builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1474737606.92 results: success (0) buildid: 20160924073016 builduid: d90ae71587cb4e958a35331710358b47 revision: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-24 10:20:06.923140) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-24 10:20:06.923544) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-24 10:20:06.923836) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-24 10:20:06.950148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 10:20:06.950418) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-24 10:20:07-- 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% 46.6M=0s 2016-09-24 10:20:07 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180140 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 10:20:07.172221) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 10:20:07.172514) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.093732 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 10:20:07.278900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 10:20:07.279255) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 --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 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 --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=9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-24 10:20:07,338 truncating revision to first 12 chars 2016-09-24 10:20:07,338 Setting DEBUG logging. 2016-09-24 10:20:07,339 attempt 1/10 2016-09-24 10:20:07,339 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/29beaebdfacc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-24 10:20:07,656 unpacking tar archive at: mozilla-central-29beaebdfacc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.665133 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 10:20:07.957940) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-24 10:20:07.958230) ========= script_repo_revision: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-24 10:20:07.958668) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-24 10:20:07.958957) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-24 10:20:07.972345) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-09-24 10:20:07.972605) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:20:08 INFO - MultiFileLogger online at 20160924 10:20:08 in /builds/slave/test 10:20:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:20:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:20:08 INFO - {'append_to_log': False, 10:20:08 INFO - 'base_work_dir': '/builds/slave/test', 10:20:08 INFO - 'blob_upload_branch': 'Firefox', 10:20:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:20:08 INFO - 'branch': 'Firefox', 10:20:08 INFO - 'buildbot_json_path': 'buildprops.json', 10:20:08 INFO - 'config_files': ('talos/linux_config.py',), 10:20:08 INFO - 'default_actions': ('clobber', 10:20:08 INFO - 'read-buildbot-config', 10:20:08 INFO - 'download-and-extract', 10:20:08 INFO - 'populate-webroot', 10:20:08 INFO - 'create-virtualenv', 10:20:08 INFO - 'install', 10:20:08 INFO - 'run-tests'), 10:20:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:20:08 INFO - 'download_minidump_stackwalk': True, 10:20:08 INFO - 'download_symbols': 'ondemand', 10:20:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:20:08 INFO - 'tooltool.py': '/tools/tooltool.py', 10:20:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:20:08 INFO - '/tools/misc-python/virtualenv.py')}, 10:20:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:20:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:20:08 INFO - 'installer_path': 'installer.exe', 10:20:08 INFO - 'log_level': 'info', 10:20:08 INFO - 'log_name': 'talos', 10:20:08 INFO - 'log_to_console': True, 10:20:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:20:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:20:08 INFO - 'opt_config_files': (), 10:20:08 INFO - 'pip_index': False, 10:20:08 INFO - 'sps_profile': False, 10:20:08 INFO - 'sps_profile_interval': 0, 10:20:08 INFO - 'suite': 'dromaeojs', 10:20:08 INFO - 'system_bits': '32', 10:20:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:20:08 INFO - 'title': 'talos-linux64-ix-022', 10:20:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:20:08 INFO - 'use_talos_json': True, 10:20:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:20:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:20:08 INFO - 'work_dir': 'build'} 10:20:08 INFO - [mozharness: 2016-09-24 17:20:08.227199Z] Running clobber step. 10:20:08 INFO - Running pre-action listener: _resource_record_pre_action 10:20:08 INFO - Running main action method: clobber 10:20:08 INFO - rmtree: /builds/slave/test/build 10:20:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:20:12 INFO - Running post-action listener: _resource_record_post_action 10:20:12 INFO - [mozharness: 2016-09-24 17:20:12.637939Z] Finished clobber step (success) 10:20:12 INFO - [mozharness: 2016-09-24 17:20:12.638069Z] Running read-buildbot-config step. 10:20:12 INFO - Running pre-action listener: _resource_record_pre_action 10:20:12 INFO - Running main action method: read_buildbot_config 10:20:12 INFO - Using buildbot properties: 10:20:12 INFO - { 10:20:12 INFO - "project": "", 10:20:12 INFO - "product": "firefox", 10:20:12 INFO - "script_repo_revision": "production", 10:20:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:20:12 INFO - "repository": "", 10:20:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:20:12 INFO - "buildid": "20160924073016", 10:20:12 INFO - "pgo_build": "True", 10:20:12 INFO - "basedir": "/builds/slave/test", 10:20:12 INFO - "buildnumber": 585, 10:20:12 INFO - "slavename": "talos-linux64-ix-022", 10:20:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:20:12 INFO - "platform": "ubuntu64_hw", 10:20:12 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:20:12 INFO - "branch": "mozilla-central", 10:20:12 INFO - "repo_path": "mozilla-central", 10:20:12 INFO - "revision": "29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49", 10:20:12 INFO - "stage_platform": "linux64-pgo", 10:20:12 INFO - "builduid": "d90ae71587cb4e958a35331710358b47", 10:20:12 INFO - "slavebuilddir": "test" 10:20:12 INFO - } 10:20:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:20:12 INFO - Running post-action listener: _resource_record_post_action 10:20:12 INFO - [mozharness: 2016-09-24 17:20:12.641360Z] Finished read-buildbot-config step (success) 10:20:12 INFO - [mozharness: 2016-09-24 17:20:12.641480Z] Running download-and-extract step. 10:20:12 INFO - Running pre-action listener: _resource_record_pre_action 10:20:12 INFO - Running main action method: download_and_extract 10:20:12 INFO - mkdir: /builds/slave/test/build/tests 10:20:12 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')]} 10:20:12 INFO - trying https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:20:12 INFO - Downloading https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/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 10:20:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/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 10:20:13 INFO - Downloaded 1361 bytes. 10:20:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:20:13 INFO - Using the following test package requirements: 10:20:13 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:20:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:20:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:20:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:13 INFO - u'jsshell-linux-x86_64.zip'], 10:20:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:20:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:20:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:20:13 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:20:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:20:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:20:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:20:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:20:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:20:13 INFO - Fetch https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:20:13 INFO - Expected file size: 21948266 10:20:18 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 10:20:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:20:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:20:18 INFO - Fetch https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:20:18 INFO - Expected file size: 21948266 10:20:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:20:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:20:24 INFO - Fetch https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:20:24 INFO - Expected file size: 14414059 10:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:25 INFO - trying https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:20:25 INFO - Downloading https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/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 10:20:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/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 10:20:26 INFO - Downloaded 59691250 bytes. 10:20:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:20:26 INFO - mkdir: /builds/slave/test/properties 10:20:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:20:26 INFO - Writing to file /builds/slave/test/properties/build_url 10:20:26 INFO - Contents: 10:20:26 INFO - build_url:https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:20:27 INFO - Running post-action listener: _resource_record_post_action 10:20:27 INFO - Running post-action listener: set_extra_try_arguments 10:20:27 INFO - [mozharness: 2016-09-24 17:20:27.119924Z] Finished download-and-extract step (success) 10:20:27 INFO - [mozharness: 2016-09-24 17:20:27.120124Z] Running populate-webroot step. 10:20:27 INFO - Running pre-action listener: _resource_record_pre_action 10:20:27 INFO - Running main action method: populate_webroot 10:20:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:20:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:20:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:20:27 INFO - '--tppagecycles', 10:20:27 INFO - '7'], 10:20:27 INFO - 'tests': ['tsvgm']}}, 10:20:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:20:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:20:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:20:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:20:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:20:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:20:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:27 INFO - 'talos_options': ['--disable-e10s'], 10:20:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:20:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:20:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:27 INFO - 'talos_options': ['--disable-e10s'], 10:20:27 INFO - 'tests': ['damp', 'tps']}, 10:20:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:27 INFO - 'tests': ['damp', 'tps']}, 10:20:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:20:27 INFO - 'tests': ['dromaeo_dom']}, 10:20:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:20:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:20:27 INFO - 'tests': ['basic_compositor_video']}, 10:20:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:20:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:20:27 INFO - 'tests': ['a11yr', 10:20:27 INFO - 'ts_paint', 10:20:27 INFO - 'tpaint', 10:20:27 INFO - 'sessionrestore', 10:20:27 INFO - 'sessionrestore_no_auto_restore', 10:20:27 INFO - 'tabpaint']}, 10:20:27 INFO - 'other-e10s': {'tests': ['a11yr', 10:20:27 INFO - 'ts_paint', 10:20:27 INFO - 'tpaint', 10:20:27 INFO - 'sessionrestore', 10:20:27 INFO - 'sessionrestore_no_auto_restore', 10:20:27 INFO - 'tabpaint']}, 10:20:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:20:27 INFO - 'ts_paint', 10:20:27 INFO - 'tpaint', 10:20:27 INFO - 'sessionrestore', 10:20:27 INFO - 'sessionrestore_no_auto_restore', 10:20:27 INFO - 'tabpaint']}, 10:20:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:20:27 INFO - 'ts_paint', 10:20:27 INFO - 'tpaint', 10:20:27 INFO - 'sessionrestore', 10:20:27 INFO - 'sessionrestore_no_auto_restore', 10:20:27 INFO - 'tabpaint']}, 10:20:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:20:27 INFO - 'tests': ['a11yr', 10:20:27 INFO - 'ts_paint', 10:20:27 INFO - 'tpaint', 10:20:27 INFO - 'sessionrestore', 10:20:27 INFO - 'sessionrestore_no_auto_restore', 10:20:27 INFO - 'tabpaint']}, 10:20:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:20:27 INFO - 'tests': ['a11yr', 10:20:27 INFO - 'ts_paint', 10:20:27 INFO - 'tpaint', 10:20:27 INFO - 'sessionrestore', 10:20:27 INFO - 'sessionrestore_no_auto_restore', 10:20:27 INFO - 'tabpaint']}, 10:20:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:20:27 INFO - 'tests': ['tsvgx', 10:20:27 INFO - 'tsvgr_opacity', 10:20:27 INFO - 'tart', 10:20:27 INFO - 'tscrollx', 10:20:27 INFO - 'cart']}, 10:20:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:20:27 INFO - 'tsvgr_opacity', 10:20:27 INFO - 'tart', 10:20:27 INFO - 'tscrollx', 10:20:27 INFO - 'cart']}, 10:20:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:27 INFO - 'talos_options': ['--disable-e10s'], 10:20:27 INFO - 'tests': ['tp5o']}, 10:20:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:27 INFO - 'tests': ['tp5o']}, 10:20:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:27 INFO - 'talos_options': ['--disable-e10s', 10:20:27 INFO - '--xperf_path', 10:20:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:20:27 INFO - 'tests': ['tp5n']}, 10:20:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:27 INFO - 'talos_options': ['--xperf_path', 10:20:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:20:27 INFO - 'tests': ['tp5n']}}, 10:20:27 INFO - 'talos.zip': {'path': '', 10:20:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:20:27 INFO - Running post-action listener: _resource_record_post_action 10:20:27 INFO - [mozharness: 2016-09-24 17:20:27.134901Z] Finished populate-webroot step (success) 10:20:27 INFO - [mozharness: 2016-09-24 17:20:27.135002Z] Running create-virtualenv step. 10:20:27 INFO - Running pre-action listener: _resource_record_pre_action 10:20:27 INFO - Running main action method: create_virtualenv 10:20:27 INFO - Creating virtualenv /builds/slave/test/build/venv 10:20:27 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 10:20:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:20:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:20:27 INFO - Using real prefix '/usr' 10:20:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:20:27 INFO - Installing distribute.............................................................................................................................................................................................done. 10:20:29 INFO - Installing pip.................done. 10:20:29 INFO - Return code: 0 10:20:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:20: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')]} 10:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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')]} 10:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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 0x7fe5a7908f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2654790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651930>, '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 0x2652830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2652cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', '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 10:20: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 10:20: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 10:20:29 INFO - Using env: {'DISPLAY': ':0', 10:20:29 INFO - 'HOME': '/home/cltbld', 10:20:29 INFO - 'LANG': 'en_US.UTF-8', 10:20:29 INFO - 'LANGUAGE': 'en_US:en', 10:20:29 INFO - 'LOGNAME': 'cltbld', 10:20:29 INFO - 'MAIL': '/var/mail/cltbld', 10:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:29 INFO - 'MOZ_NO_REMOTE': '1', 10:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:29 INFO - 'NO_EM_RESTART': '1', 10:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:29 INFO - 'PWD': '/builds/slave/test', 10:20:29 INFO - 'SHELL': '/bin/bash', 10:20:29 INFO - 'SHLVL': '1', 10:20:29 INFO - 'TERM': 'linux', 10:20:29 INFO - 'TMOUT': '86400', 10:20:29 INFO - 'USER': 'cltbld', 10:20:29 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', 10:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:29 INFO - '_': '/tools/buildbot/bin/python'} 10:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:30 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 10:20:30 INFO - Cleaning up... 10:20:30 INFO - Return code: 0 10:20:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:20:30 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')]} 10:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:30 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')]} 10:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:30 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 0x7fe5a7908f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2654790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651930>, '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 0x2652830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2652cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', '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 10:20:30 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 10:20:30 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 10:20:30 INFO - Using env: {'DISPLAY': ':0', 10:20:30 INFO - 'HOME': '/home/cltbld', 10:20:30 INFO - 'LANG': 'en_US.UTF-8', 10:20:30 INFO - 'LANGUAGE': 'en_US:en', 10:20:30 INFO - 'LOGNAME': 'cltbld', 10:20:30 INFO - 'MAIL': '/var/mail/cltbld', 10:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:30 INFO - 'MOZ_NO_REMOTE': '1', 10:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:30 INFO - 'NO_EM_RESTART': '1', 10:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:30 INFO - 'PWD': '/builds/slave/test', 10:20:30 INFO - 'SHELL': '/bin/bash', 10:20:30 INFO - 'SHLVL': '1', 10:20:30 INFO - 'TERM': 'linux', 10:20:30 INFO - 'TMOUT': '86400', 10:20:30 INFO - 'USER': 'cltbld', 10:20:30 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', 10:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:30 INFO - '_': '/tools/buildbot/bin/python'} 10:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:31 INFO - Downloading/unpacking psutil>=3.1.1 10:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:20:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:20:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:20:33 INFO - Installing collected packages: psutil 10:20:33 INFO - Running setup.py install for psutil 10:20:33 INFO - building 'psutil._psutil_linux' extension 10:20:33 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 10:20:34 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 10:20:34 INFO - building 'psutil._psutil_posix' extension 10:20:34 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 10:20:35 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 10:20:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:20:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:20:35 INFO - Successfully installed psutil 10:20:35 INFO - Cleaning up... 10:20:35 INFO - Return code: 0 10:20:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:20:35 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')]} 10:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:35 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')]} 10:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:35 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 0x7fe5a7908f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2654790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651930>, '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 0x2652830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2652cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', '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 10:20:35 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 10:20:35 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 10:20:35 INFO - Using env: {'DISPLAY': ':0', 10:20:35 INFO - 'HOME': '/home/cltbld', 10:20:35 INFO - 'LANG': 'en_US.UTF-8', 10:20:35 INFO - 'LANGUAGE': 'en_US:en', 10:20:35 INFO - 'LOGNAME': 'cltbld', 10:20:35 INFO - 'MAIL': '/var/mail/cltbld', 10:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:35 INFO - 'MOZ_NO_REMOTE': '1', 10:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:35 INFO - 'NO_EM_RESTART': '1', 10:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:35 INFO - 'PWD': '/builds/slave/test', 10:20:35 INFO - 'SHELL': '/bin/bash', 10:20:35 INFO - 'SHLVL': '1', 10:20:35 INFO - 'TERM': 'linux', 10:20:35 INFO - 'TMOUT': '86400', 10:20:35 INFO - 'USER': 'cltbld', 10:20:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', 10:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:35 INFO - '_': '/tools/buildbot/bin/python'} 10:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:20:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:20:37 INFO - Installing collected packages: mozsystemmonitor 10:20:37 INFO - Running setup.py install for mozsystemmonitor 10:20:37 INFO - Successfully installed mozsystemmonitor 10:20:37 INFO - Cleaning up... 10:20:37 INFO - Return code: 0 10:20:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:20: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')]} 10:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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')]} 10:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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', '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 0x7fe5a7908f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2654790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651930>, '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 0x2652830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2652cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', '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 10:20: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:20: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 jsonschema==2.5.1 10:20:37 INFO - Using env: {'DISPLAY': ':0', 10:20:37 INFO - 'HOME': '/home/cltbld', 10:20:37 INFO - 'LANG': 'en_US.UTF-8', 10:20:37 INFO - 'LANGUAGE': 'en_US:en', 10:20:37 INFO - 'LOGNAME': 'cltbld', 10:20:37 INFO - 'MAIL': '/var/mail/cltbld', 10:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:37 INFO - 'MOZ_NO_REMOTE': '1', 10:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:37 INFO - 'NO_EM_RESTART': '1', 10:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:37 INFO - 'PWD': '/builds/slave/test', 10:20:37 INFO - 'SHELL': '/bin/bash', 10:20:37 INFO - 'SHLVL': '1', 10:20:37 INFO - 'TERM': 'linux', 10:20:37 INFO - 'TMOUT': '86400', 10:20:37 INFO - 'USER': 'cltbld', 10:20:37 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', 10:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:37 INFO - '_': '/tools/buildbot/bin/python'} 10:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:37 INFO - Downloading/unpacking jsonschema==2.5.1 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:20:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:20:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:20:39 INFO - Downloading functools32-3.2.3-2.tar.gz 10:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:20:40 INFO - warning: no files found matching '*.txt' 10:20:40 INFO - no previously-included directories found matching 'build' 10:20:40 INFO - no previously-included directories found matching 'dist' 10:20:40 INFO - no previously-included directories found matching '.git*' 10:20:40 INFO - Installing collected packages: jsonschema, functools32 10:20:40 INFO - Running setup.py install for functools32 10:20:40 INFO - warning: no files found matching '*.txt' 10:20:40 INFO - no previously-included directories found matching 'build' 10:20:40 INFO - no previously-included directories found matching 'dist' 10:20:40 INFO - no previously-included directories found matching '.git*' 10:20:40 INFO - Successfully installed jsonschema functools32 10:20:40 INFO - Cleaning up... 10:20:40 INFO - Return code: 0 10:20:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:40 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 0x7fe5a7908f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2654790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651930>, '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 0x2652830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2652cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', '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 10:20:40 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 10:20:40 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 10:20:40 INFO - Using env: {'DISPLAY': ':0', 10:20:40 INFO - 'HOME': '/home/cltbld', 10:20:40 INFO - 'LANG': 'en_US.UTF-8', 10:20:40 INFO - 'LANGUAGE': 'en_US:en', 10:20:40 INFO - 'LOGNAME': 'cltbld', 10:20:40 INFO - 'MAIL': '/var/mail/cltbld', 10:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:40 INFO - 'MOZ_NO_REMOTE': '1', 10:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:40 INFO - 'NO_EM_RESTART': '1', 10:20:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:40 INFO - 'PWD': '/builds/slave/test', 10:20:40 INFO - 'SHELL': '/bin/bash', 10:20:40 INFO - 'SHLVL': '1', 10:20:40 INFO - 'TERM': 'linux', 10:20:40 INFO - 'TMOUT': '86400', 10:20:40 INFO - 'USER': 'cltbld', 10:20:40 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', 10:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:40 INFO - '_': '/tools/buildbot/bin/python'} 10:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:20:40 INFO - Cleaning up... 10:20:40 INFO - Return code: 0 10:20:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:40 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 0x7fe5a7908f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2654790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651930>, '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 0x2652830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2652cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', '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 10:20:40 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 10:20:40 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 10:20:40 INFO - Using env: {'DISPLAY': ':0', 10:20:40 INFO - 'HOME': '/home/cltbld', 10:20:40 INFO - 'LANG': 'en_US.UTF-8', 10:20:40 INFO - 'LANGUAGE': 'en_US:en', 10:20:40 INFO - 'LOGNAME': 'cltbld', 10:20:40 INFO - 'MAIL': '/var/mail/cltbld', 10:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:40 INFO - 'MOZ_NO_REMOTE': '1', 10:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:40 INFO - 'NO_EM_RESTART': '1', 10:20:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:40 INFO - 'PWD': '/builds/slave/test', 10:20:40 INFO - 'SHELL': '/bin/bash', 10:20:40 INFO - 'SHLVL': '1', 10:20:40 INFO - 'TERM': 'linux', 10:20:40 INFO - 'TMOUT': '86400', 10:20:40 INFO - 'USER': 'cltbld', 10:20:40 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', 10:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:40 INFO - '_': '/tools/buildbot/bin/python'} 10:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:40 INFO - Downloading/unpacking blobuploader==1.2.4 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:20:42 INFO - Downloading blobuploader-1.2.4.tar.gz 10:20:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:20:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:20:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:20:43 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 10:20:43 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 10:20:43 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 10:20:43 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 10:20:43 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 10:20:43 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 10:20:43 INFO - Downloading docopt-0.6.1.tar.gz 10:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:20:43 INFO - Installing collected packages: blobuploader, requests, docopt 10:20:43 INFO - Running setup.py install for blobuploader 10:20:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:20:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:20:43 INFO - Running setup.py install for requests 10:20:43 INFO - Running setup.py install for docopt 10:20:43 INFO - Successfully installed blobuploader requests docopt 10:20:43 INFO - Cleaning up... 10:20:43 INFO - Return code: 0 10:20:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:43 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 0x7fe5a7908f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2654790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651930>, '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 0x2652830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2652cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', '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 10:20:43 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 10:20:43 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 10:20:43 INFO - Using env: {'DISPLAY': ':0', 10:20:43 INFO - 'HOME': '/home/cltbld', 10:20:43 INFO - 'LANG': 'en_US.UTF-8', 10:20:43 INFO - 'LANGUAGE': 'en_US:en', 10:20:43 INFO - 'LOGNAME': 'cltbld', 10:20:43 INFO - 'MAIL': '/var/mail/cltbld', 10:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:43 INFO - 'MOZ_NO_REMOTE': '1', 10:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:43 INFO - 'NO_EM_RESTART': '1', 10:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:43 INFO - 'PWD': '/builds/slave/test', 10:20:43 INFO - 'SHELL': '/bin/bash', 10:20:43 INFO - 'SHLVL': '1', 10:20:43 INFO - 'TERM': 'linux', 10:20:43 INFO - 'TMOUT': '86400', 10:20:43 INFO - 'USER': 'cltbld', 10:20:43 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', 10:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:43 INFO - '_': '/tools/buildbot/bin/python'} 10:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:20:44 INFO - Running setup.py (path:/tmp/pip-IS9Sjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:20:44 INFO - Running setup.py (path:/tmp/pip-rc3DRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:20:44 INFO - Running setup.py (path:/tmp/pip-Z0KUAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:20:44 INFO - Running setup.py (path:/tmp/pip-HKOVZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:20:44 INFO - Running setup.py (path:/tmp/pip-E3HHoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:20:44 INFO - Running setup.py (path:/tmp/pip-M0V0Em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:20:44 INFO - Running setup.py (path:/tmp/pip-0kxAZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:20:44 INFO - Running setup.py (path:/tmp/pip-J0VBoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:20:44 INFO - Running setup.py (path:/tmp/pip-gFCQUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:20:44 INFO - Running setup.py (path:/tmp/pip-D9pGet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:20:44 INFO - Running setup.py (path:/tmp/pip-Yey88p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:20:44 INFO - Running setup.py (path:/tmp/pip-JV37TY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:20:45 INFO - Running setup.py (path:/tmp/pip-tjrLSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:20:45 INFO - Running setup.py (path:/tmp/pip-mo3h6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:45 INFO - Running setup.py (path:/tmp/pip-3eAYaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:20:45 INFO - Running setup.py (path:/tmp/pip-xZ0xSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:20:45 INFO - Running setup.py (path:/tmp/pip-oBI7yJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:20:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:20:45 INFO - Running setup.py install for manifestparser 10:20:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:20:45 INFO - Running setup.py install for mozcrash 10:20:45 INFO - Running setup.py install for mozdebug 10:20:45 INFO - Running setup.py install for mozdevice 10:20:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:20:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:20:45 INFO - Running setup.py install for mozfile 10:20:45 INFO - Running setup.py install for mozhttpd 10:20:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:20:45 INFO - Running setup.py install for mozinfo 10:20:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:20:46 INFO - Running setup.py install for mozInstall 10:20:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:20:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:20:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:20:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:20:46 INFO - Running setup.py install for mozleak 10:20:46 INFO - Running setup.py install for mozlog 10:20:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:20:46 INFO - Running setup.py install for moznetwork 10:20:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:20:46 INFO - Running setup.py install for mozprocess 10:20:46 INFO - Running setup.py install for mozprofile 10:20:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:20:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:20:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:20:46 INFO - Running setup.py install for mozrunner 10:20:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:20:46 INFO - Running setup.py install for mozscreenshot 10:20:46 INFO - Running setup.py install for moztest 10:20:47 INFO - Running setup.py install for mozversion 10:20:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:20:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:20:47 INFO - Cleaning up... 10:20:47 INFO - Return code: 0 10:20:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:47 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 0x7fe5a7908f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2654790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651930>, '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 0x2652830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2652cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', '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 10:20:47 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 10:20:47 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 10:20:47 INFO - Using env: {'DISPLAY': ':0', 10:20:47 INFO - 'HOME': '/home/cltbld', 10:20:47 INFO - 'LANG': 'en_US.UTF-8', 10:20:47 INFO - 'LANGUAGE': 'en_US:en', 10:20:47 INFO - 'LOGNAME': 'cltbld', 10:20:47 INFO - 'MAIL': '/var/mail/cltbld', 10:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:47 INFO - 'MOZ_NO_REMOTE': '1', 10:20:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:47 INFO - 'NO_EM_RESTART': '1', 10:20:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:47 INFO - 'PWD': '/builds/slave/test', 10:20:47 INFO - 'SHELL': '/bin/bash', 10:20:47 INFO - 'SHLVL': '1', 10:20:47 INFO - 'TERM': 'linux', 10:20:47 INFO - 'TMOUT': '86400', 10:20:47 INFO - 'USER': 'cltbld', 10:20:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', 10:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:47 INFO - '_': '/tools/buildbot/bin/python'} 10:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:20:47 INFO - Running setup.py (path:/tmp/pip-3I7RCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:20:47 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)) 10:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:20:47 INFO - Running setup.py (path:/tmp/pip-1XmKMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:20:47 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)) 10:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:20:47 INFO - Running setup.py (path:/tmp/pip-BbcxOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:20:47 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)) 10:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:20:47 INFO - Running setup.py (path:/tmp/pip-MsWnzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:20:47 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)) 10:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:20:47 INFO - Running setup.py (path:/tmp/pip-CkSNuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:20:47 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)) 10:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:20:47 INFO - Running setup.py (path:/tmp/pip-VX6sEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:20:47 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)) 10:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:20:47 INFO - Running setup.py (path:/tmp/pip-iDO276-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:20:47 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)) 10:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:20:47 INFO - Running setup.py (path:/tmp/pip-6G0flA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:20:47 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)) 10:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:20:47 INFO - Running setup.py (path:/tmp/pip-oA3p8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:20:48 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)) 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:20:48 INFO - Running setup.py (path:/tmp/pip-hHVO8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:20:48 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)) 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:20:48 INFO - Running setup.py (path:/tmp/pip-oFiDg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:20:48 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)) 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:20:48 INFO - Running setup.py (path:/tmp/pip-qL4qs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:20:48 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)) 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:20:48 INFO - Running setup.py (path:/tmp/pip-wdZKNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:20:48 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)) 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:20:48 INFO - Running setup.py (path:/tmp/pip-SgYQ33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:20:48 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)) 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:48 INFO - Running setup.py (path:/tmp/pip-KzA8tG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:48 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)) 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:20:48 INFO - Running setup.py (path:/tmp/pip-knQkRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:20:48 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)) 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:20:48 INFO - Running setup.py (path:/tmp/pip-Byl2cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:20:48 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)) 10:20:48 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)) 10:20:48 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)) 10:20:48 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)) 10:20:48 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)) 10:20:48 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)) 10:20:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:20:48 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 10:20:48 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 10:20:48 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 10:20:48 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 10:20:48 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 10:20:48 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 10:20:50 INFO - Downloading blessings-1.6.tar.gz 10:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:20:50 INFO - Installing collected packages: blessings 10:20:50 INFO - Running setup.py install for blessings 10:20:50 INFO - Successfully installed blessings 10:20:50 INFO - Cleaning up... 10:20:50 INFO - Return code: 0 10:20:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:20:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:20:50 INFO - Reading from file tmpfile_stdout 10:20:50 INFO - Current package versions: 10:20:50 INFO - argparse == 1.2.1 10:20:50 INFO - blessings == 1.6 10:20:50 INFO - blobuploader == 1.2.4 10:20:50 INFO - docopt == 0.6.1 10:20:50 INFO - functools32 == 3.2.3-2 10:20:50 INFO - jsonschema == 2.5.1 10:20:50 INFO - manifestparser == 1.1 10:20:50 INFO - mozInstall == 1.12 10:20:50 INFO - mozcrash == 0.17 10:20:50 INFO - mozdebug == 0.1 10:20:50 INFO - mozdevice == 0.48 10:20:50 INFO - mozfile == 1.2 10:20:50 INFO - mozhttpd == 0.7 10:20:50 INFO - mozinfo == 0.9 10:20:50 INFO - mozleak == 0.1 10:20:50 INFO - mozlog == 3.4 10:20:50 INFO - moznetwork == 0.27 10:20:50 INFO - mozprocess == 0.23 10:20:50 INFO - mozprofile == 0.28 10:20:50 INFO - mozrunner == 6.12 10:20:50 INFO - mozscreenshot == 0.1 10:20:50 INFO - mozsystemmonitor == 0.3 10:20:50 INFO - moztest == 0.7 10:20:50 INFO - mozversion == 1.4 10:20:50 INFO - psutil == 3.1.1 10:20:50 INFO - requests == 1.2.3 10:20:50 INFO - wsgiref == 0.1.2 10:20:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:50 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 0x7fe5a7908f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2654790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651930>, '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 0x2652830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2652cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', '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 10:20:50 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 10:20:50 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 10:20:50 INFO - Using env: {'DISPLAY': ':0', 10:20:50 INFO - 'HOME': '/home/cltbld', 10:20:50 INFO - 'LANG': 'en_US.UTF-8', 10:20:50 INFO - 'LANGUAGE': 'en_US:en', 10:20:50 INFO - 'LOGNAME': 'cltbld', 10:20:50 INFO - 'MAIL': '/var/mail/cltbld', 10:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:50 INFO - 'MOZ_NO_REMOTE': '1', 10:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:50 INFO - 'NO_EM_RESTART': '1', 10:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:50 INFO - 'PWD': '/builds/slave/test', 10:20:50 INFO - 'SHELL': '/bin/bash', 10:20:50 INFO - 'SHLVL': '1', 10:20:50 INFO - 'TERM': 'linux', 10:20:50 INFO - 'TMOUT': '86400', 10:20:50 INFO - 'USER': 'cltbld', 10:20:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', 10:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:50 INFO - '_': '/tools/buildbot/bin/python'} 10:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:51 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)) 10:20:51 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)) 10:20:51 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)) 10:20:51 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)) 10:20:51 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)) 10:20:51 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)) 10:20:51 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)) 10:20:51 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)) 10:20:51 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)) 10:20:51 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)) 10:20:51 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)) 10:20:51 INFO - Cleaning up... 10:20:51 INFO - Return code: 0 10:20:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:20:51 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')]} 10:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:51 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')]} 10:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:51 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 0x7fe5a7908f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2654790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2651930>, '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 0x2652830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2652cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', '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 10:20:51 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 10:20:51 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 10:20:51 INFO - Using env: {'DISPLAY': ':0', 10:20:51 INFO - 'HOME': '/home/cltbld', 10:20:51 INFO - 'LANG': 'en_US.UTF-8', 10:20:51 INFO - 'LANGUAGE': 'en_US:en', 10:20:51 INFO - 'LOGNAME': 'cltbld', 10:20:51 INFO - 'MAIL': '/var/mail/cltbld', 10:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:51 INFO - 'MOZ_NO_REMOTE': '1', 10:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:51 INFO - 'NO_EM_RESTART': '1', 10:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:51 INFO - 'PWD': '/builds/slave/test', 10:20:51 INFO - 'SHELL': '/bin/bash', 10:20:51 INFO - 'SHLVL': '1', 10:20:51 INFO - 'TERM': 'linux', 10:20:51 INFO - 'TMOUT': '86400', 10:20:51 INFO - 'USER': 'cltbld', 10:20:51 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', 10:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:51 INFO - '_': '/tools/buildbot/bin/python'} 10:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:20:51 INFO - Cleaning up... 10:20:51 INFO - Return code: 0 10:20:51 INFO - Running post-action listener: _resource_record_post_action 10:20:51 INFO - Running post-action listener: _start_resource_monitoring 10:20:51 INFO - Starting resource monitoring. 10:20:51 INFO - [mozharness: 2016-09-24 17:20:51.467499Z] Finished create-virtualenv step (success) 10:20:51 INFO - [mozharness: 2016-09-24 17:20:51.468501Z] Running install step. 10:20:51 INFO - Running pre-action listener: _resource_record_pre_action 10:20:51 INFO - Running main action method: install 10:20:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:20:51 INFO - Reading from file tmpfile_stdout 10:20:51 INFO - Detecting whether we're running mozinstall >=1.0... 10:20:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:20:51 INFO - Reading from file tmpfile_stdout 10:20:51 INFO - Output received: 10:20:51 INFO - Usage: mozinstall [options] installer 10:20:51 INFO - Options: 10:20:51 INFO - -h, --help show this help message and exit 10:20:51 INFO - -d DEST, --destination=DEST 10:20:51 INFO - Directory to install application into. [default: 10:20:51 INFO - "/builds/slave/test"] 10:20:51 INFO - --app=APP Application being installed. [default: firefox] 10:20:51 INFO - mkdir: /builds/slave/test/build/application 10:20:51 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'] 10:20:51 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 10:21:08 INFO - Reading from file tmpfile_stdout 10:21:08 INFO - Output received: 10:21:08 INFO - /builds/slave/test/build/application/firefox/firefox 10:21:08 INFO - Running post-action listener: _resource_record_post_action 10:21:08 INFO - [mozharness: 2016-09-24 17:21:08.755986Z] Finished install step (success) 10:21:08 INFO - [mozharness: 2016-09-24 17:21:08.756236Z] Running run-tests step. 10:21:08 INFO - Running pre-action listener: _resource_record_pre_action 10:21:08 INFO - Running main action method: run_tests 10:21:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:21:08 INFO - Python 2.7.3 10:21:08 INFO - Return code: 0 10:21:08 INFO - grabbing minidump binary from tooltool 10:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:08 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 0x2651930>, '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 0x2652830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2652cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:21:08 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 10:21:08 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 10:21:08 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 10:21:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:21:08 INFO - Return code: 0 10:21:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:21:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:21:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:21:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:21:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:21:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 10:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 10:21:08 INFO - Using env: {'DISPLAY': ':0', 10:21:08 INFO - 'HOME': '/home/cltbld', 10:21:08 INFO - 'LANG': 'en_US.UTF-8', 10:21:08 INFO - 'LANGUAGE': 'en_US:en', 10:21:08 INFO - 'LOGNAME': 'cltbld', 10:21:08 INFO - 'MAIL': '/var/mail/cltbld', 10:21:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:21:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:08 INFO - 'MOZ_NO_REMOTE': '1', 10:21:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:08 INFO - 'NO_EM_RESTART': '1', 10:21:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:08 INFO - 'PWD': '/builds/slave/test', 10:21:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:21:08 INFO - 'SHELL': '/bin/bash', 10:21:08 INFO - 'SHLVL': '1', 10:21:08 INFO - 'TERM': 'linux', 10:21:08 INFO - 'TMOUT': '86400', 10:21:08 INFO - 'USER': 'cltbld', 10:21:08 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430', 10:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:08 INFO - '_': '/tools/buildbot/bin/python'} 10:21:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 10:21:09 INFO - mozversion application_buildid: 20160924073016 10:21:09 INFO - mozversion application_changeset: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 10:21:09 INFO - mozversion application_display_name: Nightly 10:21:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:21:09 INFO - mozversion application_name: Firefox 10:21:09 INFO - mozversion application_remotingname: firefox 10:21:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:21:09 INFO - mozversion application_vendor: Mozilla 10:21:09 INFO - mozversion application_version: 52.0a1 10:21:09 INFO - mozversion platform_buildid: 20160924073016 10:21:09 INFO - mozversion platform_changeset: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 10:21:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:21:09 INFO - mozversion platform_version: 52.0a1 10:21:09 INFO - using testdate: 1474737669 10:21:09 INFO - actual date: 1474737669 10:21:09 INFO - starting webserver on 'localhost:51373' 10:21:09 INFO - SUITE-START | Running 2 tests 10:21:09 INFO - TEST-START | dromaeo_css 10:21:09 INFO - operating with platform_type : linux_ 10:21:09 INFO - Initialising browser for dromaeo_css test... 10:21:09 INFO - TEST-INFO | started process 3318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7dKB2j/profile http://localhost:51373/getInfo.html) 10:21:17 INFO - PROCESS | 3318 | __metrics Screen width/height:1600/1200 10:21:17 INFO - PROCESS | 3318 | colorDepth:24 10:21:17 INFO - PROCESS | 3318 | Browser inner width/height: 1024/697 10:21:17 INFO - PROCESS | 3318 | __metrics 10:21:18 INFO - PROCESS | 3318 | 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" 10:21:18 INFO - PROCESS | 3318 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:21:19 INFO - PROCESS | 3318 | console.error: PushService: 10:21:19 INFO - PROCESS | 3318 | stateChangeProcessEnqueue: Error transitioning state 10:21:19 INFO - PROCESS | 3318 | UnknownError 10:21:19 INFO - TEST-INFO | 3318: exit 0 10:21:19 INFO - Browser initialized. 10:21:19 INFO - Running cycle 1/1 for dromaeo_css test... 10:21:19 INFO - TEST-INFO | started process 3401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7dKB2j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:31 INFO - PROCESS | 3401 | RSS: Main: 173891584 10:21:31 INFO - PROCESS | 3401 | 10:22:23 INFO - PROCESS | 3401 | 1474737743366 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] 10:24:33 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:51373/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51373/tests/dromaeo/cssquery-ext.html) 10:24:34 INFO - PROCESS | 3401 | RSS: Main: 319492096 10:24:34 INFO - PROCESS | 3401 | 10:27:36 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:51373/tests/dromaeo/cssquery-ext.html (next: http://localhost:51373/tests/dromaeo/cssquery-jquery.html) 10:27:37 INFO - PROCESS | 3401 | RSS: Main: 273809408 10:27:37 INFO - PROCESS | 3401 | 10:30:39 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:51373/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51373/tests/dromaeo/cssquery-mootools.html) 10:30:40 INFO - PROCESS | 3401 | RSS: Main: 269570048 10:30:40 INFO - PROCESS | 3401 | 10:33:42 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:51373/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51373/tests/dromaeo/cssquery-prototype.html) 10:33:42 INFO - PROCESS | 3401 | RSS: Main: 257871872 10:33:42 INFO - PROCESS | 3401 | 10:36:45 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:51373/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51373/tests/dromaeo/cssquery-yui.html) 10:36:46 INFO - PROCESS | 3401 | RSS: Main: 217620480 10:36:46 INFO - PROCESS | 3401 | 10:39:48 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:51373/tests/dromaeo/cssquery-yui.html (next: http://localhost:51373/tests/dromaeo/cssquery-dojo.html) 10:39:48 INFO - PROCESS | 3401 | RSS: Main: 309383168 10:39:48 INFO - PROCESS | 3401 | 10:39:48 INFO - PROCESS | 3401 | __start_tp_report 10:39:48 INFO - PROCESS | 3401 | _x_x_mozilla_page_load 10:39:48 INFO - PROCESS | 3401 | _x_x_mozilla_page_load_details 10:39:48 INFO - PROCESS | 3401 | |i|pagename|runs| 10:39:48 INFO - PROCESS | 3401 | |0;dojo.html;3030.30303030303;3058.220153860765;3065.6167979002626;3094.9535756963664;3111.6266048074235;5173.793048278074;5205.063088644042;5248.86877828054;5332.413434522205;5371.543418809396;5252.868678283045;5263.236830659552;5334.946650533493;5362.946370536293;5401.945980540193;4809.615230781529;4819.590334821544;4824;4833.589144922686;4955.578775804061;4930.876728081808;4958.752062396866;4986.626003049768;5001.674891132083;5026.346574945252;4734.6685731998605;4767.213409787381;4796.544328288807;4865.6594038417325;4906.484819093997;4864.537868902448;4867.780949857265;4930.482299358588;4930.5069493050405;4938.407391113054;4802.783874725646;4831.516848315176;4849.563539281482;4850.5877000455;4903.975480122576;5130.9743451282875;5168.22476628505;5314.495122963351;5328.813491527778;5383.084875571162;5528.668279903179;5583.3858275589655;5643.40744221859;5651.265335506399;5654.236678048452;5583.302087239095;5593.3847276799515;5599.272094627672;5600.719964001824;5601.411851755548;5137.486251374908;5193.506616871391;5216.895662086737;5224.817131400383;5274.894502109974;5606.018946684314;5683.630564013326;5743.339515955635;5746.798862039808;5835.124731290255;5474.151506516417;5514.420985796514;5517.2551705520045;5521.00621888064;5521.171824226318;5544.611877168641;5579;5609.158626206102;5616.0373145436915;5617.129344951539;5424.945750542523;5495.395506494282;5601.551875849922;5651.124075768263;5666.235058267163;5684.118961560965;5701.4013528579735;5749.913751293734;5779.2775903012125;5781.364049954502;4426.092651006536;4427.845025424094;4435.467743870756;4438.223310920576;4483.977580112079;3855.132595166121;3862.0537968197973;3884.2425726982965;3916.921661566753;3941.7437866538585;5394.9460505394445;5402.783888644411;5403.675779453245;5408.621396502207;5409.702466364388;5575.163725441216;5607.467290607386;5621.915671264935;5633.183188437653;5638.774449021993;5259.184826351921;5268.762905669254;5273.604479664041;5278.498542638443;5282.656627319212;4744.098621262018;4809.254565542276;4819.277108433763;4874.610031197496;4881.755912204376;5770.451807078321;5787.2476578045425;5787.536997040227;5791.594588378773;5847.736851841677;5647.3505546861;5652.152177173457;5664.405237450173;5666.490015898589;5671.858203544944;5691.117876729114;5729.1119876419225;5746;5782.45066718661;5789.9710501447225;5537.5569954402745;5576.414476480073;5592.328920529562;5640.887182256414;5649.180868773922;5632.408597097409;5655.4910058094965;5659.6321239119325;5664.0937450007805;5665.49010589049;5396.568274537949;5463.863403414946;5483.698396588226;5551.861203469945;5561.332640083054;5503.669779813224;5519.972400137974;5526.557875370041;5560.054790685674;5592.888142237214;5415.810446634349;5440.53755430777;5442.319710036246;5448.4006759257245;5452.972735136457;5393.649412788313;5441.755121019484;5539.473749993744;5553.50018498321;5621.5221706155435;5384.326959130109;5406.51341379262;5428.212909128233;5445.346558413015;5504.366997795305 10:39:48 INFO - PROCESS | 3401 | |1;ext.html;551.2673745031468;587.9706014699265;610.2189197826781;617.0743884173738;624.494159730618;42553.78723106384;43966.780166099124;44054.33918491221;44066.779666101706;48288.75855620717;44515.10969780602;44893.32660010103;44964.550354496445;45015.54984450155;45063;8981.101889811032;9142.63429462824;9156.725298241063;9159.725208243763;9160.725178244664;8947.776305592348;9013.098690131;9042;9044.186023257906;9045.321600879928;9089.954550227272;9106.817863642724;9118.77203069922;9120.270378369747;9130.589123489459;9003.459792412443;9015.549222538846;9029.548522573845;9045.3668243223;9045.592948317342;9011.459312441275;9093.499857507835;9096.226820720247;9104.31717621181;9104.817903641957;41880;42150.78924605388;42154.1569168618;42160.36759448611;42214;3485.5643044619424;3575.535180426528;3852.460655508231;4045.5347635022054;4072.694547908889;31687.524687129713;31729.682703173134;31916.680833191604;31941.20146996344;32224.355512889844;4260.382244574519;4281.229378711831;4331.635534806526;4349.826006959718;4378.474583050054;337690;338385;338931;339011;339037;35326.47010294848;59199.70400147972;59578;59623.403765962656;59680.55590271685;35904.461433078526;37672.62327376746;37714.811425942695;37735.24529509395;37788.62211377906;14383.712325753426;14607;14611.853881461262;14623.341949612293;14624.634384140481;12912.289824059766;13184.73630527384;13187.67030824237;13192.670183245304;13224.272665003517;8731.563421828883;8742.91257087421;8750.387472876964;8784.78038049054;8823.338249631302;3292.5719656444508;3305.8512366943546;3352.798832070084;3353.3293341331832;3363.1423986883187;934.4626839567276;972.547765289144;974.7124598243536;1001.4341896828269;1029.3978022856713;31308;31375.686243137276;31807.363852722818;31841.363172736415;32084.67915320817;1009.5103874620803;1061.3366645846345;1077.1813421799332;1094.2887123369715;1155.381870699172;15742;16527.752083718755;16621;16888.240029198714;17243.137843108045;498805;502871;502944;503769;504796;57242;57250;57335.42664573301;57978.710106449194;57984;1083.8320060390652;1209.1958847366402;1212.1030437476204;1281.2952875918209;1319.736052789446;29316.70683293225;32189.195270118435;32301.192470188435;34296.14259643529;34606.13484662904;54327.72836135794;54978.45021549733;55044.17433738417;55049.1742623853;55053.174202386195;438500;442787;442883;443240;443436;24764.628530571696;25290.71220741292;27465.86267068732;27962.44075118527;28448.43103137884;42742.358864616435;43905.12189756123;44057.11885762331;44076.55923440853;44115.55884441114;36536.26927461383;37292.440613391365;37372.626273738;37407.06482337855;37582;36945;37892.43161352527;38282.0429489265;38313.808430957666;38379.424308634836;29430.852845735633;29717.405651887275;30293.69706302997;31025.68974310228;38091.23817523578;29855;35100;35133.297334052666;36242.8187859059;36513.63486365102;27016.72983270142;27317;27676.584851226846;27876.17695859927;27918.3020424491 10:39:48 INFO - PROCESS | 3401 | |2;jquery.html;350.58455729959985;376.3770959062752;380.24319721154984;382.74356181358496;401.5462527344101;14460.638484037905;18343.44969650909;19260.133294001786;20390;20528.589428211464;15821.525354239391;18063;18116.456506304832;18334.266629334845;18415.171317290722;5400.702961337125;5641.887162256752;5655.208270842065;5668.518175955049;5669.09294512878;4106.7125301228925;4303.913921721563;4342.435483387155;5481.287432633752;5587.8882422351735;4408.42690450241;6309.905351419732;6313.9052914206095;6318;6348.619082855043;6086.969565152191;6244.937550624527;6282.057691346335;6309.179806625132;6314.7789827356055;5402;5446.863828404322;5455.645383050129;5457.672539647634;5458.699771512565;22487;23493.060277588876;23498.765012349828;23499.29502114939;23656.645150322758;2168.5012447137087;2322.094383190557;2348.0373047050625;2387.2599494156866;2408.6627872097747;13611.931940340235;14091.577252682437;14401.855981440156;15097.245137743179;15113.54659360221;1699.3967141664655;1860.5813691919345;1875.1468082022648;1888.1408958923657;1930.5077205312696;82140.58929705372;83156;83393;83559.58220208921;84604.57697711472;10300.433476158883;10330.793384132425;10342.844857327145;10474.214433917487;10530.262881598368;13419.463221471227;13434.798478022838;13441.596752097452;13449.125806822525;13459.528916487876;7898.881516777253;8060.717874874351;8088.231617996281;8208.056073551617;8247.134050924686;7893.289603935674;8109.918900810916;8164.224398682116;8183.140770219041;8643.481391116553;6375.330590288046;6382.6170429774365;6392.137061496732;6433.844662038269;6494.64279464634;1797.478731167973;1797.4877160009596;1803.5671438854843;1809.5928416106533;1839.6044850357237;927.5408672706918;963.3738070254391;983.8783786483415;1032.9431881246453;1042.5100202904623;18605.348812791486;19565.51086222856;19863.5102367323;19957;20010.799892001185;965.3918031640022;1001.5843424978698;1029.2280789407944;1046.7749433871602;1061.946902654864;10199.98000199974;11152.944235278772;11233.438328083726;11371.601993930339;11376.943115284535;509821;512534;523823;526716;530507;94418;99337;100995;102372;103712.48143759384;1026.6201505442884;1027.6403258859339;1063.8776540697918;1072.8337107748312;1073.4954571351452;16470.83529164693;16633.584160396087;16956.626072349634;17463.214155362784;18026.098695065455;42085.78957105195;42812;42867;43157.78421108;43227.8386080701;60706.39293607007;61446.69276653767;61522.384776151666;61830.690846545476;62138.37861621326;8126.309263712651;8261.710840120568;8317.584120794058;8481.067082620782;8550;12647.747045059232;12849.357532123544;12864.807027894401;13044.739105217654;13065.150765200611;11145.49845256949;11221.326720396803;11470.226768157072;11474.598389056342;11617;11204.887951120385;11293.887061129284;11456.885431145582;11598.652040438801;11823.11326650522;11484.253523521278;11729.413529323328;11749.647510574696;11813.70465738329;11940.2835829847;7277.490575659653;7784.41616878725;7947.728363461818;8370.748877533684;8772.736817895473;9110.635574576943;11164.385958772345;11361.36856684723;12132.454039568063;12341.814872776737 10:39:48 INFO - PROCESS | 3401 | |3;mootools.html;1251.8560365557964;1334.8464926533447;1412.73158099961;1445.465177884183;1741.0424266653338;7584.9241507584975;8359.414840961128;8522.232999030086;8692.782680432992;8881.73354799357;8724.563771811416;8762.21140097391;8781.56092195391;8788.560571971391;8792.69225577105;2330.9394225627343;2389.378761522008;2391.35433432973;2393.377721792338;2394.0663141374876;2285.5543169082034;2354.9175778847743;2359.7640235976437;2360.693109895711;2379.0721618568687;2338.205010296499;2344.179537161997;2355.34050465869;2372.478054827935;2375.5367703297866;2308.4805918668335;2313.1672597864754;2332.825038122139;2333.428310064028;2335.0426325206754;2277.248507992375;2280.1791355112146;2287.5996700577334;2295.185209250725;2295.5064661097776;8533.104024077444;8592.398532102756;8636.524991125485;8679.088695686989;8683;5143.7685304161405;5382.67703937765;5383.892322153535;5446.945530544684;5448.155535891903;3349.2296771742635;3508.5438892944007;3511.3679537683206;3560;3588.9641103588892;1017.2574020964737;1033.8862725100232;1036.9896301036968;1042.1142029275131;1062.4156713807374;10902.5093870776;10975.28660637056;11035.39305338206;11038.668839934815;11044.116470682326;4280.957190428118;4318.784060796947;4446.866594002185;4475.7985890634345;4517.5482451755215;8808.647654093764;8831.735047948572;8833.425827321204;8837.072107428627;8838.55807209637;5075.923861142012;5090.185570308733;5107.770150343244;5120.308758317654;5123.436421993578;4240.575942405735;4376.584224498668;4744.691595046311;4774.665773395898;4879.512048795092;3704.407294832814;3752.080740218664;3854.9807250964127;3870.670992965573;3887.436321733333;1107.617871834216;1126.318577260762;1134.359087115777;1138.1293310617384;1142.2575326037975;793.9603019848985;913.59345091435;931.3247895275871;934.5327336331834;959.1799011844912;5613.270274864241;5617.168371021169;5793.536517078624;5814.418558144152;5876.44173803488;428.2997299415478;432.3514727908138;433.55127443096245;439.0910814613719;467.6562726396096;3544.9645503544634;3572.339117263263;3617.8552857885916;3627.2020155565733;3662.487251784752;10516.68449946503;10747.516361763739;10891.0742586881;10899.618513351994;10926.159198608419;10243.180545556337;10731;10778.245522813328;10796.51415686296;10802.243842931077;8026.357891368676;8204.630791614272;8214.178582141858;8229.094799572042;8230.670773169126;5627.155926611041;5629.4652008059165;5681.829545113653;5687.5734319927;5773.24947756789;9040.773980650536;9221.123993220634;9260.907390926273;9264.11990860867;9305.348625596143;9135.771605709644;9256.629734810533;9365.578548965177;9379.155875971195;9408.153266206074;7799.298063174341;7806.375489960676;7834.882476762739;7886.171951944963;7894.763157105296;8373.204545568162;8422.199891010345;8437.831243374976;8440.620172092393;8491.617877195664;7482;7545.622718863925;7563.281488258606;7646.694132234648;7798.883016754867;7286.793810723265;7419.29516695913;7451.40388768908;7465;7640.044994375703;6831.45348372139;6868.347506986828;6938.23679395256;6950.443964482931;6966;4994.875128121826;5037.70030629938;5075.87310317245;5133.743312834418;5252.65857719247;5041.621878359211;5046.1926091825135;5078.593712503065;5105.412877519133;5253.290805741176 10:39:48 INFO - PROCESS | 3401 | |4;prototype.html;321.95814544109277;332.8168361474956;334.58511445807204;340.9318136372726;341.3855060890397;5175.482451754822;5298.576113910887;5299.735013249341;5364.490373414525;5368.060589396855;5143.81996630118;5208.791648334071;5229.712365819878;5249.448807875176;5270.367555893288;4129.834806607747;4142.502899652046;4185;4195.265828480019;4199.391088292188;3955.4857868477056;4131.400946862703;4163.104932439525;4194.2450358935375;4202.348635961431;4130.834766609332;4138.5654506276705;4146.4402305688645;4150.3359462486005;4156.210320039198;4145.647619952323;4149.958500414988;4159.7920103994675;4169.332906734908;4191.287481128215;3675.889723308305;3685.3182161300247;3687.1519550503267;3688.0595448160816;3698.7041036716996;5050.97014075582;5150.819721309736;5153.407358153823;5180.792768289264;5223.425423203445;4670.182718024366;4704.45898721648;4704.835330763407;4708.529147085298;4716.858494245178;5490.286262785852;5492.47821456961;5504;5512.173174023888;5577.406505974701;3759.6240375962457;3937.2912875682364;3943.191645712622;3952.288588054149;3953.6639385652256;5675.886482270373;5699.601027928046;5703.144528320744;5703.857403564903;5711.257536520267;4061.593840615915;4071.796410179479;4100.282450571138;4106.425100485934;4110.650594699424;4031.677465802729;4146.854860079883;4191.476065491814;4221.176870510221;4225.070484493406;4722.126406614787;4725.298892398734;4726.456457507362;4752.928706069411;4773.546513081252;5470.863228419322;5543.223948647193;5552.555795536347;5618.775248989995;5652.9152062719095;1341.2489006156584;1369.3564024908278;1435.806166167554;1465.9780103298458;1467.7358075546504;940.9931373430363;951.4909523404945;963.0513943765385;965.5510187762584;971.062924278075;4690.601298889633;4693.413323334583;4715.622750179978;4732.627538014006;4733.739644319527;4937.888974980672;4937.975310123426;4950.925736113961;4958.479359667183;4989.226669866104;4568.451785785727;4717.764111794397;4719;4735.384400027974;4742.66801323904;2636.8022398320204;2640.920772376832;2642.4186678930605;2655.8406495610325;2656.667916510436;5029.189491782955;5040;5103.77033033507;5145.761593706675;5200.531952124327;4713.316569097462;5034.421041580192;5064.848054558295;5090.9236361454605;5126.667366348377;5075.720835354091;5078.873028174326;5087.796488140507;5102.158143906214;5102.285440306806;4918.581920536794;4941.492844682262;4982.252662100569;4989.101961646938;5012.573931215742;4740.440162312313;4901.750053736275;4968.776405061709;5198.608640025631;5619.915701264403;5789.568381279788;5807.303123625023;5812.505936995402;5815.214945982408;5824.563157763269;4033.475648165837;4091.1408604193452;4095.0581366285323;4106.979465102655;4110.979445102756;5382.381026182039;5449.3188351456065;5658.745356458887;5755.280589926259;5802.448767367094;5341.783159988561;5386.811461598825;5488.945110548843;5538.861528461821;5550.916736248879;5538.861528461821;5544.445555444423;5545.197810711455;5552.666839989613;5574.637648552831;5297.205419186998;5411.594130440154;5446.183072539151;5448.918266225931;5482.671039737628;5569.526590239875;5572.219889215432;5597.244372009726;5624.690642014729;5629.605927585194;5382.327209098863;5447.564194864322;5455.372632147195;5457.345118585795;5487.725613719378 10:39:48 INFO - PROCESS | 3401 | |5;yui.html;573.9397363276854;647.4076220258464;662.4005275225919;684.5789839248862;735.1692587376264;14448;14669.486567970123;15030.398784048624;15343.38626454942;15359;13439.26084065376;13744.17534947904;13746.862531374683;13750.793738093937;13836.584902452918;657.7533424965637;772.7449941519285;794.0233512779284;796.024869534821;796.044746304434;668.8361351468873;765.4603504529322;788.2432864450107;795.8129839487744;796.0089688337998;832.1678321678322;832.8500869843426;834.6202477872583;834.6869923778584;835.031363618203;623.5105442227874;827.0365024746163;827.1604321613537;827.5117680568463;828;466.552109974425;582.9941700583024;599.409581562161;602.325395556979;602.9608075475124;13339.333033348294;13370.130941488773;13379.130356526795;13381.598552043357;13387.397567109503;12651.873481265162;13007.739845203138;13224.27266500342;13510;13672.453101875913;12661.936690316581;12857.935710321388;12870.099093063489;12941.288229147392;13019.674508137372;4307.1601037797645;4361.105973275503;4373.497047839507;4378;4387.100644367929;83955.5802220991;84868.15131848665;85635.57182214111;87336.12663873343;88427;10960.780784384267;11080.778384432428;11123.555057797597;11146.331220126818;11334.149938754626;20650.896745516176;20764.792352076285;20784.272550460963;20875.58248835045;23115.53768924612;7446.702131914771;7469.1037075551285;7542.660580273791;7543.849123017509;7813.335866451415;3877.8061096945603;3920.294347017564;3926.705497087673;4095.508538975342;4180.435641188462;3329.667033296651;3448.1724386147143;3451.861925523001;3453.1194545391268;3453.637368076366;569.0440060698068;575.3239943066964;579.5913880714087;579.7651950959868;581.682982774389;508.336620709977;548.9039418101817;614.744880874441;620.2433031701318;621.8911690454153;8256;8503.787405314793;8675.913240867636;8920.643174272956;9319.347645664739;494.5647829909656;546.1998172677047;581.8748968971606;595.9940400595939;618.1006635345651;3533.8056406897354;3807.676347510437;3920.1179734559496;3938.369860822255;3973.6821054315587;71103;71205;72210.2778972214;109390.90609093808;125110;107267.46366268274;108184;109789;110343.44828275808;111176.44411778051;95380.52309738546;97712;97882.51058744661;99428;100104;6948.861022779415;7326.780196594111;7360.116785985716;7407.518511296748;7670.348020418104;55136.55656486323;55851;56451;56628;58396.70801645965;75407.24592754002;76369.61815190889;81693;84487.57756211425;84946;10052.195824334181;10204.540795664361;10330.48347582633;10422.635207767691;10425.582976680847;10570.418626975283;10827.24209305341;10902.509387077442;11207.943960280147;11254;10338.689839304832;10397.688069357931;10494.160467162455;10585.206109541661;10993.065589424989;10443.94778026105;10617.89382106169;10682.359058456517;10933.453327333442;10992.527752992317;10353;10642;10699.839502407625;10765.515551800032;10847.40339281347;9143;9334.626614935598;9361.297902657465;9452.338336316392;9822.410655360702;8499.150084991452;8744.91255087441;8762.430442021248;8793.824123517366;8901 10:39:48 INFO - PROCESS | 3401 | __end_tp_report 10:39:48 INFO - PROCESS | 3401 | __start_cc_report 10:39:48 INFO - PROCESS | 3401 | _x_x_mozilla_cycle_collect,1071 10:39:48 INFO - PROCESS | 3401 | __end_cc_report 10:39:48 INFO - PROCESS | 3401 | __startTimestamp1474738788772__endTimestamp 10:39:48 INFO - PROCESS | 3401 | 10:39:48 INFO - PROCESS | 3401 | ------- Summary: start ------- 10:39:48 INFO - PROCESS | 3401 | Number of tests: 6 10:39:48 INFO - PROCESS | 3401 | 10:39:48 INFO - PROCESS | 3401 | [#0] dojo.html Cycles:165 Average:5248.54 Median:5440.54 stddev:569.63 (10.5%) stddev-sans-first:544.15 10:39:48 INFO - PROCESS | 3401 | Values: 3030.3 3058.2 3065.6 3095.0 3111.6 5173.8 5205.1 5248.9 5332.4 5371.5 5252.9 5263.2 5334.9 5362.9 5401.9 4809.6 4819.6 4824.0 4833.6 4955.6 4930.9 4958.8 4986.6 5001.7 5026.3 4734.7 4767.2 4796.5 4865.7 4906.5 4864.5 4867.8 4930.5 4930.5 4938.4 4802.8 4831.5 4849.6 4850.6 4904.0 5131.0 5168.2 5314.5 5328.8 5383.1 5528.7 5583.4 5643.4 5651.3 5654.2 5583.3 5593.4 5599.3 5600.7 5601.4 5137.5 5193.5 5216.9 5224.8 5274.9 5606.0 5683.6 5743.3 5746.8 5835.1 5474.2 5514.4 5517.3 5521.0 5521.2 5544.6 5579.0 5609.2 5616.0 5617.1 5424.9 5495.4 5601.6 5651.1 5666.2 5684.1 5701.4 5749.9 5779.3 5781.4 4426.1 4427.8 4435.5 4438.2 4484.0 3855.1 3862.1 3884.2 3916.9 3941.7 5394.9 5402.8 5403.7 5408.6 5409.7 5575.2 5607.5 5621.9 5633.2 5638.8 5259.2 5268.8 5273.6 5278.5 5282.7 4744.1 4809.3 4819.3 4874.6 4881.8 5770.5 5787.2 5787.5 5791.6 5847.7 5647.4 5652.2 5664.4 5666.5 5671.9 5691.1 5729.1 5746.0 5782.5 5790.0 5537.6 5576.4 5592.3 5640.9 5649.2 5632.4 5655.5 5659.6 5664.1 5665.5 5396.6 5463.9 5483.7 5551.9 5561.3 5503.7 5520.0 5526.6 5560.1 5592.9 5415.8 5440.5 5442.3 5448.4 5453.0 5393.6 5441.8 5539.5 5553.5 5621.5 5384.3 5406.5 5428.2 5445.3 5504.4 10:39:48 INFO - PROCESS | 3401 | 10:39:48 INFO - PROCESS | 3401 | [#1] ext.html Cycles:180 Average:57472.69 Median:3949.00 stddev:114971.55 (2911.4%) stddev-sans-first:115214.64 10:39:48 INFO - PROCESS | 3401 | Values: 551.3 588.0 610.2 617.1 624.5 42553.8 43966.8 44054.3 44066.8 48288.8 44515.1 44893.3 44964.6 45015.5 45063.0 8981.1 9142.6 9156.7 9159.7 9160.7 8947.8 9013.1 9042.0 9044.2 9045.3 9090.0 9106.8 9118.8 9120.3 9130.6 9003.5 9015.5 9029.5 9045.4 9045.6 9011.5 9093.5 9096.2 9104.3 9104.8 41880.0 42150.8 42154.2 42160.4 42214.0 3485.6 3575.5 3852.5 4045.5 4072.7 31687.5 31729.7 31916.7 31941.2 32224.4 4260.4 4281.2 4331.6 4349.8 4378.5 337690.0 338385.0 338931.0 339011.0 339037.0 35326.5 59199.7 59578.0 59623.4 59680.6 35904.5 37672.6 37714.8 37735.2 37788.6 14383.7 14607.0 14611.9 14623.3 14624.6 12912.3 13184.7 13187.7 13192.7 13224.3 8731.6 8742.9 8750.4 8784.8 8823.3 3292.6 3305.9 3352.8 3353.3 3363.1 934.5 972.5 974.7 1001.4 1029.4 31308.0 31375.7 31807.4 31841.4 32084.7 1009.5 1061.3 1077.2 1094.3 1155.4 15742.0 16527.8 16621.0 16888.2 17243.1 498805.0 502871.0 502944.0 503769.0 504796.0 57242.0 57250.0 57335.4 57978.7 57984.0 1083.8 1209.2 1212.1 1281.3 1319.7 29316.7 32189.2 32301.2 34296.1 34606.1 54327.7 54978.5 55044.2 55049.2 55053.2 438500.0 442787.0 442883.0 443240.0 443436.0 24764.6 25290.7 27465.9 27962.4 28448.4 42742.4 43905.1 44057.1 44076.6 44115.6 36536.3 37292.4 37372.6 37407.1 37582.0 36945.0 37892.4 38282.0 38313.8 38379.4 29430.9 29717.4 30293.7 31025.7 38091.2 29855.0 35100.0 35133.3 36242.8 36513.6 27016.7 27317.0 27676.6 27876.2 27918.3 10:39:48 INFO - PROCESS | 3401 | 10:39:48 INFO - PROCESS | 3401 | [#2] jquery.html Cycles:180 Average:30265.96 Median:2335.07 stddev:85954.62 (3681.0%) stddev-sans-first:86166.39 10:39:48 INFO - PROCESS | 3401 | Values: 350.6 376.4 380.2 382.7 401.5 14460.6 18343.4 19260.1 20390.0 20528.6 15821.5 18063.0 18116.5 18334.3 18415.2 5400.7 5641.9 5655.2 5668.5 5669.1 4106.7 4303.9 4342.4 5481.3 5587.9 4408.4 6309.9 6313.9 6318.0 6348.6 6087.0 6244.9 6282.1 6309.2 6314.8 5402.0 5446.9 5455.6 5457.7 5458.7 22487.0 23493.1 23498.8 23499.3 23656.6 2168.5 2322.1 2348.0 2387.3 2408.7 13611.9 14091.6 14401.9 15097.2 15113.5 1699.4 1860.6 1875.1 1888.1 1930.5 82140.6 83156.0 83393.0 83559.6 84604.6 10300.4 10330.8 10342.8 10474.2 10530.3 13419.5 13434.8 13441.6 13449.1 13459.5 7898.9 8060.7 8088.2 8208.1 8247.1 7893.3 8109.9 8164.2 8183.1 8643.5 6375.3 6382.6 6392.1 6433.8 6494.6 1797.5 1797.5 1803.6 1809.6 1839.6 927.5 963.4 983.9 1032.9 1042.5 18605.3 19565.5 19863.5 19957.0 20010.8 965.4 1001.6 1029.2 1046.8 1061.9 10200.0 11152.9 11233.4 11371.6 11376.9 509821.0 512534.0 523823.0 526716.0 530507.0 94418.0 99337.0 100995.0 102372.0 103712.5 1026.6 1027.6 1063.9 1072.8 1073.5 16470.8 16633.6 16956.6 17463.2 18026.1 42085.8 42812.0 42867.0 43157.8 43227.8 60706.4 61446.7 61522.4 61830.7 62138.4 8126.3 8261.7 8317.6 8481.1 8550.0 12647.7 12849.4 12864.8 13044.7 13065.2 11145.5 11221.3 11470.2 11474.6 11617.0 11204.9 11293.9 11456.9 11598.7 11823.1 11484.3 11729.4 11749.6 11813.7 11940.3 7277.5 7784.4 7947.7 8370.7 8772.7 9110.6 11164.4 11361.4 12132.5 12341.8 10:39:48 INFO - PROCESS | 3401 | 10:39:48 INFO - PROCESS | 3401 | [#3] mootools.html Cycles:180 Average:5575.81 Median:5077.26 stddev:3128.27 (61.6%) stddev-sans-first:3120.16 10:39:48 INFO - PROCESS | 3401 | Values: 1251.9 1334.8 1412.7 1445.5 1741.0 7584.9 8359.4 8522.2 8692.8 8881.7 8724.6 8762.2 8781.6 8788.6 8792.7 2330.9 2389.4 2391.4 2393.4 2394.1 2285.6 2354.9 2359.8 2360.7 2379.1 2338.2 2344.2 2355.3 2372.5 2375.5 2308.5 2313.2 2332.8 2333.4 2335.0 2277.2 2280.2 2287.6 2295.2 2295.5 8533.1 8592.4 8636.5 8679.1 8683.0 5143.8 5382.7 5383.9 5446.9 5448.2 3349.2 3508.5 3511.4 3560.0 3589.0 1017.3 1033.9 1037.0 1042.1 1062.4 10902.5 10975.3 11035.4 11038.7 11044.1 4281.0 4318.8 4446.9 4475.8 4517.5 8808.6 8831.7 8833.4 8837.1 8838.6 5075.9 5090.2 5107.8 5120.3 5123.4 4240.6 4376.6 4744.7 4774.7 4879.5 3704.4 3752.1 3855.0 3870.7 3887.4 1107.6 1126.3 1134.4 1138.1 1142.3 794.0 913.6 931.3 934.5 959.2 5613.3 5617.2 5793.5 5814.4 5876.4 428.3 432.4 433.6 439.1 467.7 3545.0 3572.3 3617.9 3627.2 3662.5 10516.7 10747.5 10891.1 10899.6 10926.2 10243.2 10731.0 10778.2 10796.5 10802.2 8026.4 8204.6 8214.2 8229.1 8230.7 5627.2 5629.5 5681.8 5687.6 5773.2 9040.8 9221.1 9260.9 9264.1 9305.3 9135.8 9256.6 9365.6 9379.2 9408.2 7799.3 7806.4 7834.9 7886.2 7894.8 8373.2 8422.2 8437.8 8440.6 8491.6 7482.0 7545.6 7563.3 7646.7 7798.9 7286.8 7419.3 7451.4 7465.0 7640.0 6831.5 6868.3 6938.2 6950.4 6966.0 4994.9 5037.7 5075.9 5133.7 5252.7 5041.6 5046.2 5078.6 5105.4 5253.3 10:39:48 INFO - PROCESS | 3401 | 10:39:48 INFO - PROCESS | 3401 | [#4] prototype.html Cycles:180 Average:4508.58 Median:4985.68 stddev:1294.88 (26.0%) stddev-sans-first:1259.81 10:39:48 INFO - PROCESS | 3401 | Values: 322.0 332.8 334.6 340.9 341.4 5175.5 5298.6 5299.7 5364.5 5368.1 5143.8 5208.8 5229.7 5249.4 5270.4 4129.8 4142.5 4185.0 4195.3 4199.4 3955.5 4131.4 4163.1 4194.2 4202.3 4130.8 4138.6 4146.4 4150.3 4156.2 4145.6 4150.0 4159.8 4169.3 4191.3 3675.9 3685.3 3687.2 3688.1 3698.7 5051.0 5150.8 5153.4 5180.8 5223.4 4670.2 4704.5 4704.8 4708.5 4716.9 5490.3 5492.5 5504.0 5512.2 5577.4 3759.6 3937.3 3943.2 3952.3 3953.7 5675.9 5699.6 5703.1 5703.9 5711.3 4061.6 4071.8 4100.3 4106.4 4110.7 4031.7 4146.9 4191.5 4221.2 4225.1 4722.1 4725.3 4726.5 4752.9 4773.5 5470.9 5543.2 5552.6 5618.8 5652.9 1341.2 1369.4 1435.8 1466.0 1467.7 941.0 951.5 963.1 965.6 971.1 4690.6 4693.4 4715.6 4732.6 4733.7 4937.9 4938.0 4950.9 4958.5 4989.2 4568.5 4717.8 4719.0 4735.4 4742.7 2636.8 2640.9 2642.4 2655.8 2656.7 5029.2 5040.0 5103.8 5145.8 5200.5 4713.3 5034.4 5064.8 5090.9 5126.7 5075.7 5078.9 5087.8 5102.2 5102.3 4918.6 4941.5 4982.3 4989.1 5012.6 4740.4 4901.8 4968.8 5198.6 5619.9 5789.6 5807.3 5812.5 5815.2 5824.6 4033.5 4091.1 4095.1 4107.0 4111.0 5382.4 5449.3 5658.7 5755.3 5802.4 5341.8 5386.8 5488.9 5538.9 5550.9 5538.9 5544.4 5545.2 5552.7 5574.6 5297.2 5411.6 5446.2 5448.9 5482.7 5569.5 5572.2 5597.2 5624.7 5629.6 5382.3 5447.6 5455.4 5457.3 5487.7 10:39:48 INFO - PROCESS | 3401 | 10:39:48 INFO - PROCESS | 3401 | [#5] yui.html Cycles:180 Average:20488.92 Median:527.27 stddev:31117.86 (5901.7%) stddev-sans-first:31169.23 10:39:48 INFO - PROCESS | 3401 | Values: 573.9 647.4 662.4 684.6 735.2 14448.0 14669.5 15030.4 15343.4 15359.0 13439.3 13744.2 13746.9 13750.8 13836.6 657.8 772.7 794.0 796.0 796.0 668.8 765.5 788.2 795.8 796.0 832.2 832.9 834.6 834.7 835.0 623.5 827.0 827.2 827.5 828.0 466.6 583.0 599.4 602.3 603.0 13339.3 13370.1 13379.1 13381.6 13387.4 12651.9 13007.7 13224.3 13510.0 13672.5 12661.9 12857.9 12870.1 12941.3 13019.7 4307.2 4361.1 4373.5 4378.0 4387.1 83955.6 84868.2 85635.6 87336.1 88427.0 10960.8 11080.8 11123.6 11146.3 11334.1 20650.9 20764.8 20784.3 20875.6 23115.5 7446.7 7469.1 7542.7 7543.8 7813.3 3877.8 3920.3 3926.7 4095.5 4180.4 3329.7 3448.2 3451.9 3453.1 3453.6 569.0 575.3 579.6 579.8 581.7 508.3 548.9 614.7 620.2 621.9 8256.0 8503.8 8675.9 8920.6 9319.3 494.6 546.2 581.9 596.0 618.1 3533.8 3807.7 3920.1 3938.4 3973.7 71103.0 71205.0 72210.3 109390.9 125110.0 107267.5 108184.0 109789.0 110343.4 111176.4 95380.5 97712.0 97882.5 99428.0 100104.0 6948.9 7326.8 7360.1 7407.5 7670.3 55136.6 55851.0 56451.0 56628.0 58396.7 75407.2 76369.6 81693.0 84487.6 84946.0 10052.2 10204.5 10330.5 10422.6 10425.6 10570.4 10827.2 10902.5 11207.9 11254.0 10338.7 10397.7 10494.2 10585.2 10993.1 10443.9 10617.9 10682.4 10933.5 10992.5 10353.0 10642.0 10699.8 10765.5 10847.4 9143.0 9334.6 9361.3 9452.3 9822.4 8499.2 8744.9 8762.4 8793.8 8901.0 10:39:48 INFO - PROCESS | 3401 | -------- Summary: end -------- 10:39:48 INFO - PROCESS | 3401 | 10:39:49 INFO - TEST-INFO | 3401: exit 0 10:39:49 INFO - TEST-OK | dromaeo_css | took 1120621ms 10:39:49 INFO - TEST-START | kraken 10:39:49 INFO - operating with platform_type : linux_ 10:39:49 INFO - Initialising browser for kraken test... 10:39:49 INFO - TEST-INFO | started process 3708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8REYzZ/profile http://localhost:51373/getInfo.html) 10:39:54 INFO - PROCESS | 3708 | __metrics Screen width/height:1600/1200 10:39:54 INFO - PROCESS | 3708 | colorDepth:24 10:39:54 INFO - PROCESS | 3708 | Browser inner width/height: 1024/697 10:39:54 INFO - PROCESS | 3708 | __metrics 10:39:54 INFO - PROCESS | 3708 | 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" 10:39:54 INFO - PROCESS | 3708 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:39:55 INFO - PROCESS | 3708 | console.error: PushService: 10:39:55 INFO - PROCESS | 3708 | stateChangeProcessEnqueue: Error transitioning state 10:39:55 INFO - PROCESS | 3708 | UnknownError 10:39:56 INFO - TEST-INFO | 3708: exit 0 10:39:56 INFO - Browser initialized. 10:39:56 INFO - Running cycle 1/1 for kraken test... 10:39:56 INFO - TEST-INFO | started process 3791 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8REYzZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:40:08 INFO - PROCESS | 3791 | RSS: Main: 173457408 10:40:08 INFO - PROCESS | 3791 | 10:40:10 INFO - PROCESS | 3791 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51373/tests/kraken/driver.html?testName=audio-beat-detection) 10:40:11 INFO - PROCESS | 3791 | RSS: Main: 232366080 10:40:11 INFO - PROCESS | 3791 | 10:40:14 INFO - PROCESS | 3791 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51373/tests/kraken/driver.html?testName=audio-dft) 10:40:14 INFO - PROCESS | 3791 | RSS: Main: 216829952 10:40:14 INFO - PROCESS | 3791 | 10:40:18 INFO - PROCESS | 3791 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51373/tests/kraken/driver.html?testName=audio-fft) 10:40:18 INFO - PROCESS | 3791 | RSS: Main: 298405888 10:40:18 INFO - PROCESS | 3791 | 10:40:20 INFO - PROCESS | 3791 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51373/tests/kraken/driver.html?testName=audio-oscillator) 10:40:21 INFO - PROCESS | 3791 | RSS: Main: 208326656 10:40:21 INFO - PROCESS | 3791 | 10:40:23 INFO - PROCESS | 3791 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51373/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:40:24 INFO - PROCESS | 3791 | RSS: Main: 212725760 10:40:24 INFO - PROCESS | 3791 | 10:40:27 INFO - PROCESS | 3791 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51373/tests/kraken/driver.html?testName=imaging-darkroom) 10:40:27 INFO - PROCESS | 3791 | RSS: Main: 248778752 10:40:27 INFO - PROCESS | 3791 | 10:40:31 INFO - PROCESS | 3791 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51373/tests/kraken/driver.html?testName=imaging-desaturate) 10:40:31 INFO - PROCESS | 3791 | RSS: Main: 248373248 10:40:31 INFO - PROCESS | 3791 | 10:40:34 INFO - PROCESS | 3791 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51373/tests/kraken/driver.html?testName=json-parse-financial) 10:40:35 INFO - PROCESS | 3791 | RSS: Main: 248348672 10:40:35 INFO - PROCESS | 3791 | 10:40:36 INFO - PROCESS | 3791 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51373/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:40:37 INFO - PROCESS | 3791 | RSS: Main: 209915904 10:40:37 INFO - PROCESS | 3791 | 10:40:38 INFO - PROCESS | 3791 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51373/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:40:39 INFO - PROCESS | 3791 | RSS: Main: 217124864 10:40:39 INFO - PROCESS | 3791 | 10:40:41 INFO - PROCESS | 3791 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51373/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:40:42 INFO - PROCESS | 3791 | RSS: Main: 222306304 10:40:42 INFO - PROCESS | 3791 | 10:40:44 INFO - PROCESS | 3791 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:40:45 INFO - PROCESS | 3791 | RSS: Main: 223412224 10:40:45 INFO - PROCESS | 3791 | 10:40:48 INFO - PROCESS | 3791 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:40:48 INFO - PROCESS | 3791 | RSS: Main: 221601792 10:40:48 INFO - PROCESS | 3791 | 10:40:50 INFO - PROCESS | 3791 | Cycle 1(1): loaded http://localhost:51373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51373/tests/kraken/driver.html?testName=ai-astar) 10:40:50 INFO - PROCESS | 3791 | RSS: Main: 272830464 10:40:50 INFO - PROCESS | 3791 | 10:40:50 INFO - PROCESS | 3791 | __start_tp_report 10:40:50 INFO - PROCESS | 3791 | _x_x_mozilla_page_load 10:40:50 INFO - PROCESS | 3791 | _x_x_mozilla_page_load_details 10:40:50 INFO - PROCESS | 3791 | |i|pagename|runs| 10:40:50 INFO - PROCESS | 3791 | |0;ai-astar;109;110;110;109;111;111;111;110;110;110 10:40:50 INFO - PROCESS | 3791 | |1;audio-beat-detection;148;122;122;166;122;119;118;119;149;118 10:40:50 INFO - PROCESS | 3791 | |2;audio-dft;162;162;162;161;163;161;163;161;163;161 10:40:50 INFO - PROCESS | 3791 | |3;audio-fft;75;75;74;111;75;76;76;75;112;76 10:40:50 INFO - PROCESS | 3791 | |4;audio-oscillator;83;83;120;83;82;81;102;81;83;112 10:40:50 INFO - PROCESS | 3791 | |5;imaging-gaussian-blur;117;117;117;118;118;118;117;117;117;116 10:40:50 INFO - PROCESS | 3791 | |6;imaging-darkroom;147;147;147;147;147;147;147;147;146;145 10:40:50 INFO - PROCESS | 3791 | |7;imaging-desaturate;96;96;95;96;96;96;96;95;95;95 10:40:50 INFO - PROCESS | 3791 | |8;json-parse-financial;51;51;52;50;52;53;53;52;51;52 10:40:50 INFO - PROCESS | 3791 | |9;json-stringify-tinderbox;59;60;59;61;60;60;61;60;61;60 10:40:50 INFO - PROCESS | 3791 | |10;stanford-crypto-aes;80;78;79;81;82;84;79;87;79;79 10:40:50 INFO - PROCESS | 3791 | |11;stanford-crypto-ccm;130;133;131;127;131;123;136;132;158;134 10:40:50 INFO - PROCESS | 3791 | |12;stanford-crypto-pbkdf2;162;162;166;159;158;161;164;160;161;159 10:40:50 INFO - PROCESS | 3791 | |13;stanford-crypto-sha256-iterative;65;66;67;64;66;64;63;65;63;64 10:40:50 INFO - PROCESS | 3791 | __end_tp_report 10:40:50 INFO - PROCESS | 3791 | __start_cc_report 10:40:50 INFO - PROCESS | 3791 | _x_x_mozilla_cycle_collect,1606 10:40:50 INFO - PROCESS | 3791 | __end_cc_report 10:40:50 INFO - PROCESS | 3791 | __startTimestamp1474738850673__endTimestamp 10:40:50 INFO - PROCESS | 3791 | 10:40:50 INFO - PROCESS | 3791 | ------- Summary: start ------- 10:40:50 INFO - PROCESS | 3791 | Number of tests: 14 10:40:50 INFO - PROCESS | 3791 | 10:40:50 INFO - PROCESS | 3791 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.67 10:40:50 INFO - PROCESS | 3791 | Values: 109.0 110.0 110.0 109.0 111.0 111.0 111.0 110.0 110.0 110.0 10:40:50 INFO - PROCESS | 3791 | 10:40:50 INFO - PROCESS | 3791 | [#1] audio-beat-detection Cycles:10 Average:130.30 Median:122.00 stddev:17.33 (14.2%) stddev-sans-first:17.15 10:40:50 INFO - PROCESS | 3791 | Values: 148.0 122.0 122.0 166.0 122.0 119.0 118.0 119.0 149.0 118.0 10:40:50 INFO - PROCESS | 3791 | 10:40:50 INFO - PROCESS | 3791 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 10:40:50 INFO - PROCESS | 3791 | Values: 162.0 162.0 162.0 161.0 163.0 161.0 163.0 161.0 163.0 161.0 10:40:50 INFO - PROCESS | 3791 | 10:40:50 INFO - PROCESS | 3791 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:15.30 (20.4%) stddev-sans-first:15.98 10:40:50 INFO - PROCESS | 3791 | Values: 75.0 75.0 74.0 111.0 75.0 76.0 76.0 75.0 112.0 76.0 10:40:50 INFO - PROCESS | 3791 | 10:40:50 INFO - PROCESS | 3791 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:82.50 stddev:14.68 (17.8%) stddev-sans-first:15.28 10:40:50 INFO - PROCESS | 3791 | Values: 83.0 83.0 120.0 83.0 82.0 81.0 102.0 81.0 83.0 112.0 10:40:50 INFO - PROCESS | 3791 | 10:40:50 INFO - PROCESS | 3791 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 10:40:50 INFO - PROCESS | 3791 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 117.0 117.0 117.0 116.0 10:40:50 INFO - PROCESS | 3791 | 10:40:50 INFO - PROCESS | 3791 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 10:40:50 INFO - PROCESS | 3791 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 145.0 10:40:50 INFO - PROCESS | 3791 | 10:40:50 INFO - PROCESS | 3791 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:40:50 INFO - PROCESS | 3791 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 10:40:50 INFO - PROCESS | 3791 | 10:40:50 INFO - PROCESS | 3791 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:0.95 (1.8%) stddev-sans-first:0.97 10:40:50 INFO - PROCESS | 3791 | Values: 51.0 51.0 52.0 50.0 52.0 53.0 53.0 52.0 51.0 52.0 10:40:50 INFO - PROCESS | 3791 | 10:40:50 INFO - PROCESS | 3791 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 10:40:50 INFO - PROCESS | 3791 | Values: 59.0 60.0 59.0 61.0 60.0 60.0 61.0 60.0 61.0 60.0 10:40:50 INFO - PROCESS | 3791 | 10:40:50 INFO - PROCESS | 3791 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.50 stddev:2.82 (3.5%) stddev-sans-first:2.98 10:40:50 INFO - PROCESS | 3791 | Values: 80.0 78.0 79.0 81.0 82.0 84.0 79.0 87.0 79.0 79.0 10:40:50 INFO - PROCESS | 3791 | 10:40:50 INFO - PROCESS | 3791 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:132.50 stddev:9.35 (7.1%) stddev-sans-first:9.83 10:40:50 INFO - PROCESS | 3791 | Values: 130.0 133.0 131.0 127.0 131.0 123.0 136.0 132.0 158.0 134.0 10:40:50 INFO - PROCESS | 3791 | 10:40:50 INFO - PROCESS | 3791 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:161.50 stddev:2.44 (1.5%) stddev-sans-first:2.57 10:40:50 INFO - PROCESS | 3791 | Values: 162.0 162.0 166.0 159.0 158.0 161.0 164.0 160.0 161.0 159.0 10:40:50 INFO - PROCESS | 3791 | 10:40:50 INFO - PROCESS | 3791 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.34 (2.1%) stddev-sans-first:1.41 10:40:50 INFO - PROCESS | 3791 | Values: 65.0 66.0 67.0 64.0 66.0 64.0 63.0 65.0 63.0 64.0 10:40:50 INFO - PROCESS | 3791 | -------- Summary: end -------- 10:40:50 INFO - PROCESS | 3791 | 10:40:51 INFO - TEST-INFO | 3791: exit 0 10:40:51 INFO - TEST-OK | kraken | took 62153ms 10:40:51 INFO - SUITE-END | took 1182s 10:40:52 INFO - Completed test suite (00:19:43) 10:40:52 INFO - javascript benchmark 10:40:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3030.30303030303, 3058.220153860765, 3065.6167979002626, 3094.9535756963664, 3111.6266048074235, 5173.793048278074, 5205.063088644042, 5248.86877828054, 5332.413434522205, 5371.543418809396, 5252.868678283045, 5263.236830659552, 5334.946650533493, 5362.946370536293, 5401.945980540193, 4809.615230781529, 4819.590334821544, 4824.0, 4833.589144922686, 4955.578775804061, 4930.876728081808, 4958.752062396866, 4986.626003049768, 5001.674891132083, 5026.346574945252, 4734.6685731998605, 4767.213409787381, 4796.544328288807, 4865.6594038417325, 4906.484819093997, 4864.537868902448, 4867.780949857265, 4930.482299358588, 4930.5069493050405, 4938.407391113054, 4802.783874725646, 4831.516848315176, 4849.563539281482, 4850.5877000455, 4903.975480122576, 5130.9743451282875, 5168.22476628505, 5314.495122963351, 5328.813491527778, 5383.084875571162, 5528.668279903179, 5583.3858275589655, 5643.40744221859, 5651.265335506399, 5654.236678048452, 5583.302087239095, 5593.3847276799515, 5599.272094627672, 5600.719964001824, 5601.411851755548, 5137.486251374908, 5193.506616871391, 5216.895662086737, 5224.817131400383, 5274.894502109974, 5606.018946684314, 5683.630564013326, 5743.339515955635, 5746.798862039808, 5835.124731290255, 5474.151506516417, 5514.420985796514, 5517.2551705520045, 5521.00621888064, 5521.171824226318, 5544.611877168641, 5579.0, 5609.158626206102, 5616.0373145436915, 5617.129344951539, 5424.945750542523, 5495.395506494282, 5601.551875849922, 5651.124075768263, 5666.235058267163, 5684.118961560965, 5701.4013528579735, 5749.913751293734, 5779.2775903012125, 5781.364049954502, 4426.092651006536, 4427.845025424094, 4435.467743870756, 4438.223310920576, 4483.977580112079, 3855.132595166121, 3862.0537968197973, 3884.2425726982965, 3916.921661566753, 3941.7437866538585, 5394.9460505394445, 5402.783888644411, 5403.675779453245, 5408.621396502207, 5409.702466364388, 5575.163725441216, 5607.467290607386, 5621.915671264935, 5633.183188437653, 5638.774449021993, 5259.184826351921, 5268.762905669254, 5273.604479664041, 5278.498542638443, 5282.656627319212, 4744.098621262018, 4809.254565542276, 4819.277108433763, 4874.610031197496, 4881.755912204376, 5770.451807078321, 5787.2476578045425, 5787.536997040227, 5791.594588378773, 5847.736851841677, 5647.3505546861, 5652.152177173457, 5664.405237450173, 5666.490015898589, 5671.858203544944, 5691.117876729114, 5729.1119876419225, 5746.0, 5782.45066718661, 5789.9710501447225, 5537.5569954402745, 5576.414476480073, 5592.328920529562, 5640.887182256414, 5649.180868773922, 5632.408597097409, 5655.4910058094965, 5659.6321239119325, 5664.0937450007805, 5665.49010589049, 5396.568274537949, 5463.863403414946, 5483.698396588226, 5551.861203469945, 5561.332640083054, 5503.669779813224, 5519.972400137974, 5526.557875370041, 5560.054790685674, 5592.888142237214, 5415.810446634349, 5440.53755430777, 5442.319710036246, 5448.4006759257245, 5452.972735136457, 5393.649412788313, 5441.755121019484, 5539.473749993744, 5553.50018498321, 5621.5221706155435, 5384.326959130109, 5406.51341379262, 5428.212909128233, 5445.346558413015, 5504.366997795305], "value": 5211.470263608635, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.2673745031468, 587.9706014699265, 610.2189197826781, 617.0743884173738, 624.494159730618, 42553.78723106384, 43966.780166099124, 44054.33918491221, 44066.779666101706, 48288.75855620717, 44515.10969780602, 44893.32660010103, 44964.550354496445, 45015.54984450155, 45063.0, 8981.101889811032, 9142.63429462824, 9156.725298241063, 9159.725208243763, 9160.725178244664, 8947.776305592348, 9013.098690131, 9042.0, 9044.186023257906, 9045.321600879928, 9089.954550227272, 9106.817863642724, 9118.77203069922, 9120.270378369747, 9130.589123489459, 9003.459792412443, 9015.549222538846, 9029.548522573845, 9045.3668243223, 9045.592948317342, 9011.459312441275, 9093.499857507835, 9096.226820720247, 9104.31717621181, 9104.817903641957, 41880.0, 42150.78924605388, 42154.1569168618, 42160.36759448611, 42214.0, 3485.5643044619424, 3575.535180426528, 3852.460655508231, 4045.5347635022054, 4072.694547908889, 31687.524687129713, 31729.682703173134, 31916.680833191604, 31941.20146996344, 32224.355512889844, 4260.382244574519, 4281.229378711831, 4331.635534806526, 4349.826006959718, 4378.474583050054, 337690.0, 338385.0, 338931.0, 339011.0, 339037.0, 35326.47010294848, 59199.70400147972, 59578.0, 59623.403765962656, 59680.55590271685, 35904.461433078526, 37672.62327376746, 37714.811425942695, 37735.24529509395, 37788.62211377906, 14383.712325753426, 14607.0, 14611.853881461262, 14623.341949612293, 14624.634384140481, 12912.289824059766, 13184.73630527384, 13187.67030824237, 13192.670183245304, 13224.272665003517, 8731.563421828883, 8742.91257087421, 8750.387472876964, 8784.78038049054, 8823.338249631302, 3292.5719656444508, 3305.8512366943546, 3352.798832070084, 3353.3293341331832, 3363.1423986883187, 934.4626839567276, 972.547765289144, 974.7124598243536, 1001.4341896828269, 1029.3978022856713, 31308.0, 31375.686243137276, 31807.363852722818, 31841.363172736415, 32084.67915320817, 1009.5103874620803, 1061.3366645846345, 1077.1813421799332, 1094.2887123369715, 1155.381870699172, 15742.0, 16527.752083718755, 16621.0, 16888.240029198714, 17243.137843108045, 498805.0, 502871.0, 502944.0, 503769.0, 504796.0, 57242.0, 57250.0, 57335.42664573301, 57978.710106449194, 57984.0, 1083.8320060390652, 1209.1958847366402, 1212.1030437476204, 1281.2952875918209, 1319.736052789446, 29316.70683293225, 32189.195270118435, 32301.192470188435, 34296.14259643529, 34606.13484662904, 54327.72836135794, 54978.45021549733, 55044.17433738417, 55049.1742623853, 55053.174202386195, 438500.0, 442787.0, 442883.0, 443240.0, 443436.0, 24764.628530571696, 25290.71220741292, 27465.86267068732, 27962.44075118527, 28448.43103137884, 42742.358864616435, 43905.12189756123, 44057.11885762331, 44076.55923440853, 44115.55884441114, 36536.26927461383, 37292.440613391365, 37372.626273738, 37407.06482337855, 37582.0, 36945.0, 37892.43161352527, 38282.0429489265, 38313.808430957666, 38379.424308634836, 29430.852845735633, 29717.405651887275, 30293.69706302997, 31025.68974310228, 38091.23817523578, 29855.0, 35100.0, 35133.297334052666, 36242.8187859059, 36513.63486365102, 27016.72983270142, 27317.0, 27676.584851226846, 27876.17695859927, 27918.3020424491], "value": 18588.56047424958, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.58455729959985, 376.3770959062752, 380.24319721154984, 382.74356181358496, 401.5462527344101, 14460.638484037905, 18343.44969650909, 19260.133294001786, 20390.0, 20528.589428211464, 15821.525354239391, 18063.0, 18116.456506304832, 18334.266629334845, 18415.171317290722, 5400.702961337125, 5641.887162256752, 5655.208270842065, 5668.518175955049, 5669.09294512878, 4106.7125301228925, 4303.913921721563, 4342.435483387155, 5481.287432633752, 5587.8882422351735, 4408.42690450241, 6309.905351419732, 6313.9052914206095, 6318.0, 6348.619082855043, 6086.969565152191, 6244.937550624527, 6282.057691346335, 6309.179806625132, 6314.7789827356055, 5402.0, 5446.863828404322, 5455.645383050129, 5457.672539647634, 5458.699771512565, 22487.0, 23493.060277588876, 23498.765012349828, 23499.29502114939, 23656.645150322758, 2168.5012447137087, 2322.094383190557, 2348.0373047050625, 2387.2599494156866, 2408.6627872097747, 13611.931940340235, 14091.577252682437, 14401.855981440156, 15097.245137743179, 15113.54659360221, 1699.3967141664655, 1860.5813691919345, 1875.1468082022648, 1888.1408958923657, 1930.5077205312696, 82140.58929705372, 83156.0, 83393.0, 83559.58220208921, 84604.57697711472, 10300.433476158883, 10330.793384132425, 10342.844857327145, 10474.214433917487, 10530.262881598368, 13419.463221471227, 13434.798478022838, 13441.596752097452, 13449.125806822525, 13459.528916487876, 7898.881516777253, 8060.717874874351, 8088.231617996281, 8208.056073551617, 8247.134050924686, 7893.289603935674, 8109.918900810916, 8164.224398682116, 8183.140770219041, 8643.481391116553, 6375.330590288046, 6382.6170429774365, 6392.137061496732, 6433.844662038269, 6494.64279464634, 1797.478731167973, 1797.4877160009596, 1803.5671438854843, 1809.5928416106533, 1839.6044850357237, 927.5408672706918, 963.3738070254391, 983.8783786483415, 1032.9431881246453, 1042.5100202904623, 18605.348812791486, 19565.51086222856, 19863.5102367323, 19957.0, 20010.799892001185, 965.3918031640022, 1001.5843424978698, 1029.2280789407944, 1046.7749433871602, 1061.946902654864, 10199.98000199974, 11152.944235278772, 11233.438328083726, 11371.601993930339, 11376.943115284535, 509821.0, 512534.0, 523823.0, 526716.0, 530507.0, 94418.0, 99337.0, 100995.0, 102372.0, 103712.48143759384, 1026.6201505442884, 1027.6403258859339, 1063.8776540697918, 1072.8337107748312, 1073.4954571351452, 16470.83529164693, 16633.584160396087, 16956.626072349634, 17463.214155362784, 18026.098695065455, 42085.78957105195, 42812.0, 42867.0, 43157.78421108, 43227.8386080701, 60706.39293607007, 61446.69276653767, 61522.384776151666, 61830.690846545476, 62138.37861621326, 8126.309263712651, 8261.710840120568, 8317.584120794058, 8481.067082620782, 8550.0, 12647.747045059232, 12849.357532123544, 12864.807027894401, 13044.739105217654, 13065.150765200611, 11145.49845256949, 11221.326720396803, 11470.226768157072, 11474.598389056342, 11617.0, 11204.887951120385, 11293.887061129284, 11456.885431145582, 11598.652040438801, 11823.11326650522, 11484.253523521278, 11729.413529323328, 11749.647510574696, 11813.70465738329, 11940.2835829847, 7277.490575659653, 7784.41616878725, 7947.728363461818, 8370.748877533684, 8772.736817895473, 9110.635574576943, 11164.385958772345, 11361.36856684723, 12132.454039568063, 12341.814872776737], "value": 9293.370421965828, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1251.8560365557964, 1334.8464926533447, 1412.73158099961, 1445.465177884183, 1741.0424266653338, 7584.9241507584975, 8359.414840961128, 8522.232999030086, 8692.782680432992, 8881.73354799357, 8724.563771811416, 8762.21140097391, 8781.56092195391, 8788.560571971391, 8792.69225577105, 2330.9394225627343, 2389.378761522008, 2391.35433432973, 2393.377721792338, 2394.0663141374876, 2285.5543169082034, 2354.9175778847743, 2359.7640235976437, 2360.693109895711, 2379.0721618568687, 2338.205010296499, 2344.179537161997, 2355.34050465869, 2372.478054827935, 2375.5367703297866, 2308.4805918668335, 2313.1672597864754, 2332.825038122139, 2333.428310064028, 2335.0426325206754, 2277.248507992375, 2280.1791355112146, 2287.5996700577334, 2295.185209250725, 2295.5064661097776, 8533.104024077444, 8592.398532102756, 8636.524991125485, 8679.088695686989, 8683.0, 5143.7685304161405, 5382.67703937765, 5383.892322153535, 5446.945530544684, 5448.155535891903, 3349.2296771742635, 3508.5438892944007, 3511.3679537683206, 3560.0, 3588.9641103588892, 1017.2574020964737, 1033.8862725100232, 1036.9896301036968, 1042.1142029275131, 1062.4156713807374, 10902.5093870776, 10975.28660637056, 11035.39305338206, 11038.668839934815, 11044.116470682326, 4280.957190428118, 4318.784060796947, 4446.866594002185, 4475.7985890634345, 4517.5482451755215, 8808.647654093764, 8831.735047948572, 8833.425827321204, 8837.072107428627, 8838.55807209637, 5075.923861142012, 5090.185570308733, 5107.770150343244, 5120.308758317654, 5123.436421993578, 4240.575942405735, 4376.584224498668, 4744.691595046311, 4774.665773395898, 4879.512048795092, 3704.407294832814, 3752.080740218664, 3854.9807250964127, 3870.670992965573, 3887.436321733333, 1107.617871834216, 1126.318577260762, 1134.359087115777, 1138.1293310617384, 1142.2575326037975, 793.9603019848985, 913.59345091435, 931.3247895275871, 934.5327336331834, 959.1799011844912, 5613.270274864241, 5617.168371021169, 5793.536517078624, 5814.418558144152, 5876.44173803488, 428.2997299415478, 432.3514727908138, 433.55127443096245, 439.0910814613719, 467.6562726396096, 3544.9645503544634, 3572.339117263263, 3617.8552857885916, 3627.2020155565733, 3662.487251784752, 10516.68449946503, 10747.516361763739, 10891.0742586881, 10899.618513351994, 10926.159198608419, 10243.180545556337, 10731.0, 10778.245522813328, 10796.51415686296, 10802.243842931077, 8026.357891368676, 8204.630791614272, 8214.178582141858, 8229.094799572042, 8230.670773169126, 5627.155926611041, 5629.4652008059165, 5681.829545113653, 5687.5734319927, 5773.24947756789, 9040.773980650536, 9221.123993220634, 9260.907390926273, 9264.11990860867, 9305.348625596143, 9135.771605709644, 9256.629734810533, 9365.578548965177, 9379.155875971195, 9408.153266206074, 7799.298063174341, 7806.375489960676, 7834.882476762739, 7886.171951944963, 7894.763157105296, 8373.204545568162, 8422.199891010345, 8437.831243374976, 8440.620172092393, 8491.617877195664, 7482.0, 7545.622718863925, 7563.281488258606, 7646.694132234648, 7798.883016754867, 7286.793810723265, 7419.29516695913, 7451.40388768908, 7465.0, 7640.044994375703, 6831.45348372139, 6868.347506986828, 6938.23679395256, 6950.443964482931, 6966.0, 4994.875128121826, 5037.70030629938, 5075.87310317245, 5133.743312834418, 5252.65857719247, 5041.621878359211, 5046.1926091825135, 5078.593712503065, 5105.412877519133, 5253.290805741176], "value": 4394.0908651063055, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.95814544109277, 332.8168361474956, 334.58511445807204, 340.9318136372726, 341.3855060890397, 5175.482451754822, 5298.576113910887, 5299.735013249341, 5364.490373414525, 5368.060589396855, 5143.81996630118, 5208.791648334071, 5229.712365819878, 5249.448807875176, 5270.367555893288, 4129.834806607747, 4142.502899652046, 4185.0, 4195.265828480019, 4199.391088292188, 3955.4857868477056, 4131.400946862703, 4163.104932439525, 4194.2450358935375, 4202.348635961431, 4130.834766609332, 4138.5654506276705, 4146.4402305688645, 4150.3359462486005, 4156.210320039198, 4145.647619952323, 4149.958500414988, 4159.7920103994675, 4169.332906734908, 4191.287481128215, 3675.889723308305, 3685.3182161300247, 3687.1519550503267, 3688.0595448160816, 3698.7041036716996, 5050.97014075582, 5150.819721309736, 5153.407358153823, 5180.792768289264, 5223.425423203445, 4670.182718024366, 4704.45898721648, 4704.835330763407, 4708.529147085298, 4716.858494245178, 5490.286262785852, 5492.47821456961, 5504.0, 5512.173174023888, 5577.406505974701, 3759.6240375962457, 3937.2912875682364, 3943.191645712622, 3952.288588054149, 3953.6639385652256, 5675.886482270373, 5699.601027928046, 5703.144528320744, 5703.857403564903, 5711.257536520267, 4061.593840615915, 4071.796410179479, 4100.282450571138, 4106.425100485934, 4110.650594699424, 4031.677465802729, 4146.854860079883, 4191.476065491814, 4221.176870510221, 4225.070484493406, 4722.126406614787, 4725.298892398734, 4726.456457507362, 4752.928706069411, 4773.546513081252, 5470.863228419322, 5543.223948647193, 5552.555795536347, 5618.775248989995, 5652.9152062719095, 1341.2489006156584, 1369.3564024908278, 1435.806166167554, 1465.9780103298458, 1467.7358075546504, 940.9931373430363, 951.4909523404945, 963.0513943765385, 965.5510187762584, 971.062924278075, 4690.601298889633, 4693.413323334583, 4715.622750179978, 4732.627538014006, 4733.739644319527, 4937.888974980672, 4937.975310123426, 4950.925736113961, 4958.479359667183, 4989.226669866104, 4568.451785785727, 4717.764111794397, 4719.0, 4735.384400027974, 4742.66801323904, 2636.8022398320204, 2640.920772376832, 2642.4186678930605, 2655.8406495610325, 2656.667916510436, 5029.189491782955, 5040.0, 5103.77033033507, 5145.761593706675, 5200.531952124327, 4713.316569097462, 5034.421041580192, 5064.848054558295, 5090.9236361454605, 5126.667366348377, 5075.720835354091, 5078.873028174326, 5087.796488140507, 5102.158143906214, 5102.285440306806, 4918.581920536794, 4941.492844682262, 4982.252662100569, 4989.101961646938, 5012.573931215742, 4740.440162312313, 4901.750053736275, 4968.776405061709, 5198.608640025631, 5619.915701264403, 5789.568381279788, 5807.303123625023, 5812.505936995402, 5815.214945982408, 5824.563157763269, 4033.475648165837, 4091.1408604193452, 4095.0581366285323, 4106.979465102655, 4110.979445102756, 5382.381026182039, 5449.3188351456065, 5658.745356458887, 5755.280589926259, 5802.448767367094, 5341.783159988561, 5386.811461598825, 5488.945110548843, 5538.861528461821, 5550.916736248879, 5538.861528461821, 5544.445555444423, 5545.197810711455, 5552.666839989613, 5574.637648552831, 5297.205419186998, 5411.594130440154, 5446.183072539151, 5448.918266225931, 5482.671039737628, 5569.526590239875, 5572.219889215432, 5597.244372009726, 5624.690642014729, 5629.605927585194, 5382.327209098863, 5447.564194864322, 5455.372632147195, 5457.345118585795, 5487.725613719378], "value": 4102.495356563118, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.9397363276854, 647.4076220258464, 662.4005275225919, 684.5789839248862, 735.1692587376264, 14448.0, 14669.486567970123, 15030.398784048624, 15343.38626454942, 15359.0, 13439.26084065376, 13744.17534947904, 13746.862531374683, 13750.793738093937, 13836.584902452918, 657.7533424965637, 772.7449941519285, 794.0233512779284, 796.024869534821, 796.044746304434, 668.8361351468873, 765.4603504529322, 788.2432864450107, 795.8129839487744, 796.0089688337998, 832.1678321678322, 832.8500869843426, 834.6202477872583, 834.6869923778584, 835.031363618203, 623.5105442227874, 827.0365024746163, 827.1604321613537, 827.5117680568463, 828.0, 466.552109974425, 582.9941700583024, 599.409581562161, 602.325395556979, 602.9608075475124, 13339.333033348294, 13370.130941488773, 13379.130356526795, 13381.598552043357, 13387.397567109503, 12651.873481265162, 13007.739845203138, 13224.27266500342, 13510.0, 13672.453101875913, 12661.936690316581, 12857.935710321388, 12870.099093063489, 12941.288229147392, 13019.674508137372, 4307.1601037797645, 4361.105973275503, 4373.497047839507, 4378.0, 4387.100644367929, 83955.5802220991, 84868.15131848665, 85635.57182214111, 87336.12663873343, 88427.0, 10960.780784384267, 11080.778384432428, 11123.555057797597, 11146.331220126818, 11334.149938754626, 20650.896745516176, 20764.792352076285, 20784.272550460963, 20875.58248835045, 23115.53768924612, 7446.702131914771, 7469.1037075551285, 7542.660580273791, 7543.849123017509, 7813.335866451415, 3877.8061096945603, 3920.294347017564, 3926.705497087673, 4095.508538975342, 4180.435641188462, 3329.667033296651, 3448.1724386147143, 3451.861925523001, 3453.1194545391268, 3453.637368076366, 569.0440060698068, 575.3239943066964, 579.5913880714087, 579.7651950959868, 581.682982774389, 508.336620709977, 548.9039418101817, 614.744880874441, 620.2433031701318, 621.8911690454153, 8256.0, 8503.787405314793, 8675.913240867636, 8920.643174272956, 9319.347645664739, 494.5647829909656, 546.1998172677047, 581.8748968971606, 595.9940400595939, 618.1006635345651, 3533.8056406897354, 3807.676347510437, 3920.1179734559496, 3938.369860822255, 3973.6821054315587, 71103.0, 71205.0, 72210.2778972214, 109390.90609093808, 125110.0, 107267.46366268274, 108184.0, 109789.0, 110343.44828275808, 111176.44411778051, 95380.52309738546, 97712.0, 97882.51058744661, 99428.0, 100104.0, 6948.861022779415, 7326.780196594111, 7360.116785985716, 7407.518511296748, 7670.348020418104, 55136.55656486323, 55851.0, 56451.0, 56628.0, 58396.70801645965, 75407.24592754002, 76369.61815190889, 81693.0, 84487.57756211425, 84946.0, 10052.195824334181, 10204.540795664361, 10330.48347582633, 10422.635207767691, 10425.582976680847, 10570.418626975283, 10827.24209305341, 10902.509387077442, 11207.943960280147, 11254.0, 10338.689839304832, 10397.688069357931, 10494.160467162455, 10585.206109541661, 10993.065589424989, 10443.94778026105, 10617.89382106169, 10682.359058456517, 10933.453327333442, 10992.527752992317, 10353.0, 10642.0, 10699.839502407625, 10765.515551800032, 10847.40339281347, 9143.0, 9334.626614935598, 9361.297902657465, 9452.338336316392, 9822.410655360702, 8499.150084991452, 8744.91255087441, 8762.430442021248, 8793.824123517366, 8901.0], "value": 6882.6284327275325, "unit": "score"}], "name": "dromaeo_css", "value": 6939.83923887983, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 110.0, 109.0, 111.0, 111.0, 111.0, 110.0, 110.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 122.0, 166.0, 122.0, 119.0, 118.0, 119.0, 149.0, 118.0], "value": 130.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 163.0, 161.0, 163.0, 161.0, 163.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 111.0, 75.0, 76.0, 76.0, 75.0, 112.0, 76.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 120.0, 83.0, 82.0, 81.0, 102.0, 81.0, 83.0, 112.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 145.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 50.0, 52.0, 53.0, 53.0, 52.0, 51.0, 52.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 61.0, 60.0, 60.0, 61.0, 60.0, 61.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 81.0, 82.0, 84.0, 79.0, 87.0, 79.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 133.0, 131.0, 127.0, 131.0, 123.0, 136.0, 132.0, 158.0, 134.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 166.0, 159.0, 158.0, 161.0, 164.0, 160.0, 161.0, 159.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 64.0, 66.0, 64.0, 63.0, 65.0, 63.0, 64.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1487.3000000000002, "alertThreshold": 2.0}]} 10:40:52 INFO - Return code: 0 10:40:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:40:52 INFO - # TBPL SUCCESS # 10:40:52 INFO - Running post-action listener: _resource_record_post_action 10:40:52 INFO - [mozharness: 2016-09-24 17:40:52.511418Z] Finished run-tests step (success) 10:40:52 INFO - Running post-run listener: _resource_record_post_run 10:40:52 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7827456; Write bytes: 430264320; Read time: 1804; Write time: 462648 10:40:52 INFO - TinderboxPrint: CPU usage
13.1% 10:40:52 INFO - TinderboxPrint: I/O read bytes / time
7,827,456 / 1,804 10:40:52 INFO - TinderboxPrint: I/O write bytes / time
430,264,320 / 462,648 10:40:52 INFO - TinderboxPrint: CPU idle
8,323.4 (86.9%) 10:40:52 INFO - TinderboxPrint: CPU user
1,195.0 (12.5%) 10:40:52 INFO - TinderboxPrint: Swap in / out
0 / 0 10:40:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 2658304; Read time: 0; Write time: 236 10:40:52 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 5611520; Write bytes: 427606016; Read time: 1624; Write time: 462412 10:40:53 INFO - Running post-run listener: _upload_blobber_files 10:40:53 INFO - Blob upload gear active. 10:40:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:40:53 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 10:40:53 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:40:53 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:40:53 INFO - (blobuploader) - INFO - Open directory for files ... 10:40:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:40:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:40:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:54 INFO - (blobuploader) - INFO - Done attempting. 10:40:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:40:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:40:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:58 INFO - (blobuploader) - INFO - Done attempting. 10:40:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:40:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:40:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:59 INFO - (blobuploader) - INFO - Done attempting. 10:40:59 INFO - (blobuploader) - INFO - Iteration through files over. 10:40:59 INFO - Return code: 0 10:40:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:40:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:40:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23875811a2c0c5c7e29b0ebbf04543cbe50adf2f8b2220a6bbb9c9fd9c052e2e4e89e931b7e100daf6acf174ab5de567942487452b5c796e0735c12ea2e4d395", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fa359a18774fadab7025123c194d3785c246af679721e25b69c39e5e5e0585736a772f55035e8a5b1bb8e8ed4164a2ef3397631aadac8817083a6f7bd3918a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e46f6225150e0813ecdd3ca5f427936995358180807a93e51cb5ec2edea00791980628d35a804056b9a60bb709e8e89e33f9df080dbb8be072d48e69a5549b2c"} 10:40:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:40:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:40:59 INFO - Contents: 10:40:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23875811a2c0c5c7e29b0ebbf04543cbe50adf2f8b2220a6bbb9c9fd9c052e2e4e89e931b7e100daf6acf174ab5de567942487452b5c796e0735c12ea2e4d395", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fa359a18774fadab7025123c194d3785c246af679721e25b69c39e5e5e0585736a772f55035e8a5b1bb8e8ed4164a2ef3397631aadac8817083a6f7bd3918a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e46f6225150e0813ecdd3ca5f427936995358180807a93e51cb5ec2edea00791980628d35a804056b9a60bb709e8e89e33f9df080dbb8be072d48e69a5549b2c"} 10:40:59 INFO - Running post-run listener: copy_logs_to_upload_dir 10:40:59 INFO - Copying logs to upload dir... 10:40:59 INFO - mkdir: /builds/slave/test/build/upload/logs 10:40:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.253027 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-09-24 10:40:59.243593) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-24 10:40:59.247264) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430 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/sha512/23875811a2c0c5c7e29b0ebbf04543cbe50adf2f8b2220a6bbb9c9fd9c052e2e4e89e931b7e100daf6acf174ab5de567942487452b5c796e0735c12ea2e4d395", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fa359a18774fadab7025123c194d3785c246af679721e25b69c39e5e5e0585736a772f55035e8a5b1bb8e8ed4164a2ef3397631aadac8817083a6f7bd3918a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e46f6225150e0813ecdd3ca5f427936995358180807a93e51cb5ec2edea00791980628d35a804056b9a60bb709e8e89e33f9df080dbb8be072d48e69a5549b2c"} build_url:https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/c7YqHj5ATMG9Cer37yIn7A/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/sha512/23875811a2c0c5c7e29b0ebbf04543cbe50adf2f8b2220a6bbb9c9fd9c052e2e4e89e931b7e100daf6acf174ab5de567942487452b5c796e0735c12ea2e4d395", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fa359a18774fadab7025123c194d3785c246af679721e25b69c39e5e5e0585736a772f55035e8a5b1bb8e8ed4164a2ef3397631aadac8817083a6f7bd3918a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e46f6225150e0813ecdd3ca5f427936995358180807a93e51cb5ec2edea00791980628d35a804056b9a60bb709e8e89e33f9df080dbb8be072d48e69a5549b2c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-24 10:40:59.276042) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 10:40:59.276471) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1474737605.358535-196241430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004378 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-24 10:40:59.331948) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-24 10:40:59.332300) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-24 10:40:59.334474) ========= ========= Total master_lag: 0.15 =========