builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1478647551.83 results: success (0) buildid: 20161108004019 builduid: 52edba3f2edf42b982700439d36cefdb revision: d9cfe58247e85c05ad98a4e60045bbdd62e0ec2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 15:25:51.830006) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 15:25:51.830503) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 15:25:51.830818) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 15:25:51.845588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 15:25:51.845993) ========= 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=bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-08 15:25:52-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-11-08 15:25:52 (42.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088603 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 15:25:51.948552) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 15:25:51.948879) ========= 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=bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016324 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 15:25:51.998176) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 15:25:51.998541) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d9cfe58247e85c05ad98a4e60045bbdd62e0ec2b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d9cfe58247e85c05ad98a4e60045bbdd62e0ec2b --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=bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-08 15:25:52,663 truncating revision to first 12 chars 2016-11-08 15:25:52,663 Setting DEBUG logging. 2016-11-08 15:25:52,663 attempt 1/10 2016-11-08 15:25:52,663 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d9cfe58247e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-08 15:25:52,989 unpacking tar archive at: mozilla-aurora-d9cfe58247e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660290 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 15:25:52.672921) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 15:25:52.673335) ========= script_repo_revision: d9cfe58247e85c05ad98a4e60045bbdd62e0ec2b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 15:25:52.673751) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 15:25:52.674180) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 15:25:52.684057) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-11-08 15:25:52.684511) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:25:53 INFO - MultiFileLogger online at 20161108 15:25:53 in /builds/slave/test 15:25:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:25:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:25:53 INFO - {'append_to_log': False, 15:25:53 INFO - 'base_work_dir': '/builds/slave/test', 15:25:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:25:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:25:53 INFO - 'branch': 'Mozilla-Aurora', 15:25:53 INFO - 'buildbot_json_path': 'buildprops.json', 15:25:53 INFO - 'config_files': ('talos/linux_config.py',), 15:25:53 INFO - 'default_actions': ('clobber', 15:25:53 INFO - 'read-buildbot-config', 15:25:53 INFO - 'download-and-extract', 15:25:53 INFO - 'populate-webroot', 15:25:53 INFO - 'create-virtualenv', 15:25:53 INFO - 'install', 15:25:53 INFO - 'run-tests'), 15:25:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:25:53 INFO - 'download_minidump_stackwalk': True, 15:25:53 INFO - 'download_symbols': 'ondemand', 15:25:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:25:53 INFO - 'tooltool.py': '/tools/tooltool.py', 15:25:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:25:53 INFO - '/tools/misc-python/virtualenv.py')}, 15:25:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:25:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:25:53 INFO - 'installer_path': 'installer.exe', 15:25:53 INFO - 'log_level': 'info', 15:25:53 INFO - 'log_name': 'talos', 15:25:53 INFO - 'log_to_console': True, 15:25:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:25:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:25:53 INFO - 'opt_config_files': (), 15:25:53 INFO - 'pip_index': False, 15:25:53 INFO - 'sps_profile': False, 15:25:53 INFO - 'sps_profile_interval': 0, 15:25:53 INFO - 'suite': 'dromaeojs', 15:25:53 INFO - 'system_bits': '32', 15:25:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:25:53 INFO - 'title': 'talos-linux64-ix-055', 15:25:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:25:53 INFO - 'use_talos_json': True, 15:25:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:25:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:25:53 INFO - 'work_dir': 'build'} 15:25:53 INFO - [mozharness: 2016-11-08 23:25:53.444391Z] Running clobber step. 15:25:53 INFO - Running pre-action listener: _resource_record_pre_action 15:25:53 INFO - Running main action method: clobber 15:25:53 INFO - rmtree: /builds/slave/test/build 15:25:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:25:53 INFO - Running post-action listener: _resource_record_post_action 15:25:53 INFO - [mozharness: 2016-11-08 23:25:53.921369Z] Finished clobber step (success) 15:25:53 INFO - [mozharness: 2016-11-08 23:25:53.921470Z] Running read-buildbot-config step. 15:25:53 INFO - Running pre-action listener: _resource_record_pre_action 15:25:53 INFO - Running main action method: read_buildbot_config 15:25:53 INFO - Using buildbot properties: 15:25:53 INFO - { 15:25:53 INFO - "project": "", 15:25:53 INFO - "product": "firefox", 15:25:53 INFO - "script_repo_revision": "production", 15:25:53 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:25:53 INFO - "repository": "", 15:25:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:25:53 INFO - "buildid": "20161108004019", 15:25:53 INFO - "stage_platform": "linux64-pgo", 15:25:53 INFO - "basedir": "/builds/slave/test", 15:25:53 INFO - "nightly_build": "True", 15:25:53 INFO - "buildnumber": 870, 15:25:53 INFO - "slavename": "talos-linux64-ix-055", 15:25:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:25:53 INFO - "platform": "ubuntu64_hw", 15:25:53 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:25:53 INFO - "branch": "mozilla-aurora", 15:25:53 INFO - "repo_path": "releases/mozilla-aurora", 15:25:53 INFO - "revision": "d9cfe58247e85c05ad98a4e60045bbdd62e0ec2b", 15:25:53 INFO - "pgo_build": "True", 15:25:53 INFO - "builduid": "52edba3f2edf42b982700439d36cefdb", 15:25:53 INFO - "slavebuilddir": "test" 15:25:53 INFO - } 15:25:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 15:25:53 INFO - Running post-action listener: _resource_record_post_action 15:25:53 INFO - [mozharness: 2016-11-08 23:25:53.924324Z] Finished read-buildbot-config step (success) 15:25:53 INFO - [mozharness: 2016-11-08 23:25:53.924411Z] Running download-and-extract step. 15:25:53 INFO - Running pre-action listener: _resource_record_pre_action 15:25:53 INFO - Running main action method: download_and_extract 15:25:53 INFO - mkdir: /builds/slave/test/build/tests 15:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:53 INFO - trying https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 15:25:53 INFO - Downloading https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 15:25:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:25:54 INFO - Downloaded 1361 bytes. 15:25:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 15:25:54 INFO - Using the following test package requirements: 15:25:54 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 15:25:54 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 15:25:54 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:25:54 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 15:25:54 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:25:54 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 15:25:54 INFO - u'jsshell-linux-x86_64.zip'], 15:25:54 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 15:25:54 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:25:54 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 15:25:54 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 15:25:54 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:25:54 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 15:25:54 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:25:54 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 15:25:54 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:25:54 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 15:25:54 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:25:54 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:25:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 15:25:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:25:54 INFO - Fetch https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:25:55 INFO - Expected file size: 21897469 15:25:59 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:25:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 15:25:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:25:59 INFO - Fetch https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:25:59 INFO - Expected file size: 21897469 15:26:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 15:26:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:26:04 INFO - Fetch https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 15:26:05 INFO - Expected file size: 14414089 15:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:05 INFO - trying https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 15:26:05 INFO - Downloading https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 15:26:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:26:06 INFO - Downloaded 63987061 bytes. 15:26:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 15:26:06 INFO - mkdir: /builds/slave/test/properties 15:26:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:26:06 INFO - Writing to file /builds/slave/test/properties/build_url 15:26:06 INFO - Contents: 15:26:06 INFO - build_url:https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 15:26:07 INFO - Running post-action listener: _resource_record_post_action 15:26:07 INFO - Running post-action listener: set_extra_try_arguments 15:26:07 INFO - [mozharness: 2016-11-08 23:26:07.422537Z] Finished download-and-extract step (success) 15:26:07 INFO - [mozharness: 2016-11-08 23:26:07.422766Z] Running populate-webroot step. 15:26:07 INFO - Running pre-action listener: _resource_record_pre_action 15:26:07 INFO - Running main action method: populate_webroot 15:26:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:26:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:26:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:26:07 INFO - '--tppagecycles', 15:26:07 INFO - '7'], 15:26:07 INFO - 'tests': ['tsvgm']}}, 15:26:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:26:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:26:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:26:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:26:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:26:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:26:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:07 INFO - 'talos_options': ['--disable-e10s'], 15:26:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:07 INFO - 'talos_options': ['--disable-e10s'], 15:26:07 INFO - 'tests': ['damp', 'tps']}, 15:26:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:07 INFO - 'tests': ['damp', 'tps']}, 15:26:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:26:07 INFO - 'tests': ['dromaeo_dom']}, 15:26:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:26:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:26:07 INFO - 'tests': ['basic_compositor_video']}, 15:26:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:26:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:26:07 INFO - 'tests': ['a11yr', 15:26:07 INFO - 'ts_paint', 15:26:07 INFO - 'tpaint', 15:26:07 INFO - 'sessionrestore', 15:26:07 INFO - 'sessionrestore_no_auto_restore', 15:26:07 INFO - 'tabpaint']}, 15:26:07 INFO - 'other-e10s': {'tests': ['a11yr', 15:26:07 INFO - 'ts_paint', 15:26:07 INFO - 'tpaint', 15:26:07 INFO - 'sessionrestore', 15:26:07 INFO - 'sessionrestore_no_auto_restore', 15:26:07 INFO - 'tabpaint']}, 15:26:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:26:07 INFO - 'ts_paint', 15:26:07 INFO - 'tpaint', 15:26:07 INFO - 'sessionrestore', 15:26:07 INFO - 'sessionrestore_no_auto_restore', 15:26:07 INFO - 'tabpaint']}, 15:26:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:26:07 INFO - 'ts_paint', 15:26:07 INFO - 'tpaint', 15:26:07 INFO - 'sessionrestore', 15:26:07 INFO - 'sessionrestore_no_auto_restore', 15:26:07 INFO - 'tabpaint']}, 15:26:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:26:07 INFO - 'tests': ['a11yr', 15:26:07 INFO - 'ts_paint', 15:26:07 INFO - 'tpaint', 15:26:07 INFO - 'sessionrestore', 15:26:07 INFO - 'sessionrestore_no_auto_restore', 15:26:07 INFO - 'tabpaint']}, 15:26:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:26:07 INFO - 'tests': ['a11yr', 15:26:07 INFO - 'ts_paint', 15:26:07 INFO - 'tpaint', 15:26:07 INFO - 'sessionrestore', 15:26:07 INFO - 'sessionrestore_no_auto_restore', 15:26:07 INFO - 'tabpaint']}, 15:26:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:26:07 INFO - 'tests': ['tsvgx', 15:26:07 INFO - 'tsvgr_opacity', 15:26:07 INFO - 'tart', 15:26:07 INFO - 'tscrollx', 15:26:07 INFO - 'cart']}, 15:26:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:26:07 INFO - 'tsvgr_opacity', 15:26:07 INFO - 'tart', 15:26:07 INFO - 'tscrollx', 15:26:07 INFO - 'cart']}, 15:26:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:07 INFO - 'talos_options': ['--disable-e10s'], 15:26:07 INFO - 'tests': ['tp5o']}, 15:26:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:07 INFO - 'tests': ['tp5o']}, 15:26:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:07 INFO - 'talos_options': ['--disable-e10s', 15:26:07 INFO - '--xperf_path', 15:26:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:07 INFO - 'tests': ['tp5n']}, 15:26:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:07 INFO - 'talos_options': ['--xperf_path', 15:26:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:07 INFO - 'tests': ['tp5n']}}, 15:26:07 INFO - 'talos.zip': {'path': '', 15:26:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:26:07 INFO - Running post-action listener: _resource_record_post_action 15:26:07 INFO - [mozharness: 2016-11-08 23:26:07.443018Z] Finished populate-webroot step (success) 15:26:07 INFO - [mozharness: 2016-11-08 23:26:07.443107Z] Running create-virtualenv step. 15:26:07 INFO - Running pre-action listener: _resource_record_pre_action 15:26:07 INFO - Running main action method: create_virtualenv 15:26:07 INFO - Creating virtualenv /builds/slave/test/build/venv 15:26:07 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 15:26:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:26:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:26:07 INFO - Using real prefix '/usr' 15:26:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:26:08 INFO - Installing distribute.............................................................................................................................................................................................done. 15:26:10 INFO - Installing pip.................done. 15:26:10 INFO - Return code: 0 15:26:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:26:10 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')]} 15:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:10 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')]} 15:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:10 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 0x7f6a52e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abaf60>, '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 0x1abbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', '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 15:26:10 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 15:26:10 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 15:26:10 INFO - Using env: {'DISPLAY': ':0', 15:26:10 INFO - 'HOME': '/home/cltbld', 15:26:10 INFO - 'LANG': 'en_US.UTF-8', 15:26:10 INFO - 'LANGUAGE': 'en_US:en', 15:26:10 INFO - 'LOGNAME': 'cltbld', 15:26:10 INFO - 'MAIL': '/var/mail/cltbld', 15:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:10 INFO - 'MOZ_NO_REMOTE': '1', 15:26:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:10 INFO - 'NO_EM_RESTART': '1', 15:26:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:10 INFO - 'PWD': '/builds/slave/test', 15:26:10 INFO - 'SHELL': '/bin/bash', 15:26:10 INFO - 'SHLVL': '1', 15:26:10 INFO - 'TERM': 'linux', 15:26:10 INFO - 'TMOUT': '86400', 15:26:10 INFO - 'USER': 'cltbld', 15:26:10 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', 15:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:10 INFO - '_': '/tools/buildbot/bin/python'} 15:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:10 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 15:26:10 INFO - Cleaning up... 15:26:10 INFO - Return code: 0 15:26:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:26:10 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')]} 15:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:10 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')]} 15:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:10 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 0x7f6a52e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abaf60>, '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 0x1abbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', '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 15:26:10 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 15:26:10 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 15:26:10 INFO - Using env: {'DISPLAY': ':0', 15:26:10 INFO - 'HOME': '/home/cltbld', 15:26:10 INFO - 'LANG': 'en_US.UTF-8', 15:26:10 INFO - 'LANGUAGE': 'en_US:en', 15:26:10 INFO - 'LOGNAME': 'cltbld', 15:26:10 INFO - 'MAIL': '/var/mail/cltbld', 15:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:10 INFO - 'MOZ_NO_REMOTE': '1', 15:26:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:10 INFO - 'NO_EM_RESTART': '1', 15:26:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:10 INFO - 'PWD': '/builds/slave/test', 15:26:10 INFO - 'SHELL': '/bin/bash', 15:26:10 INFO - 'SHLVL': '1', 15:26:10 INFO - 'TERM': 'linux', 15:26:10 INFO - 'TMOUT': '86400', 15:26:10 INFO - 'USER': 'cltbld', 15:26:10 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', 15:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:10 INFO - '_': '/tools/buildbot/bin/python'} 15:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:10 INFO - Downloading/unpacking psutil>=3.1.1 15:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:26:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:26:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:26:12 INFO - Installing collected packages: psutil 15:26:12 INFO - Running setup.py install for psutil 15:26:12 INFO - building 'psutil._psutil_linux' extension 15:26:12 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 15:26:12 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 15:26:12 INFO - building 'psutil._psutil_posix' extension 15:26:12 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 15:26:12 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 15:26:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:26:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:26:12 INFO - Successfully installed psutil 15:26:12 INFO - Cleaning up... 15:26:13 INFO - Return code: 0 15:26:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:26:13 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')]} 15:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:13 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')]} 15:26:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:13 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 0x7f6a52e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abaf60>, '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 0x1abbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', '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 15:26:13 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 15:26:13 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 15:26:13 INFO - Using env: {'DISPLAY': ':0', 15:26:13 INFO - 'HOME': '/home/cltbld', 15:26:13 INFO - 'LANG': 'en_US.UTF-8', 15:26:13 INFO - 'LANGUAGE': 'en_US:en', 15:26:13 INFO - 'LOGNAME': 'cltbld', 15:26:13 INFO - 'MAIL': '/var/mail/cltbld', 15:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:13 INFO - 'MOZ_NO_REMOTE': '1', 15:26:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:13 INFO - 'NO_EM_RESTART': '1', 15:26:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:13 INFO - 'PWD': '/builds/slave/test', 15:26:13 INFO - 'SHELL': '/bin/bash', 15:26:13 INFO - 'SHLVL': '1', 15:26:13 INFO - 'TERM': 'linux', 15:26:13 INFO - 'TMOUT': '86400', 15:26:13 INFO - 'USER': 'cltbld', 15:26:13 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', 15:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:13 INFO - '_': '/tools/buildbot/bin/python'} 15:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:26:13 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 15:26:13 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 15:26:13 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 15:26:13 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 15:26:13 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 15:26:13 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 15:26:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:26:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:26:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:26:15 INFO - Installing collected packages: mozsystemmonitor 15:26:15 INFO - Running setup.py install for mozsystemmonitor 15:26:15 INFO - Successfully installed mozsystemmonitor 15:26:15 INFO - Cleaning up... 15:26:15 INFO - Return code: 0 15:26:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:15 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 0x7f6a52e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abaf60>, '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 0x1abbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', '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 15:26:15 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 15:26:15 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 15:26:15 INFO - Using env: {'DISPLAY': ':0', 15:26:15 INFO - 'HOME': '/home/cltbld', 15:26:15 INFO - 'LANG': 'en_US.UTF-8', 15:26:15 INFO - 'LANGUAGE': 'en_US:en', 15:26:15 INFO - 'LOGNAME': 'cltbld', 15:26:15 INFO - 'MAIL': '/var/mail/cltbld', 15:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:15 INFO - 'MOZ_NO_REMOTE': '1', 15:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:15 INFO - 'NO_EM_RESTART': '1', 15:26:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:15 INFO - 'PWD': '/builds/slave/test', 15:26:15 INFO - 'SHELL': '/bin/bash', 15:26:15 INFO - 'SHLVL': '1', 15:26:15 INFO - 'TERM': 'linux', 15:26:15 INFO - 'TMOUT': '86400', 15:26:15 INFO - 'USER': 'cltbld', 15:26:15 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', 15:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:15 INFO - '_': '/tools/buildbot/bin/python'} 15:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:15 INFO - Downloading/unpacking jsonschema==2.5.1 15:26:15 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 15:26:15 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 15:26:15 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 15:26:15 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 15:26:15 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 15:26:15 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 15:26:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:26:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:26:17 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 15:26:17 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 15:26:17 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 15:26:17 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 15:26:17 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 15:26:17 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 15:26:17 INFO - Downloading functools32-3.2.3-2.tar.gz 15:26:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:26:17 INFO - warning: no files found matching '*.txt' 15:26:17 INFO - no previously-included directories found matching 'build' 15:26:17 INFO - no previously-included directories found matching 'dist' 15:26:17 INFO - no previously-included directories found matching '.git*' 15:26:17 INFO - Installing collected packages: jsonschema, functools32 15:26:17 INFO - Running setup.py install for functools32 15:26:17 INFO - warning: no files found matching '*.txt' 15:26:17 INFO - no previously-included directories found matching 'build' 15:26:17 INFO - no previously-included directories found matching 'dist' 15:26:17 INFO - no previously-included directories found matching '.git*' 15:26:17 INFO - Successfully installed jsonschema functools32 15:26:17 INFO - Cleaning up... 15:26:18 INFO - Return code: 0 15:26:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:26:18 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')]} 15:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:18 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')]} 15:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:18 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 0x7f6a52e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abaf60>, '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 0x1abbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', '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 15:26:18 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 15:26:18 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 15:26:18 INFO - Using env: {'DISPLAY': ':0', 15:26:18 INFO - 'HOME': '/home/cltbld', 15:26:18 INFO - 'LANG': 'en_US.UTF-8', 15:26:18 INFO - 'LANGUAGE': 'en_US:en', 15:26:18 INFO - 'LOGNAME': 'cltbld', 15:26:18 INFO - 'MAIL': '/var/mail/cltbld', 15:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:18 INFO - 'MOZ_NO_REMOTE': '1', 15:26:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:18 INFO - 'NO_EM_RESTART': '1', 15:26:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:18 INFO - 'PWD': '/builds/slave/test', 15:26:18 INFO - 'SHELL': '/bin/bash', 15:26:18 INFO - 'SHLVL': '1', 15:26:18 INFO - 'TERM': 'linux', 15:26:18 INFO - 'TMOUT': '86400', 15:26:18 INFO - 'USER': 'cltbld', 15:26:18 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', 15:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:18 INFO - '_': '/tools/buildbot/bin/python'} 15:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:26:18 INFO - Cleaning up... 15:26:18 INFO - Return code: 0 15:26:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:26:18 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')]} 15:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:18 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')]} 15:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:18 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 0x7f6a52e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abaf60>, '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 0x1abbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', '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 15:26:18 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 15:26:18 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 15:26:18 INFO - Using env: {'DISPLAY': ':0', 15:26:18 INFO - 'HOME': '/home/cltbld', 15:26:18 INFO - 'LANG': 'en_US.UTF-8', 15:26:18 INFO - 'LANGUAGE': 'en_US:en', 15:26:18 INFO - 'LOGNAME': 'cltbld', 15:26:18 INFO - 'MAIL': '/var/mail/cltbld', 15:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:18 INFO - 'MOZ_NO_REMOTE': '1', 15:26:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:18 INFO - 'NO_EM_RESTART': '1', 15:26:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:18 INFO - 'PWD': '/builds/slave/test', 15:26:18 INFO - 'SHELL': '/bin/bash', 15:26:18 INFO - 'SHLVL': '1', 15:26:18 INFO - 'TERM': 'linux', 15:26:18 INFO - 'TMOUT': '86400', 15:26:18 INFO - 'USER': 'cltbld', 15:26:18 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', 15:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:18 INFO - '_': '/tools/buildbot/bin/python'} 15:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:18 INFO - Downloading/unpacking blobuploader==1.2.4 15:26:18 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 15:26:18 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 15:26:18 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 15:26:18 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 15:26:18 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 15:26:18 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 15:26:20 INFO - Downloading blobuploader-1.2.4.tar.gz 15:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:26:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:26:20 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 15:26:20 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 15:26:20 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 15:26:20 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 15:26:20 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 15:26:20 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 15:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:26:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:26:20 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 15:26:20 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 15:26:20 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 15:26:20 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 15:26:20 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 15:26:20 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 15:26:21 INFO - Downloading docopt-0.6.1.tar.gz 15:26:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:26:21 INFO - Installing collected packages: blobuploader, requests, docopt 15:26:21 INFO - Running setup.py install for blobuploader 15:26:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:26:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:26:21 INFO - Running setup.py install for requests 15:26:21 INFO - Running setup.py install for docopt 15:26:21 INFO - Successfully installed blobuploader requests docopt 15:26:21 INFO - Cleaning up... 15:26:21 INFO - Return code: 0 15:26:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:26:21 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')]} 15:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:21 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')]} 15:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:21 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 0x7f6a52e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abaf60>, '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 0x1abbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', '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 15:26:21 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 15:26:21 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 15:26:21 INFO - Using env: {'DISPLAY': ':0', 15:26:21 INFO - 'HOME': '/home/cltbld', 15:26:21 INFO - 'LANG': 'en_US.UTF-8', 15:26:21 INFO - 'LANGUAGE': 'en_US:en', 15:26:21 INFO - 'LOGNAME': 'cltbld', 15:26:21 INFO - 'MAIL': '/var/mail/cltbld', 15:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:21 INFO - 'MOZ_NO_REMOTE': '1', 15:26:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:21 INFO - 'NO_EM_RESTART': '1', 15:26:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:21 INFO - 'PWD': '/builds/slave/test', 15:26:21 INFO - 'SHELL': '/bin/bash', 15:26:21 INFO - 'SHLVL': '1', 15:26:21 INFO - 'TERM': 'linux', 15:26:21 INFO - 'TMOUT': '86400', 15:26:21 INFO - 'USER': 'cltbld', 15:26:21 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', 15:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:21 INFO - '_': '/tools/buildbot/bin/python'} 15:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:26:21 INFO - Running setup.py (path:/tmp/pip-uMVam6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:26:22 INFO - Running setup.py (path:/tmp/pip-jr7HJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:26:22 INFO - Running setup.py (path:/tmp/pip-Y0QOU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:26:22 INFO - Running setup.py (path:/tmp/pip-h8eLKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:26:22 INFO - Running setup.py (path:/tmp/pip-ruEwyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:26:22 INFO - Running setup.py (path:/tmp/pip-_487Ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:26:22 INFO - Running setup.py (path:/tmp/pip-CXNOKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:26:22 INFO - Running setup.py (path:/tmp/pip-gF7Rb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:26:22 INFO - Running setup.py (path:/tmp/pip-lnLkef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:26:22 INFO - Running setup.py (path:/tmp/pip-wzspgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:26:22 INFO - Running setup.py (path:/tmp/pip-Vqljyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:26:22 INFO - Running setup.py (path:/tmp/pip-_kRR7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:26:22 INFO - Running setup.py (path:/tmp/pip-M411e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:26:22 INFO - Running setup.py (path:/tmp/pip-pXj5_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:26:23 INFO - Running setup.py (path:/tmp/pip-DEf6TA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:26:23 INFO - Running setup.py (path:/tmp/pip-RyvIEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:26:23 INFO - Running setup.py (path:/tmp/pip-IxoBaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:26:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:26:23 INFO - Running setup.py install for manifestparser 15:26:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:26:23 INFO - Running setup.py install for mozcrash 15:26:23 INFO - Running setup.py install for mozdebug 15:26:23 INFO - Running setup.py install for mozdevice 15:26:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:26:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:26:23 INFO - Running setup.py install for mozfile 15:26:23 INFO - Running setup.py install for mozhttpd 15:26:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:26:23 INFO - Running setup.py install for mozinfo 15:26:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:26:23 INFO - Running setup.py install for mozInstall 15:26:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:26:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:26:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:26:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:26:24 INFO - Running setup.py install for mozleak 15:26:24 INFO - Running setup.py install for mozlog 15:26:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:26:24 INFO - Running setup.py install for moznetwork 15:26:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:26:24 INFO - Running setup.py install for mozprocess 15:26:24 INFO - Running setup.py install for mozprofile 15:26:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:26:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:26:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:26:24 INFO - Running setup.py install for mozrunner 15:26:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:26:24 INFO - Running setup.py install for mozscreenshot 15:26:24 INFO - Running setup.py install for moztest 15:26:24 INFO - Running setup.py install for mozversion 15:26:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:26:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:26:24 INFO - Cleaning up... 15:26:25 INFO - Return code: 0 15:26:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:26: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')]} 15:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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')]} 15:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:25 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 0x7f6a52e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abaf60>, '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 0x1abbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', '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 15:26:25 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 15:26:25 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 15:26:25 INFO - Using env: {'DISPLAY': ':0', 15:26:25 INFO - 'HOME': '/home/cltbld', 15:26:25 INFO - 'LANG': 'en_US.UTF-8', 15:26:25 INFO - 'LANGUAGE': 'en_US:en', 15:26:25 INFO - 'LOGNAME': 'cltbld', 15:26:25 INFO - 'MAIL': '/var/mail/cltbld', 15:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:25 INFO - 'MOZ_NO_REMOTE': '1', 15:26:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:25 INFO - 'NO_EM_RESTART': '1', 15:26:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:25 INFO - 'PWD': '/builds/slave/test', 15:26:25 INFO - 'SHELL': '/bin/bash', 15:26:25 INFO - 'SHLVL': '1', 15:26:25 INFO - 'TERM': 'linux', 15:26:25 INFO - 'TMOUT': '86400', 15:26:25 INFO - 'USER': 'cltbld', 15:26:25 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', 15:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:25 INFO - '_': '/tools/buildbot/bin/python'} 15:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:26:25 INFO - Running setup.py (path:/tmp/pip-Vm5X8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:26:25 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)) 15:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:26:25 INFO - Running setup.py (path:/tmp/pip-yD5J6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:26:25 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)) 15:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:26:25 INFO - Running setup.py (path:/tmp/pip-aYm5od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:26:25 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)) 15:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:26:25 INFO - Running setup.py (path:/tmp/pip-0qJfwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:26:25 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)) 15:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:26:25 INFO - Running setup.py (path:/tmp/pip-V8acur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:26:25 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)) 15:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:26:25 INFO - Running setup.py (path:/tmp/pip-Vvx4h1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:26:25 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)) 15:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:26:25 INFO - Running setup.py (path:/tmp/pip-0_pjlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:26:25 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)) 15:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:26:25 INFO - Running setup.py (path:/tmp/pip-KkzNCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:26:25 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)) 15:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:26:25 INFO - Running setup.py (path:/tmp/pip-MPJB1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:26:25 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)) 15:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:26:25 INFO - Running setup.py (path:/tmp/pip-MCioCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:26:25 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)) 15:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:26:25 INFO - Running setup.py (path:/tmp/pip-EQLCdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:26:26 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)) 15:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:26:26 INFO - Running setup.py (path:/tmp/pip-9JPZ1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:26:26 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)) 15:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:26:26 INFO - Running setup.py (path:/tmp/pip-k3F7Bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:26:26 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)) 15:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:26:26 INFO - Running setup.py (path:/tmp/pip-6DC44n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:26:26 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)) 15:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:26:26 INFO - Running setup.py (path:/tmp/pip-sNcOi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:26:26 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)) 15:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:26:26 INFO - Running setup.py (path:/tmp/pip-eUYCsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:26:26 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)) 15:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:26:26 INFO - Running setup.py (path:/tmp/pip-IvGO1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:26:26 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)) 15:26:26 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)) 15:26:26 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)) 15:26:26 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)) 15:26:26 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)) 15:26:26 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)) 15:26:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:26:26 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 15:26:26 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 15:26:26 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 15:26:26 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 15:26:26 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 15:26:26 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 15:26:28 INFO - Downloading blessings-1.6.tar.gz 15:26:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:26:28 INFO - Installing collected packages: blessings 15:26:28 INFO - Running setup.py install for blessings 15:26:28 INFO - Successfully installed blessings 15:26:28 INFO - Cleaning up... 15:26:28 INFO - Return code: 0 15:26:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:26:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:26:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:26:28 INFO - Reading from file tmpfile_stdout 15:26:28 INFO - Current package versions: 15:26:28 INFO - argparse == 1.2.1 15:26:28 INFO - blessings == 1.6 15:26:28 INFO - blobuploader == 1.2.4 15:26:28 INFO - docopt == 0.6.1 15:26:28 INFO - functools32 == 3.2.3-2 15:26:28 INFO - jsonschema == 2.5.1 15:26:28 INFO - manifestparser == 1.1 15:26:28 INFO - mozInstall == 1.12 15:26:28 INFO - mozcrash == 0.17 15:26:28 INFO - mozdebug == 0.1 15:26:28 INFO - mozdevice == 0.48 15:26:28 INFO - mozfile == 1.2 15:26:28 INFO - mozhttpd == 0.7 15:26:28 INFO - mozinfo == 0.9 15:26:28 INFO - mozleak == 0.1 15:26:28 INFO - mozlog == 3.4 15:26:28 INFO - moznetwork == 0.27 15:26:28 INFO - mozprocess == 0.23 15:26:28 INFO - mozprofile == 0.28 15:26:28 INFO - mozrunner == 6.12 15:26:28 INFO - mozscreenshot == 0.1 15:26:28 INFO - mozsystemmonitor == 0.3 15:26:28 INFO - moztest == 0.7 15:26:28 INFO - mozversion == 1.4 15:26:28 INFO - psutil == 3.1.1 15:26:28 INFO - requests == 1.2.3 15:26:28 INFO - wsgiref == 0.1.2 15:26:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:28 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 0x7f6a52e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abaf60>, '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 0x1abbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', '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 15:26:28 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 15:26:28 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 15:26:28 INFO - Using env: {'DISPLAY': ':0', 15:26:28 INFO - 'HOME': '/home/cltbld', 15:26:28 INFO - 'LANG': 'en_US.UTF-8', 15:26:28 INFO - 'LANGUAGE': 'en_US:en', 15:26:28 INFO - 'LOGNAME': 'cltbld', 15:26:28 INFO - 'MAIL': '/var/mail/cltbld', 15:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:28 INFO - 'MOZ_NO_REMOTE': '1', 15:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:28 INFO - 'NO_EM_RESTART': '1', 15:26:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:28 INFO - 'PWD': '/builds/slave/test', 15:26:28 INFO - 'SHELL': '/bin/bash', 15:26:28 INFO - 'SHLVL': '1', 15:26:28 INFO - 'TERM': 'linux', 15:26:28 INFO - 'TMOUT': '86400', 15:26:28 INFO - 'USER': 'cltbld', 15:26:28 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', 15:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:28 INFO - '_': '/tools/buildbot/bin/python'} 15:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:29 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)) 15:26:29 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)) 15:26:29 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)) 15:26:29 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)) 15:26:29 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)) 15:26:29 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)) 15:26:29 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)) 15:26:29 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)) 15:26:29 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)) 15:26:29 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)) 15:26:29 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)) 15:26:29 INFO - Cleaning up... 15:26:29 INFO - Return code: 0 15:26:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:26: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')]} 15:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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')]} 15:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a52e28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abaf60>, '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 0x1abbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc1d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', '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 15:26:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:26:29 INFO - Using env: {'DISPLAY': ':0', 15:26:29 INFO - 'HOME': '/home/cltbld', 15:26:29 INFO - 'LANG': 'en_US.UTF-8', 15:26:29 INFO - 'LANGUAGE': 'en_US:en', 15:26:29 INFO - 'LOGNAME': 'cltbld', 15:26:29 INFO - 'MAIL': '/var/mail/cltbld', 15:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:29 INFO - 'MOZ_NO_REMOTE': '1', 15:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:29 INFO - 'NO_EM_RESTART': '1', 15:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:29 INFO - 'PWD': '/builds/slave/test', 15:26:29 INFO - 'SHELL': '/bin/bash', 15:26:29 INFO - 'SHLVL': '1', 15:26:29 INFO - 'TERM': 'linux', 15:26:29 INFO - 'TMOUT': '86400', 15:26:29 INFO - 'USER': 'cltbld', 15:26:29 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', 15:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:29 INFO - '_': '/tools/buildbot/bin/python'} 15:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:26:29 INFO - Cleaning up... 15:26:29 INFO - Return code: 0 15:26:29 INFO - Running post-action listener: _resource_record_post_action 15:26:29 INFO - Running post-action listener: _start_resource_monitoring 15:26:29 INFO - Starting resource monitoring. 15:26:29 INFO - [mozharness: 2016-11-08 23:26:29.382438Z] Finished create-virtualenv step (success) 15:26:29 INFO - [mozharness: 2016-11-08 23:26:29.382893Z] Running install step. 15:26:29 INFO - Running pre-action listener: _resource_record_pre_action 15:26:29 INFO - Running main action method: install 15:26:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:26:29 INFO - Reading from file tmpfile_stdout 15:26:29 INFO - Detecting whether we're running mozinstall >=1.0... 15:26:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:26:29 INFO - Reading from file tmpfile_stdout 15:26:29 INFO - Output received: 15:26:29 INFO - Usage: mozinstall [options] installer 15:26:29 INFO - Options: 15:26:29 INFO - -h, --help show this help message and exit 15:26:29 INFO - -d DEST, --destination=DEST 15:26:29 INFO - Directory to install application into. [default: 15:26:29 INFO - "/builds/slave/test"] 15:26:29 INFO - --app=APP Application being installed. [default: firefox] 15:26:29 INFO - mkdir: /builds/slave/test/build/application 15:26:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:26:45 INFO - Reading from file tmpfile_stdout 15:26:45 INFO - Output received: 15:26:45 INFO - /builds/slave/test/build/application/firefox/firefox 15:26:45 INFO - Running post-action listener: _resource_record_post_action 15:26:45 INFO - [mozharness: 2016-11-08 23:26:45.665386Z] Finished install step (success) 15:26:45 INFO - [mozharness: 2016-11-08 23:26:45.665785Z] Running run-tests step. 15:26:45 INFO - Running pre-action listener: _resource_record_pre_action 15:26:45 INFO - Running main action method: run_tests 15:26:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:26:45 INFO - Python 2.7.3 15:26:45 INFO - Return code: 0 15:26:45 INFO - grabbing minidump binary from tooltool 15:26:45 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')]} 15:26:45 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 0x1abaf60>, '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 0x1abbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:26:45 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 15:26:45 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 15:26:45 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 15:26:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:26:45 INFO - Return code: 0 15:26:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:26:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:26:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:26:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:26:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:26:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 15:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 15:26:45 INFO - Using env: {'DISPLAY': ':0', 15:26:45 INFO - 'HOME': '/home/cltbld', 15:26:45 INFO - 'LANG': 'en_US.UTF-8', 15:26:45 INFO - 'LANGUAGE': 'en_US:en', 15:26:45 INFO - 'LOGNAME': 'cltbld', 15:26:45 INFO - 'MAIL': '/var/mail/cltbld', 15:26:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:26:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:45 INFO - 'MOZ_NO_REMOTE': '1', 15:26:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:45 INFO - 'NO_EM_RESTART': '1', 15:26:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:45 INFO - 'PWD': '/builds/slave/test', 15:26:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:26:45 INFO - 'SHELL': '/bin/bash', 15:26:45 INFO - 'SHLVL': '1', 15:26:45 INFO - 'TERM': 'linux', 15:26:45 INFO - 'TMOUT': '86400', 15:26:45 INFO - 'USER': 'cltbld', 15:26:45 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498', 15:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:45 INFO - '_': '/tools/buildbot/bin/python'} 15:26:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 15:26:45 INFO - mozversion application_buildid: 20161108004019 15:26:45 INFO - mozversion application_changeset: d9cfe58247e85c05ad98a4e60045bbdd62e0ec2b 15:26:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:26:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:26:45 INFO - mozversion application_name: Firefox 15:26:45 INFO - mozversion application_remotingname: firefox-dev 15:26:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:26:45 INFO - mozversion application_vendor: Mozilla 15:26:45 INFO - mozversion application_version: 51.0a2 15:26:45 INFO - mozversion platform_buildid: 20161108004019 15:26:45 INFO - mozversion platform_changeset: d9cfe58247e85c05ad98a4e60045bbdd62e0ec2b 15:26:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:26:45 INFO - mozversion platform_version: 51.0a2 15:26:45 INFO - using testdate: 1478647605 15:26:45 INFO - actual date: 1478647605 15:26:45 INFO - starting webserver on 'localhost:54206' 15:26:45 INFO - SUITE-START | Running 2 tests 15:26:45 INFO - TEST-START | dromaeo_css 15:26:45 INFO - operating with platform_type : linux_ 15:26:45 INFO - Initialising browser for dromaeo_css test... 15:26:45 INFO - TEST-INFO | started process 18464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBcqRKR/profile http://localhost:54206/getInfo.html) 15:26:49 INFO - PROCESS | 18464 | __metrics Screen width/height:1600/1200 15:26:49 INFO - PROCESS | 18464 | colorDepth:24 15:26:49 INFO - PROCESS | 18464 | Browser inner width/height: 1024/697 15:26:49 INFO - PROCESS | 18464 | __metrics 15:26:50 INFO - PROCESS | 18464 | 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" 15:26:50 INFO - PROCESS | 18464 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:26:50 INFO - PROCESS | 18464 | console.error: PushService: 15:26:50 INFO - PROCESS | 18464 | stateChangeProcessEnqueue: Error transitioning state 15:26:50 INFO - PROCESS | 18464 | UnknownError 15:26:51 INFO - TEST-INFO | 18464: exit 0 15:26:51 INFO - Browser initialized. 15:26:51 INFO - Running cycle 1/1 for dromaeo_css test... 15:26:51 INFO - TEST-INFO | started process 18552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBcqRKR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:27:03 INFO - PROCESS | 18552 | RSS: Main: 144711680 15:27:03 INFO - PROCESS | 18552 | 15:27:54 INFO - PROCESS | 18552 | 1478647674399 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] 15:30:03 INFO - PROCESS | 18552 | Cycle 1(1): loaded http://localhost:54206/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54206/tests/dromaeo/cssquery-ext.html) 15:30:04 INFO - PROCESS | 18552 | RSS: Main: 274345984 15:30:04 INFO - PROCESS | 18552 | 15:33:07 INFO - PROCESS | 18552 | Cycle 1(1): loaded http://localhost:54206/tests/dromaeo/cssquery-ext.html (next: http://localhost:54206/tests/dromaeo/cssquery-jquery.html) 15:33:07 INFO - PROCESS | 18552 | RSS: Main: 241528832 15:33:07 INFO - PROCESS | 18552 | 15:36:09 INFO - PROCESS | 18552 | Cycle 1(1): loaded http://localhost:54206/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54206/tests/dromaeo/cssquery-mootools.html) 15:36:10 INFO - PROCESS | 18552 | RSS: Main: 175210496 15:36:10 INFO - PROCESS | 18552 | 15:39:12 INFO - PROCESS | 18552 | Cycle 1(1): loaded http://localhost:54206/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54206/tests/dromaeo/cssquery-prototype.html) 15:39:12 INFO - PROCESS | 18552 | RSS: Main: 202801152 15:39:12 INFO - PROCESS | 18552 | 15:42:15 INFO - PROCESS | 18552 | Cycle 1(1): loaded http://localhost:54206/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54206/tests/dromaeo/cssquery-yui.html) 15:42:16 INFO - PROCESS | 18552 | RSS: Main: 175423488 15:42:16 INFO - PROCESS | 18552 | 15:45:18 INFO - PROCESS | 18552 | Cycle 1(1): loaded http://localhost:54206/tests/dromaeo/cssquery-yui.html (next: http://localhost:54206/tests/dromaeo/cssquery-dojo.html) 15:45:18 INFO - PROCESS | 18552 | RSS: Main: 266403840 15:45:18 INFO - PROCESS | 18552 | 15:45:18 INFO - PROCESS | 18552 | __start_tp_report 15:45:18 INFO - PROCESS | 18552 | _x_x_mozilla_page_load 15:45:18 INFO - PROCESS | 18552 | _x_x_mozilla_page_load_details 15:45:18 INFO - PROCESS | 18552 | |i|pagename|runs| 15:45:18 INFO - PROCESS | 18552 | |0;dojo.html;3132.545780861775;3164.082416099331;3171.2230503526625;3182.904512864615;3205.9519107213396;5537.501624853762;5615.438456154383;5628.915566266509;5651.2935883014625;5657.745401456928;5511.283533140686;5575.526080283171;5577.414371490986;5581.804636837712;5602.1596760485845;5021.297018417425;5029.949700502984;5033.043721692885;5116.437191908887;5126.231065340192;5001.549860512553;5069.822556210534;5118.897622047557;5133.230015497668;5133.3326667533165;4996.100701873679;5025.447200807908;5046.873828154289;5095.668781529207;5117.360329958755;5097.3118628984985;5125.743712814345;5132.923006154911;5190.480951904779;5197.766100525486;5006.949930500685;5127.923081153748;5169.896602067975;5186.974065129688;5215.243789650517;5430.619856610039;5478.123500239943;5496.038193316153;5500.944990550083;5504.119340905476;5917.171595976567;5924.7926322578505;6008.399160084;6024.578279520435;6028.728707208186;6047.848803779897;6056.152138700585;6057.3336932937345;6064.151018857364;6068.999999999955;5378.919316210221;5418.051840927822;5479.123340265578;5580.776768929279;5584.385717571064;6170.043643235216;6179.84550386244;6180.505559555315;6183.3816618337805;6184.81445556634;5912.290525137011;5919.763209471573;5926.822195334147;5935.614185077956;5936.554758393051;5857.20927674767;5946.316173640001;5947.791827286024;5966.403359663999;6025.3974602540275;5857.502112320415;6007.339192688801;6009.06859436788;6017.037274036134;6018.7291571878495;5921.407859214044;5923.348431672513;5984.431479009487;6001.699915004232;6005.759769609167;4551.203539380595;4551.726896386227;4556.498785133633;4558.042811009659;4586.243269860435;3952.802359882052;3963.4847469828737;4050.5139383274195;4055.0673345130194;4073.0835561998315;5523.447655234444;5682.943170568324;5688.800891968761;5736.110902810071;5766.711664416763;6041.607295525777;6044.093385992049;6051.455369016721;6053.424924632153;6055.273367195965;5496.340439147248;5681.517071049007;5724.427557244242;5730.111832665943;5739.655620662774;4906.656534042583;4987.900241995139;5005.724685142352;5010.799568017312;5061.569766569809;6207;6211.254649442096;6223.96888015557;6237.157983672237;6243.406876346739;6041.516678665784;6070.423309785563;6075.1798507200965;6079.3008803988105;6082.118092876596;5987.13186587951;5989.101634754822;6121.234845644294;6156.26124865019;6214.471769899609;5916.911246331395;5953.077273022688;5972.5520585955355;5994.790182343597;6002.429769171922;6058;6065.120557519223;6068.029115341524;6069.2716873975405;6072.817815465543;5642.040853054908;5709.429057094258;5744.885102298014;5892.558058145571;5905;5766.250387449605;5833.912491312549;5837.0368889132815;5865.472107510344;5868;5750.568707346882;5770.163326317576;5772.105323674838;5781.739821708117;5783.768649254151;5656.406077361818;5666.801661941812;5854.356020837619;5857.033589457692;5862.179294898803;5652.68910209926;5676.886462270814;5707.885842283048;5716.114002329646;5800.6229595077875 15:45:18 INFO - PROCESS | 18552 | |1;ext.html;585.6661702829389;628.1237673445543;651.8794023105726;657.5331514624617;674.5312008154335;34964.65035349646;46674.76662616691;47892.04215915684;48052;48200.75899620497;50454.74772626132;50756.49243507564;50893.7276568086;50960.23559646599;51038;8681.088485709004;9509.476978766164;9672.661456849011;9676.467794271312;9678.080582344666;8480.194381533775;11197.216194866363;11454.71363215922;11469.713257168554;11764.058875289957;11631.302121872672;11680.12399070069;11698.649040528799;11708.53165873364;11709.063274937984;11466.885331146665;11502.769944601145;11539.076873850156;11555.826662600068;11560.942195289012;11105.55577776888;11164.441777911072;11186.720331991684;11194.216404851664;11198.944005280004;43457.348139777925;43469.78265108654;43560.3465948011;43571.346429803576;43966;3683.3001729671278;3823.8661646842506;3940.468036815022;4163.708540402173;4544.431946006749;35475.467867982;36169.81915090434;36337.27325453476;37002.62997370019;37460.25079498395;4105.692073094529;4155.044339801832;4161.313383291753;4180.7909604519655;4203.810828512725;382163;386254;387013;387718.06140969397;387859;66527.33472665308;66879;66959.66520167465;67011.66494167596;67057;41656.791716041225;42068.78965605152;42409.36385954213;44357.33463998043;44413.55586444159;19073.80926190748;19088.80911190898;19350;19381.612367752565;19419.4174174775;13367.131136476099;13590.93204533971;13616.38726257301;13942.093763905314;14076.085054471427;20478.18087276522;21015.57968840645;21121.521493495617;21196.470088247916;21276.36170914875;7389.748510655294;7503.474756767083;7525.962370188114;7580.9620951895995;7651.502652327581;1043.6242952537082;1087.7606926476162;1124.027716025632;1152.1819508149308;1198.9928460093563;33800.830995845354;34249;34299.82850085734;34443;34572;1177.7232350397649;1185.324365111878;1188.2276520261726;1230.8399908011902;1304.6477451088342;17330.913345433193;17493.30026798939;17724.556886077695;17756.20097095634;17867.1959761811;595530;609711;609918;613125;614078;63741.36258637354;64279;64372.356276437575;64375.35624643787;64385.67807161028;1345.4752646467884;1379.5516457151266;1392.366473254687;1451.883849292054;1489.4489039055618;30394.696053039188;36722;36932;37316;37446.625533745406;61756.38243617507;62769.68615156895;62852.371476286484;62917.37082629115;63012.36987630248;505733;508985;509446;510808;512241;26647;27007.45985080248;31494;32044.359112818078;32351;50469.495305047945;50747;50771.238431424295;50903.490965091354;51576;44117.33823992578;44563.77718111389;44958.55041449674;46470.070598588514;46524.53475465202;44621.55378446174;45302.773486132355;45398;45496;46876.7656161717;43908.560914391725;44830.77584612056;45098.323525146494;45281.09437811291;45338.546614533436;36483.27033459369;39136.217275653755;39525.2094958105;39832.949308755575;40290.597094028686;29095;29108.417831642826;29559.556606650487;29672.703272966995;29673.258168545097 15:45:18 INFO - PROCESS | 18552 | |2;jquery.html;422;431.8749657143142;434.8847555397819;437.96058354748084;441.6157942589947;18827.435176944695;20341.898290508565;20627.174913003462;20935.581288374222;21039.579208415824;19985.700214496796;20023.799762002374;20518.589628207428;20538.794612053876;20644.793552064475;5835.241418615585;6109.877802443971;6114.388561143895;6115.663638499881;6118.235220597426;5722.856928576798;5934;5958.851028724295;5961.135635332874;6023.909641355362;5917.142014407908;5929.644221346712;5929.733162007698;5930.318013428447;5931;5709.143628455723;5874.383189765077;5892.558058145656;5899.380565040652;5902.88194236115;5261.184516399964;5356.4107948125675;5362.222477740745;5367.543758780469;5373.677579345252;23720;24085.7591424087;24136;24324.027038918422;24414.145504907243;2728.9590656139976;2731.740484653955;3004.669486356499;3172.254520187754;3262.8531716072835;15287.617809554738;15306.005109667836;15324.233788310652;15443;16048.35806567736;1894.1855002348984;2046.7134601155851;2088.4256829371893;2112.5669237806214;2161.91352345906;63569.36430635727;68674.65673145534;69637;81958;87818.5609071957;11375.521182246255;11615.245009074382;11664.475098620413;11833.467493962793;11993.940030299967;16775.2451139699;16784.664306714043;16794.496165115066;16804.57988550296;16805.24376403065;8683.348748843862;8753.912460875437;8797.780055498664;8808.955955220183;8827.16141966512;8303.875441868377;8335.499870007698;8339.666413343519;8513.148685131437;8537.786555336166;5087.949120508822;5128.794848206105;5144.6913185209005;5198.2722418861385;5250.448702886142;1961.2743284984647;1964.4499540128786;1998.1407994562478;2026.1490174126902;2030.46192758919;937.8218138553653;1005.8893521712606;1073.4257172412722;1095.4741723972538;1109.517359948425;18918.905405472884;20219.696704549442;20470.181192752123;20694.172233110807;20847.37457876266;1048.9003544663244;1060.4485667452882;1080.4631976541891;1108.5621179634;1130.3669944830922;10582.841257381146;11484.425778711031;11508.251963622506;11512.654620361403;11575.479103440366;165022;165475;165626.1718691399;167927;392802;92119.36492758724;92629;109107;110404;111353.65939021842;1041.1306559023149;1075.6074032977906;1077.5097330714507;1086.1039642295138;1090.6618948126106;18179.909100454413;18300.72548911794;18680.439586812416;18701.90649046746;19083.61832763365;44560.331595025455;44759.77620111879;44819.32771008372;45061;45066.77466612646;62268.68865655643;62884.94487764266;64733.35266647273;64994;65088;9107.544622768968;9265.258779297776;9438.575264112995;9462.195713364166;9465.621375144918;9793.559289832117;13396.665083372995;13568.52510162179;13661.726765464833;14064.578062658136;11298.039666628429;12034.398280086136;12108.091893107876;12369.381530923238;12481.126321157431;6004.42957918997;11361.261518001304;11416.600418985296;11627.360495172508;12175.939120304341;7792.986911701442;7844.725434609762;12090.637280881587;12528.248305101723;12619.621411357673;8094.31198348147;8190.099089100075;9288.628454862;12468.563600273947;13612.65968350799;11926.701832454259;12388.380580971096;12426.689332766753;12872.678183045498;12975 15:45:18 INFO - PROCESS | 18552 | |3;mootools.html;1387.9653008674788;1513.1828812441279;1567.0754254989556;1691.9915400422997;1807.3945228348502;8497.617607207674;9060.818783624323;9319.161275485205;9381.108794664504;9512.66705665302;9564.09141131593;9628.229741620671;9629.518524073803;9642.758931026729;9650.662226822064;2510.2469259222253;2535.7210706822234;2537.53055684698;2537.936551586207;2539.873006349684;2462.101333013446;2533.8353007054575;2537.835040722347;2543.0844895837577;2543.834650747705;2507.3104896153523;2515.157422263544;2548.7323830997757;2556.386467247856;2560.2063360358256;2474.158786012755;2485.9378515537164;2496.5755821510297;2506.0602274147195;2511.0458025950206;2417.9481925362347;2425.599776036952;2461.2247142150163;2464.051340234023;2468.5556599812026;9193.862092068624;9328.813423731555;9454.101860323328;9462.716118516455;9476.952615236949;5523.834284971457;5680.261565996394;5680.630759000652;5681.147827825859;5683.005474042026;3648.2885837261742;3658.396364599838;3711.832967516468;3714.0900479382453;3736.271427071722;1207.4506099724604;1251.555697727303;1272.243015405832;1299.961001169957;1302.3358087375507;12852.871471285262;13074;13117.278549679764;13131.803022954664;13139.60581182566;4762.97596016858;4796.928046079312;4815.614750819926;4903;4948.826791062295;10413.687589372332;10419.895801042045;10422.21833362501;10426.895731042592;10439.791204175874;5670.234518339971;5676.403977582377;5682.801101961411;5684.573656975661;5687.090065589486;4470.473401659346;4682.1103990241745;4758.738269395217;5176.482351764868;5287.07476191665;4031.475908131924;4095.2423801596206;4125.360569111733;4131.029208136086;4220.957790422057;1183.928964262147;1214.9392530373445;1222.266640016001;1222.8471441069867;1233.7224124572078;857.5883575883611;921.3412410126791;922.0272612393854;950.4439902656885;1026.338011982282;6192.783252586228;6306.180196574508;6358.23701155855;6394.23269207698;6405.231372235362;977.0620204603518;1034.7413146713322;1079.1205167788228;1084.1218612923558;1107.5293000474767;4092;4197.411213412488;4238.576142385798;4239.788010599457;4389.736615803062;12113.636590902288;12429.875701243052;12462.31457269859;12475.064370172273;12478;12309.446074926649;12334.691632709255;12360.196587221983;12510.812337814757;12515.311657858723;8570.271526920282;8946.731598051938;8950.14973577509;9010.63957441695;9181.632734690538;6592.604443733391;6633.436157926631;6655.900161497679;6732.293109223461;6904;10937.234393592373;11405.771884562097;11455.713607159887;11478.540858365572;11631.59289424866;10266.178705703674;10584.89415105839;11597.6520704379;11630.302181869114;11636.53453861836;8426.873596895928;8694.04365519805;8703.651853925772;8806.163414475615;8915.331350148894;8843.380963332505;9005.774855628662;9161.816763664556;9163.266938645025;9176.220021298264;7834.238376471494;7917.208279172037;8002.159773223728;8137.6338064788415;8459.915400845914;7827.804304892423;8077.7576672699915;8289.709860155106;8305.958470207852;8351.791205219919;7329.230430804689;7338.156112047183;7429.108506979197;7430.3684186842565;7435.442341824493;5435.9280246545695;5595.440455954372;5599.04816181242;5685.374608792947;5686.2607860977805;5360.973195133999;5497.47773961473;5573.303337082864;5789.884202316014;5818.418158184148 15:45:18 INFO - PROCESS | 18552 | |4;prototype.html;347.24127780798955;352.24267824178014;356.15413393191164;356.6273244459543;357.33892299246395;5270.183121616146;5374.973125134378;5433.48381903719;5475.890482190353;5481.342238931329;5225.634205605609;5321.753730224569;5338.359396872371;5356.464353564642;5402.91895621565;4227.936580951288;4268.935965960513;4269.466316710411;4289.099289149282;4313.568643135693;4176;4256.616294874864;4261.76560289184;4295.1839150561445;4298.785060746965;4221.641160501361;4221.831126754926;4230.392450868666;4230.640395566381;4235.174141042498;4199.664026877843;4215.45199124115;4218.367244913272;4228.936565951513;4276.465441819772;3591.892243232707;3693.9445908311395;3699.519062521882;3713.702903767719;3841.980790096032;5287.339082614673;5288.391834938954;5295.384907603179;5295.708736019517;5340.839774806762;4784.497627749106;4821.68659037165;4822.879428014293;4844.4186697596515;4885.633577481668;5422.810201642924;5605.915911261334;5617.376791969198;5628.605997580171;5657.2928383952;4024.7786371749544;4035.414864844581;4036.1725846201753;4048.6153815387493;4052.837886484537;5853.385394533598;5891.882162356772;5901.7934372297195;5908.143319218732;5930.495907847838;4087.795610219477;4181.310083836133;4186.895327616834;4193.559676234013;4203.138356636882;4225.239456897726;4229.323308270662;4229.6404805591255;4252.659787217015;4289.63538099265;4873.317735516959;4893.755312234374;4896.877578060506;4904.681195722338;4917.1149193144865;5622.582289615423;5687.289088863892;5711.143328500675;5735.770569177186;5775.653460792366;1356.9932150339184;1363.3796622536722;1433.1329545624956;1456.1190479759805;1459.511063793641;992.6972273456521;1008.2287050406445;1019.8164330420595;1021.9080282774586;1028.2956175020136;5459.918101228484;5461.306994831615;5469.480399362054;5489.231507588941;5490.341159060858;5719.513841323451;5787.479126878601;5792.710364481759;5794.536437085023;5857.941420585825;5218.086834803894;5422.8373148805595;5471.534919531805;5527.668339899619;5558.499735023867;2690.2870739254113;2716.9184924452297;2733.2097476153153;2744.986275068612;2753.026731130374;5164.25118357836;5221.668474538968;5224.686518808883;5230.372355317386;5282.815101471507;4972.707096155026;5050.747462626928;5149.45930677281;5217.530422262014;5235.267062611238;5120.92318615221;5226.9215961761365;5232.2674825524455;5256.658317209369;5265.420803711589;5104.310918026019;5122.282880396822;5129.384473863161;5152.27868098474;5185.407296351824;5426.914617076522;5781.710914454345;5802.750459742389;5802.796902108406;5816.9127463088935;6015.969920150371;6045.576809623284;6053.273607167168;6086.665233412028;6098.146259523759;4062.512498500199;4215.557366476476;4275.743455392686;4280.95719042818;4290.184864875664;5639.520640745583;5794.797182098607;5794.82615521535;5803.187553742564;5806.796762113475;5599.832005039855;5726.79956201531;5752.274317704756;5754.8849023018465;5775.364709881826;5690.089585666274;5692.800751973661;5694.743736531783;5767.798127065533;5817.534597232296;5523.944760552504;5535.861603459945;5615.522680572197;5624;5639.577031722555;5696;5716.342620598684;5740.712964351682;5742.28221472316;5751.424857514383;5427.4301198373605;5595.580331475075;5621.80323688669;5663.433656634304;5696.629719068247 15:45:18 INFO - PROCESS | 18552 | |5;yui.html;863.9956800215998;871.6818361298128;904.6019751309419;906.4787747045447;918.1461241045827;16534.338626454926;17824.821751782478;17851.73222401665;17884.64230715388;17913.193906274217;15993.520194394157;16130.516084517454;16151.273192706327;16166.272517736701;16187.35250589978;726.3789460011693;741.0255513999101;854.8247609240121;862.2455351567379;886.4858382138344;881.7398867334152;890.9821803563925;891.233539156325;891.6032365597312;893.499640201486;937.2595649436937;937.5780898595625;937.6202637931615;940.0787228516058;941.4398432932394;771.5794891783963;790.1150711203431;905.6739573753443;924.1359329027381;934.5747684803432;684.3327755438457;684.387473211473;684.650828077679;684.7740245718901;684.8219462939621;15655.92172039144;15712.292946817306;15727.292271847795;15729.37082516698;15746.212689365486;15622.687546249124;15759.054456732518;15917.602059948478;16055;16135;14079.436822527188;14237.359318830677;14252.501162459264;14466.421343146261;14812.777808332883;4557.361969324297;4582.931256031162;4584.7478388688605;4615.215413379734;4635.5364463553715;89149;90286.5485672574;90942;91485.54257228671;92045;11861.703457413634;12038.39808009596;12134;12310.446029928675;12418.75162496763;21096.47258818511;21292.787072129082;21618.351449456542;22138;22762.20332288362;9379.624815007459;9417.576209070608;9663.420194788336;9684.03159684026;9823.410595364301;4991.101601711727;5213.921791173136;5273.2617433559335;5285.947140528622;5370.9731451342495;3566.375884220251;3660.469231961404;3663.743537952371;3666.4683620875358;3671.6511931366476;599.7690889007677;615.5844804756771;615.6613862375675;618.1315252070758;625.8435391152212;568.8520984543966;686.9484788640872;711.0294448078336;711.5659447736876;717.9964100179466;9469.810603787886;9768.90231097694;9970.700878973497;10036.397816131055;10350.120239779702;601.6299975515115;627.6892937995722;669.223700507409;692.2834865913755;740.6704016712512;4552;4556.703814252063;4622.237330840374;4625.838095666635;4704.364910737075;108367;109392.4530377343;112411;119957.40021299837;135272;99036;105140;108211.45894270478;108248.45875770571;109175;91205;92561;93582.53208734049;94194;95711.52144239235;10377.792444150924;10401.843972340572;10411.583536658449;10543.472826358498;10569.365838049742;41777.582224178586;42588;55372.44627553673;56449.15326270191;56805;72197.6390118067;77732.61133694295;79849.6007519982;80903;82520.58739706263;13384.929205663719;13686.178829270275;13836.377363018488;14233.928830355782;14256.786148207993;15284;15325.846741532441;15461;15519.224038797789;15982.360705571647;14642.34109465098;14807.555773326818;15073.397064117313;15348;15682.529524114294;14400.639984000065;14437.422503099759;15176.620584485476;15354;15747.763783543027;14668;15285.388584456497;15719.135447550494;15738.9213053934;15824;12415.503379864704;12540.686482838002;12698.682532936751;12895.548655797002;13773.655658608615;12601.306928119042;12762;13002.130438453278;13049.869501304865;13249.337533123113 15:45:18 INFO - PROCESS | 18552 | __end_tp_report 15:45:18 INFO - PROCESS | 18552 | __start_cc_report 15:45:18 INFO - PROCESS | 18552 | _x_x_mozilla_cycle_collect,1052 15:45:18 INFO - PROCESS | 18552 | __end_cc_report 15:45:18 INFO - PROCESS | 18552 | __startTimestamp1478648718792__endTimestamp 15:45:18 INFO - PROCESS | 18552 | 15:45:18 INFO - PROCESS | 18552 | ------- Summary: start ------- 15:45:18 INFO - PROCESS | 18552 | Number of tests: 6 15:45:18 INFO - PROCESS | 18552 | 15:45:18 INFO - PROCESS | 18552 | [#0] dojo.html Cycles:165 Average:5550.03 Median:5744.89 stddev:651.35 (11.3%) stddev-sans-first:625.13 15:45:18 INFO - PROCESS | 18552 | Values: 3132.5 3164.1 3171.2 3182.9 3206.0 5537.5 5615.4 5628.9 5651.3 5657.7 5511.3 5575.5 5577.4 5581.8 5602.2 5021.3 5029.9 5033.0 5116.4 5126.2 5001.5 5069.8 5118.9 5133.2 5133.3 4996.1 5025.4 5046.9 5095.7 5117.4 5097.3 5125.7 5132.9 5190.5 5197.8 5006.9 5127.9 5169.9 5187.0 5215.2 5430.6 5478.1 5496.0 5500.9 5504.1 5917.2 5924.8 6008.4 6024.6 6028.7 6047.8 6056.2 6057.3 6064.2 6069.0 5378.9 5418.1 5479.1 5580.8 5584.4 6170.0 6179.8 6180.5 6183.4 6184.8 5912.3 5919.8 5926.8 5935.6 5936.6 5857.2 5946.3 5947.8 5966.4 6025.4 5857.5 6007.3 6009.1 6017.0 6018.7 5921.4 5923.3 5984.4 6001.7 6005.8 4551.2 4551.7 4556.5 4558.0 4586.2 3952.8 3963.5 4050.5 4055.1 4073.1 5523.4 5682.9 5688.8 5736.1 5766.7 6041.6 6044.1 6051.5 6053.4 6055.3 5496.3 5681.5 5724.4 5730.1 5739.7 4906.7 4987.9 5005.7 5010.8 5061.6 6207.0 6211.3 6224.0 6237.2 6243.4 6041.5 6070.4 6075.2 6079.3 6082.1 5987.1 5989.1 6121.2 6156.3 6214.5 5916.9 5953.1 5972.6 5994.8 6002.4 6058.0 6065.1 6068.0 6069.3 6072.8 5642.0 5709.4 5744.9 5892.6 5905.0 5766.3 5833.9 5837.0 5865.5 5868.0 5750.6 5770.2 5772.1 5781.7 5783.8 5656.4 5666.8 5854.4 5857.0 5862.2 5652.7 5676.9 5707.9 5716.1 5800.6 15:45:18 INFO - PROCESS | 18552 | 15:45:18 INFO - PROCESS | 18552 | [#1] ext.html Cycles:180 Average:67179.50 Median:39679.08 stddev:135290.13 (341.0%) stddev-sans-first:135577.27 15:45:18 INFO - PROCESS | 18552 | Values: 585.7 628.1 651.9 657.5 674.5 34964.7 46674.8 47892.0 48052.0 48200.8 50454.7 50756.5 50893.7 50960.2 51038.0 8681.1 9509.5 9672.7 9676.5 9678.1 8480.2 11197.2 11454.7 11469.7 11764.1 11631.3 11680.1 11698.6 11708.5 11709.1 11466.9 11502.8 11539.1 11555.8 11560.9 11105.6 11164.4 11186.7 11194.2 11198.9 43457.3 43469.8 43560.3 43571.3 43966.0 3683.3 3823.9 3940.5 4163.7 4544.4 35475.5 36169.8 36337.3 37002.6 37460.3 4105.7 4155.0 4161.3 4180.8 4203.8 382163.0 386254.0 387013.0 387718.1 387859.0 66527.3 66879.0 66959.7 67011.7 67057.0 41656.8 42068.8 42409.4 44357.3 44413.6 19073.8 19088.8 19350.0 19381.6 19419.4 13367.1 13590.9 13616.4 13942.1 14076.1 20478.2 21015.6 21121.5 21196.5 21276.4 7389.7 7503.5 7526.0 7581.0 7651.5 1043.6 1087.8 1124.0 1152.2 1199.0 33800.8 34249.0 34299.8 34443.0 34572.0 1177.7 1185.3 1188.2 1230.8 1304.6 17330.9 17493.3 17724.6 17756.2 17867.2 595530.0 609711.0 609918.0 613125.0 614078.0 63741.4 64279.0 64372.4 64375.4 64385.7 1345.5 1379.6 1392.4 1451.9 1489.4 30394.7 36722.0 36932.0 37316.0 37446.6 61756.4 62769.7 62852.4 62917.4 63012.4 505733.0 508985.0 509446.0 510808.0 512241.0 26647.0 27007.5 31494.0 32044.4 32351.0 50469.5 50747.0 50771.2 50903.5 51576.0 44117.3 44563.8 44958.6 46470.1 46524.5 44621.6 45302.8 45398.0 45496.0 46876.8 43908.6 44830.8 45098.3 45281.1 45338.5 36483.3 39136.2 39525.2 39832.9 40290.6 29095.0 29108.4 29559.6 29672.7 29673.3 15:45:18 INFO - PROCESS | 18552 | 15:45:18 INFO - PROCESS | 18552 | [#2] jquery.html Cycles:180 Average:22138.76 Median:20987.58 stddev:41586.19 (198.1%) stddev-sans-first:41670.89 15:45:18 INFO - PROCESS | 18552 | Values: 422.0 431.9 434.9 438.0 441.6 18827.4 20341.9 20627.2 20935.6 21039.6 19985.7 20023.8 20518.6 20538.8 20644.8 5835.2 6109.9 6114.4 6115.7 6118.2 5722.9 5934.0 5958.9 5961.1 6023.9 5917.1 5929.6 5929.7 5930.3 5931.0 5709.1 5874.4 5892.6 5899.4 5902.9 5261.2 5356.4 5362.2 5367.5 5373.7 23720.0 24085.8 24136.0 24324.0 24414.1 2729.0 2731.7 3004.7 3172.3 3262.9 15287.6 15306.0 15324.2 15443.0 16048.4 1894.2 2046.7 2088.4 2112.6 2161.9 63569.4 68674.7 69637.0 81958.0 87818.6 11375.5 11615.2 11664.5 11833.5 11993.9 16775.2 16784.7 16794.5 16804.6 16805.2 8683.3 8753.9 8797.8 8809.0 8827.2 8303.9 8335.5 8339.7 8513.1 8537.8 5087.9 5128.8 5144.7 5198.3 5250.4 1961.3 1964.4 1998.1 2026.1 2030.5 937.8 1005.9 1073.4 1095.5 1109.5 18918.9 20219.7 20470.2 20694.2 20847.4 1048.9 1060.4 1080.5 1108.6 1130.4 10582.8 11484.4 11508.3 11512.7 11575.5 165022.0 165475.0 165626.2 167927.0 392802.0 92119.4 92629.0 109107.0 110404.0 111353.7 1041.1 1075.6 1077.5 1086.1 1090.7 18179.9 18300.7 18680.4 18701.9 19083.6 44560.3 44759.8 44819.3 45061.0 45066.8 62268.7 62884.9 64733.4 64994.0 65088.0 9107.5 9265.3 9438.6 9462.2 9465.6 9793.6 13396.7 13568.5 13661.7 14064.6 11298.0 12034.4 12108.1 12369.4 12481.1 6004.4 11361.3 11416.6 11627.4 12175.9 7793.0 7844.7 12090.6 12528.2 12619.6 8094.3 8190.1 9288.6 12468.6 13612.7 11926.7 12388.4 12426.7 12872.7 12975.0 15:45:18 INFO - PROCESS | 18552 | 15:45:18 INFO - PROCESS | 18552 | [#3] mootools.html Cycles:180 Average:6257.21 Median:4576.29 stddev:3614.44 (79.0%) stddev-sans-first:3606.05 15:45:18 INFO - PROCESS | 18552 | Values: 1388.0 1513.2 1567.1 1692.0 1807.4 8497.6 9060.8 9319.2 9381.1 9512.7 9564.1 9628.2 9629.5 9642.8 9650.7 2510.2 2535.7 2537.5 2537.9 2539.9 2462.1 2533.8 2537.8 2543.1 2543.8 2507.3 2515.2 2548.7 2556.4 2560.2 2474.2 2485.9 2496.6 2506.1 2511.0 2417.9 2425.6 2461.2 2464.1 2468.6 9193.9 9328.8 9454.1 9462.7 9477.0 5523.8 5680.3 5680.6 5681.1 5683.0 3648.3 3658.4 3711.8 3714.1 3736.3 1207.5 1251.6 1272.2 1300.0 1302.3 12852.9 13074.0 13117.3 13131.8 13139.6 4763.0 4796.9 4815.6 4903.0 4948.8 10413.7 10419.9 10422.2 10426.9 10439.8 5670.2 5676.4 5682.8 5684.6 5687.1 4470.5 4682.1 4758.7 5176.5 5287.1 4031.5 4095.2 4125.4 4131.0 4221.0 1183.9 1214.9 1222.3 1222.8 1233.7 857.6 921.3 922.0 950.4 1026.3 6192.8 6306.2 6358.2 6394.2 6405.2 977.1 1034.7 1079.1 1084.1 1107.5 4092.0 4197.4 4238.6 4239.8 4389.7 12113.6 12429.9 12462.3 12475.1 12478.0 12309.4 12334.7 12360.2 12510.8 12515.3 8570.3 8946.7 8950.1 9010.6 9181.6 6592.6 6633.4 6655.9 6732.3 6904.0 10937.2 11405.8 11455.7 11478.5 11631.6 10266.2 10584.9 11597.7 11630.3 11636.5 8426.9 8694.0 8703.7 8806.2 8915.3 8843.4 9005.8 9161.8 9163.3 9176.2 7834.2 7917.2 8002.2 8137.6 8459.9 7827.8 8077.8 8289.7 8306.0 8351.8 7329.2 7338.2 7429.1 7430.4 7435.4 5435.9 5595.4 5599.0 5685.4 5686.3 5361.0 5497.5 5573.3 5789.9 5818.4 15:45:18 INFO - PROCESS | 18552 | 15:45:18 INFO - PROCESS | 18552 | [#4] prototype.html Cycles:180 Average:4699.50 Median:5231.32 stddev:1366.52 (26.1%) stddev-sans-first:1330.74 15:45:18 INFO - PROCESS | 18552 | Values: 347.2 352.2 356.2 356.6 357.3 5270.2 5375.0 5433.5 5475.9 5481.3 5225.6 5321.8 5338.4 5356.5 5402.9 4227.9 4268.9 4269.5 4289.1 4313.6 4176.0 4256.6 4261.8 4295.2 4298.8 4221.6 4221.8 4230.4 4230.6 4235.2 4199.7 4215.5 4218.4 4228.9 4276.5 3591.9 3693.9 3699.5 3713.7 3842.0 5287.3 5288.4 5295.4 5295.7 5340.8 4784.5 4821.7 4822.9 4844.4 4885.6 5422.8 5605.9 5617.4 5628.6 5657.3 4024.8 4035.4 4036.2 4048.6 4052.8 5853.4 5891.9 5901.8 5908.1 5930.5 4087.8 4181.3 4186.9 4193.6 4203.1 4225.2 4229.3 4229.6 4252.7 4289.6 4873.3 4893.8 4896.9 4904.7 4917.1 5622.6 5687.3 5711.1 5735.8 5775.7 1357.0 1363.4 1433.1 1456.1 1459.5 992.7 1008.2 1019.8 1021.9 1028.3 5459.9 5461.3 5469.5 5489.2 5490.3 5719.5 5787.5 5792.7 5794.5 5857.9 5218.1 5422.8 5471.5 5527.7 5558.5 2690.3 2716.9 2733.2 2745.0 2753.0 5164.3 5221.7 5224.7 5230.4 5282.8 4972.7 5050.7 5149.5 5217.5 5235.3 5120.9 5226.9 5232.3 5256.7 5265.4 5104.3 5122.3 5129.4 5152.3 5185.4 5426.9 5781.7 5802.8 5802.8 5816.9 6016.0 6045.6 6053.3 6086.7 6098.1 4062.5 4215.6 4275.7 4281.0 4290.2 5639.5 5794.8 5794.8 5803.2 5806.8 5599.8 5726.8 5752.3 5754.9 5775.4 5690.1 5692.8 5694.7 5767.8 5817.5 5523.9 5535.9 5615.5 5624.0 5639.6 5696.0 5716.3 5740.7 5742.3 5751.4 5427.4 5595.6 5621.8 5663.4 5696.6 15:45:18 INFO - PROCESS | 18552 | 15:45:18 INFO - PROCESS | 18552 | [#5] yui.html Cycles:180 Average:22389.73 Median:22724.62 stddev:31944.39 (140.6%) stddev-sans-first:31993.11 15:45:18 INFO - PROCESS | 18552 | Values: 864.0 871.7 904.6 906.5 918.1 16534.3 17824.8 17851.7 17884.6 17913.2 15993.5 16130.5 16151.3 16166.3 16187.4 726.4 741.0 854.8 862.2 886.5 881.7 891.0 891.2 891.6 893.5 937.3 937.6 937.6 940.1 941.4 771.6 790.1 905.7 924.1 934.6 684.3 684.4 684.7 684.8 684.8 15655.9 15712.3 15727.3 15729.4 15746.2 15622.7 15759.1 15917.6 16055.0 16135.0 14079.4 14237.4 14252.5 14466.4 14812.8 4557.4 4582.9 4584.7 4615.2 4635.5 89149.0 90286.5 90942.0 91485.5 92045.0 11861.7 12038.4 12134.0 12310.4 12418.8 21096.5 21292.8 21618.4 22138.0 22762.2 9379.6 9417.6 9663.4 9684.0 9823.4 4991.1 5213.9 5273.3 5285.9 5371.0 3566.4 3660.5 3663.7 3666.5 3671.7 599.8 615.6 615.7 618.1 625.8 568.9 686.9 711.0 711.6 718.0 9469.8 9768.9 9970.7 10036.4 10350.1 601.6 627.7 669.2 692.3 740.7 4552.0 4556.7 4622.2 4625.8 4704.4 108367.0 109392.5 112411.0 119957.4 135272.0 99036.0 105140.0 108211.5 108248.5 109175.0 91205.0 92561.0 93582.5 94194.0 95711.5 10377.8 10401.8 10411.6 10543.5 10569.4 41777.6 42588.0 55372.4 56449.2 56805.0 72197.6 77732.6 79849.6 80903.0 82520.6 13384.9 13686.2 13836.4 14233.9 14256.8 15284.0 15325.8 15461.0 15519.2 15982.4 14642.3 14807.6 15073.4 15348.0 15682.5 14400.6 14437.4 15176.6 15354.0 15747.8 14668.0 15285.4 15719.1 15738.9 15824.0 12415.5 12540.7 12698.7 12895.5 13773.7 12601.3 12762.0 13002.1 13049.9 13249.3 15:45:18 INFO - PROCESS | 18552 | -------- Summary: end -------- 15:45:18 INFO - PROCESS | 18552 | 15:45:19 INFO - TEST-INFO | 18552: exit 0 15:45:19 INFO - TEST-OK | dromaeo_css | took 1113623ms 15:45:19 INFO - TEST-START | kraken 15:45:19 INFO - operating with platform_type : linux_ 15:45:19 INFO - Initialising browser for kraken test... 15:45:19 INFO - TEST-INFO | started process 18874 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM00F56/profile http://localhost:54206/getInfo.html) 15:45:23 INFO - PROCESS | 18874 | __metrics Screen width/height:1600/1200 15:45:23 INFO - PROCESS | 18874 | colorDepth:24 15:45:23 INFO - PROCESS | 18874 | Browser inner width/height: 1024/697 15:45:23 INFO - PROCESS | 18874 | __metrics 15:45:24 INFO - PROCESS | 18874 | 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" 15:45:24 INFO - PROCESS | 18874 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:45:24 INFO - PROCESS | 18874 | console.error: PushService: 15:45:24 INFO - PROCESS | 18874 | stateChangeProcessEnqueue: Error transitioning state 15:45:24 INFO - PROCESS | 18874 | UnknownError 15:45:25 INFO - TEST-INFO | 18874: exit 0 15:45:25 INFO - Browser initialized. 15:45:25 INFO - Running cycle 1/1 for kraken test... 15:45:25 INFO - TEST-INFO | started process 18966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM00F56/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:45:36 INFO - PROCESS | 18966 | RSS: Main: 144510976 15:45:36 INFO - PROCESS | 18966 | 15:45:39 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:54206/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54206/tests/kraken/driver.html?testName=audio-beat-detection) 15:45:40 INFO - PROCESS | 18966 | RSS: Main: 186408960 15:45:40 INFO - PROCESS | 18966 | 15:45:42 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:54206/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54206/tests/kraken/driver.html?testName=audio-dft) 15:45:43 INFO - PROCESS | 18966 | RSS: Main: 175820800 15:45:43 INFO - PROCESS | 18966 | 15:45:46 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:54206/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54206/tests/kraken/driver.html?testName=audio-fft) 15:45:46 INFO - PROCESS | 18966 | RSS: Main: 266977280 15:45:46 INFO - PROCESS | 18966 | 15:45:48 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:54206/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54206/tests/kraken/driver.html?testName=audio-oscillator) 15:45:49 INFO - PROCESS | 18966 | RSS: Main: 173375488 15:45:49 INFO - PROCESS | 18966 | 15:45:51 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:54206/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54206/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:45:52 INFO - PROCESS | 18966 | RSS: Main: 175423488 15:45:52 INFO - PROCESS | 18966 | 15:45:55 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:54206/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54206/tests/kraken/driver.html?testName=imaging-darkroom) 15:45:55 INFO - PROCESS | 18966 | RSS: Main: 210706432 15:45:55 INFO - PROCESS | 18966 | 15:45:59 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:54206/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54206/tests/kraken/driver.html?testName=imaging-desaturate) 15:45:59 INFO - PROCESS | 18966 | RSS: Main: 210370560 15:45:59 INFO - PROCESS | 18966 | 15:46:02 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:54206/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54206/tests/kraken/driver.html?testName=json-parse-financial) 15:46:03 INFO - PROCESS | 18966 | RSS: Main: 209362944 15:46:03 INFO - PROCESS | 18966 | 15:46:04 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:54206/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54206/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:46:05 INFO - PROCESS | 18966 | RSS: Main: 171102208 15:46:05 INFO - PROCESS | 18966 | 15:46:06 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:54206/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54206/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:46:07 INFO - PROCESS | 18966 | RSS: Main: 178806784 15:46:07 INFO - PROCESS | 18966 | 15:46:09 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:54206/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54206/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:46:09 INFO - PROCESS | 18966 | RSS: Main: 188321792 15:46:09 INFO - PROCESS | 18966 | 15:46:12 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:54206/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54206/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:46:13 INFO - PROCESS | 18966 | RSS: Main: 196542464 15:46:13 INFO - PROCESS | 18966 | 15:46:15 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:54206/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54206/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:46:16 INFO - PROCESS | 18966 | RSS: Main: 193085440 15:46:16 INFO - PROCESS | 18966 | 15:46:18 INFO - PROCESS | 18966 | Cycle 1(1): loaded http://localhost:54206/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54206/tests/kraken/driver.html?testName=ai-astar) 15:46:18 INFO - PROCESS | 18966 | RSS: Main: 243941376 15:46:18 INFO - PROCESS | 18966 | 15:46:18 INFO - PROCESS | 18966 | __start_tp_report 15:46:18 INFO - PROCESS | 18966 | _x_x_mozilla_page_load 15:46:18 INFO - PROCESS | 18966 | _x_x_mozilla_page_load_details 15:46:18 INFO - PROCESS | 18966 | |i|pagename|runs| 15:46:18 INFO - PROCESS | 18966 | |0;ai-astar;111;110;110;111;113;111;110;111;109;110 15:46:18 INFO - PROCESS | 18966 | |1;audio-beat-detection;141;116;115;157;117;125;116;116;157;116 15:46:18 INFO - PROCESS | 18966 | |2;audio-dft;158;160;159;162;160;163;160;163;160;169 15:46:18 INFO - PROCESS | 18966 | |3;audio-fft;74;76;75;115;76;76;76;74;96;75 15:46:18 INFO - PROCESS | 18966 | |4;audio-oscillator;82;80;123;82;82;81;115;81;82;107 15:46:18 INFO - PROCESS | 18966 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;117;116 15:46:18 INFO - PROCESS | 18966 | |6;imaging-darkroom;145;146;146;146;146;147;146;147;147;146 15:46:18 INFO - PROCESS | 18966 | |7;imaging-desaturate;95;95;95;95;96;95;94;95;95;94 15:46:18 INFO - PROCESS | 18966 | |8;json-parse-financial;51;49;50;49;50;51;52;50;50;51 15:46:18 INFO - PROCESS | 18966 | |9;json-stringify-tinderbox;58;58;59;59;58;58;58;58;58;58 15:46:18 INFO - PROCESS | 18966 | |10;stanford-crypto-aes;74;74;73;73;75;72;73;79;76;74 15:46:18 INFO - PROCESS | 18966 | |11;stanford-crypto-ccm;138;125;123;120;124;122;122;125;161;131 15:46:18 INFO - PROCESS | 18966 | |12;stanford-crypto-pbkdf2;156;155;154;154;153;156;159;155;149;154 15:46:18 INFO - PROCESS | 18966 | |13;stanford-crypto-sha256-iterative;61;63;62;64;62;62;65;61;66;61 15:46:18 INFO - PROCESS | 18966 | __end_tp_report 15:46:18 INFO - PROCESS | 18966 | __start_cc_report 15:46:18 INFO - PROCESS | 18966 | _x_x_mozilla_cycle_collect,1699 15:46:18 INFO - PROCESS | 18966 | __end_cc_report 15:46:18 INFO - PROCESS | 18966 | __startTimestamp1478648778297__endTimestamp 15:46:18 INFO - PROCESS | 18966 | 15:46:18 INFO - PROCESS | 18966 | ------- Summary: start ------- 15:46:18 INFO - PROCESS | 18966 | Number of tests: 14 15:46:18 INFO - PROCESS | 18966 | 15:46:18 INFO - PROCESS | 18966 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.07 (1.0%) stddev-sans-first:1.13 15:46:18 INFO - PROCESS | 18966 | Values: 111.0 110.0 110.0 111.0 113.0 111.0 110.0 111.0 109.0 110.0 15:46:18 INFO - PROCESS | 18966 | 15:46:18 INFO - PROCESS | 18966 | [#1] audio-beat-detection Cycles:10 Average:127.60 Median:121.00 stddev:17.40 (14.4%) stddev-sans-first:17.77 15:46:18 INFO - PROCESS | 18966 | Values: 141.0 116.0 115.0 157.0 117.0 125.0 116.0 116.0 157.0 116.0 15:46:18 INFO - PROCESS | 18966 | 15:46:18 INFO - PROCESS | 18966 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:3.13 (1.9%) stddev-sans-first:3.07 15:46:18 INFO - PROCESS | 18966 | Values: 158.0 160.0 159.0 162.0 160.0 163.0 160.0 163.0 160.0 169.0 15:46:18 INFO - PROCESS | 18966 | 15:46:18 INFO - PROCESS | 18966 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:13.54 (17.8%) stddev-sans-first:14.10 15:46:18 INFO - PROCESS | 18966 | Values: 74.0 76.0 75.0 115.0 76.0 76.0 76.0 74.0 96.0 75.0 15:46:18 INFO - PROCESS | 18966 | 15:46:18 INFO - PROCESS | 18966 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:81.50 stddev:16.66 (20.4%) stddev-sans-first:17.31 15:46:18 INFO - PROCESS | 18966 | Values: 82.0 80.0 123.0 82.0 82.0 81.0 115.0 81.0 82.0 107.0 15:46:18 INFO - PROCESS | 18966 | 15:46:18 INFO - PROCESS | 18966 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 15:46:18 INFO - PROCESS | 18966 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 15:46:18 INFO - PROCESS | 18966 | 15:46:18 INFO - PROCESS | 18966 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 15:46:18 INFO - PROCESS | 18966 | Values: 145.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 146.0 15:46:18 INFO - PROCESS | 18966 | 15:46:18 INFO - PROCESS | 18966 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 15:46:18 INFO - PROCESS | 18966 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 94.0 15:46:18 INFO - PROCESS | 18966 | 15:46:18 INFO - PROCESS | 18966 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.50 stddev:0.95 (1.9%) stddev-sans-first:0.97 15:46:18 INFO - PROCESS | 18966 | Values: 51.0 49.0 50.0 49.0 50.0 51.0 52.0 50.0 50.0 51.0 15:46:18 INFO - PROCESS | 18966 | 15:46:18 INFO - PROCESS | 18966 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 15:46:18 INFO - PROCESS | 18966 | Values: 58.0 58.0 59.0 59.0 58.0 58.0 58.0 58.0 58.0 58.0 15:46:18 INFO - PROCESS | 18966 | 15:46:18 INFO - PROCESS | 18966 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:74.00 stddev:2.00 (2.7%) stddev-sans-first:2.12 15:46:18 INFO - PROCESS | 18966 | Values: 74.0 74.0 73.0 73.0 75.0 72.0 73.0 79.0 76.0 74.0 15:46:18 INFO - PROCESS | 18966 | 15:46:18 INFO - PROCESS | 18966 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:125.00 stddev:12.39 (9.9%) stddev-sans-first:12.71 15:46:18 INFO - PROCESS | 18966 | Values: 138.0 125.0 123.0 120.0 124.0 122.0 122.0 125.0 161.0 131.0 15:46:18 INFO - PROCESS | 18966 | 15:46:18 INFO - PROCESS | 18966 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:155.00 stddev:2.55 (1.6%) stddev-sans-first:2.65 15:46:18 INFO - PROCESS | 18966 | Values: 156.0 155.0 154.0 154.0 153.0 156.0 159.0 155.0 149.0 154.0 15:46:18 INFO - PROCESS | 18966 | 15:46:18 INFO - PROCESS | 18966 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:1.77 (2.8%) stddev-sans-first:1.76 15:46:18 INFO - PROCESS | 18966 | Values: 61.0 63.0 62.0 64.0 62.0 62.0 65.0 61.0 66.0 61.0 15:46:18 INFO - PROCESS | 18966 | -------- Summary: end -------- 15:46:18 INFO - PROCESS | 18966 | 15:46:19 INFO - TEST-INFO | 18966: exit 0 15:46:19 INFO - TEST-OK | kraken | took 59708ms 15:46:19 INFO - SUITE-END | took 1173s 15:46:19 INFO - Completed test suite (00:19:33) 15:46:19 INFO - javascript benchmark 15:46:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.545780861775, 3164.082416099331, 3171.2230503526625, 3182.904512864615, 3205.9519107213396, 5537.501624853762, 5615.438456154383, 5628.915566266509, 5651.2935883014625, 5657.745401456928, 5511.283533140686, 5575.526080283171, 5577.414371490986, 5581.804636837712, 5602.1596760485845, 5021.297018417425, 5029.949700502984, 5033.043721692885, 5116.437191908887, 5126.231065340192, 5001.549860512553, 5069.822556210534, 5118.897622047557, 5133.230015497668, 5133.3326667533165, 4996.100701873679, 5025.447200807908, 5046.873828154289, 5095.668781529207, 5117.360329958755, 5097.3118628984985, 5125.743712814345, 5132.923006154911, 5190.480951904779, 5197.766100525486, 5006.949930500685, 5127.923081153748, 5169.896602067975, 5186.974065129688, 5215.243789650517, 5430.619856610039, 5478.123500239943, 5496.038193316153, 5500.944990550083, 5504.119340905476, 5917.171595976567, 5924.7926322578505, 6008.399160084, 6024.578279520435, 6028.728707208186, 6047.848803779897, 6056.152138700585, 6057.3336932937345, 6064.151018857364, 6068.999999999955, 5378.919316210221, 5418.051840927822, 5479.123340265578, 5580.776768929279, 5584.385717571064, 6170.043643235216, 6179.84550386244, 6180.505559555315, 6183.3816618337805, 6184.81445556634, 5912.290525137011, 5919.763209471573, 5926.822195334147, 5935.614185077956, 5936.554758393051, 5857.20927674767, 5946.316173640001, 5947.791827286024, 5966.403359663999, 6025.3974602540275, 5857.502112320415, 6007.339192688801, 6009.06859436788, 6017.037274036134, 6018.7291571878495, 5921.407859214044, 5923.348431672513, 5984.431479009487, 6001.699915004232, 6005.759769609167, 4551.203539380595, 4551.726896386227, 4556.498785133633, 4558.042811009659, 4586.243269860435, 3952.802359882052, 3963.4847469828737, 4050.5139383274195, 4055.0673345130194, 4073.0835561998315, 5523.447655234444, 5682.943170568324, 5688.800891968761, 5736.110902810071, 5766.711664416763, 6041.607295525777, 6044.093385992049, 6051.455369016721, 6053.424924632153, 6055.273367195965, 5496.340439147248, 5681.517071049007, 5724.427557244242, 5730.111832665943, 5739.655620662774, 4906.656534042583, 4987.900241995139, 5005.724685142352, 5010.799568017312, 5061.569766569809, 6207.0, 6211.254649442096, 6223.96888015557, 6237.157983672237, 6243.406876346739, 6041.516678665784, 6070.423309785563, 6075.1798507200965, 6079.3008803988105, 6082.118092876596, 5987.13186587951, 5989.101634754822, 6121.234845644294, 6156.26124865019, 6214.471769899609, 5916.911246331395, 5953.077273022688, 5972.5520585955355, 5994.790182343597, 6002.429769171922, 6058.0, 6065.120557519223, 6068.029115341524, 6069.2716873975405, 6072.817815465543, 5642.040853054908, 5709.429057094258, 5744.885102298014, 5892.558058145571, 5905.0, 5766.250387449605, 5833.912491312549, 5837.0368889132815, 5865.472107510344, 5868.0, 5750.568707346882, 5770.163326317576, 5772.105323674838, 5781.739821708117, 5783.768649254151, 5656.406077361818, 5666.801661941812, 5854.356020837619, 5857.033589457692, 5862.179294898803, 5652.68910209926, 5676.886462270814, 5707.885842283048, 5716.114002329646, 5800.6229595077875], "value": 5504.337902155784, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.6661702829389, 628.1237673445543, 651.8794023105726, 657.5331514624617, 674.5312008154335, 34964.65035349646, 46674.76662616691, 47892.04215915684, 48052.0, 48200.75899620497, 50454.74772626132, 50756.49243507564, 50893.7276568086, 50960.23559646599, 51038.0, 8681.088485709004, 9509.476978766164, 9672.661456849011, 9676.467794271312, 9678.080582344666, 8480.194381533775, 11197.216194866363, 11454.71363215922, 11469.713257168554, 11764.058875289957, 11631.302121872672, 11680.12399070069, 11698.649040528799, 11708.53165873364, 11709.063274937984, 11466.885331146665, 11502.769944601145, 11539.076873850156, 11555.826662600068, 11560.942195289012, 11105.55577776888, 11164.441777911072, 11186.720331991684, 11194.216404851664, 11198.944005280004, 43457.348139777925, 43469.78265108654, 43560.3465948011, 43571.346429803576, 43966.0, 3683.3001729671278, 3823.8661646842506, 3940.468036815022, 4163.708540402173, 4544.431946006749, 35475.467867982, 36169.81915090434, 36337.27325453476, 37002.62997370019, 37460.25079498395, 4105.692073094529, 4155.044339801832, 4161.313383291753, 4180.7909604519655, 4203.810828512725, 382163.0, 386254.0, 387013.0, 387718.06140969397, 387859.0, 66527.33472665308, 66879.0, 66959.66520167465, 67011.66494167596, 67057.0, 41656.791716041225, 42068.78965605152, 42409.36385954213, 44357.33463998043, 44413.55586444159, 19073.80926190748, 19088.80911190898, 19350.0, 19381.612367752565, 19419.4174174775, 13367.131136476099, 13590.93204533971, 13616.38726257301, 13942.093763905314, 14076.085054471427, 20478.18087276522, 21015.57968840645, 21121.521493495617, 21196.470088247916, 21276.36170914875, 7389.748510655294, 7503.474756767083, 7525.962370188114, 7580.9620951895995, 7651.502652327581, 1043.6242952537082, 1087.7606926476162, 1124.027716025632, 1152.1819508149308, 1198.9928460093563, 33800.830995845354, 34249.0, 34299.82850085734, 34443.0, 34572.0, 1177.7232350397649, 1185.324365111878, 1188.2276520261726, 1230.8399908011902, 1304.6477451088342, 17330.913345433193, 17493.30026798939, 17724.556886077695, 17756.20097095634, 17867.1959761811, 595530.0, 609711.0, 609918.0, 613125.0, 614078.0, 63741.36258637354, 64279.0, 64372.356276437575, 64375.35624643787, 64385.67807161028, 1345.4752646467884, 1379.5516457151266, 1392.366473254687, 1451.883849292054, 1489.4489039055618, 30394.696053039188, 36722.0, 36932.0, 37316.0, 37446.625533745406, 61756.38243617507, 62769.68615156895, 62852.371476286484, 62917.37082629115, 63012.36987630248, 505733.0, 508985.0, 509446.0, 510808.0, 512241.0, 26647.0, 27007.45985080248, 31494.0, 32044.359112818078, 32351.0, 50469.495305047945, 50747.0, 50771.238431424295, 50903.490965091354, 51576.0, 44117.33823992578, 44563.77718111389, 44958.55041449674, 46470.070598588514, 46524.53475465202, 44621.55378446174, 45302.773486132355, 45398.0, 45496.0, 46876.7656161717, 43908.560914391725, 44830.77584612056, 45098.323525146494, 45281.09437811291, 45338.546614533436, 36483.27033459369, 39136.217275653755, 39525.2094958105, 39832.949308755575, 40290.597094028686, 29095.0, 29108.417831642826, 29559.556606650487, 29672.703272966995, 29673.258168545097], "value": 22068.56887258203, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.0, 431.8749657143142, 434.8847555397819, 437.96058354748084, 441.6157942589947, 18827.435176944695, 20341.898290508565, 20627.174913003462, 20935.581288374222, 21039.579208415824, 19985.700214496796, 20023.799762002374, 20518.589628207428, 20538.794612053876, 20644.793552064475, 5835.241418615585, 6109.877802443971, 6114.388561143895, 6115.663638499881, 6118.235220597426, 5722.856928576798, 5934.0, 5958.851028724295, 5961.135635332874, 6023.909641355362, 5917.142014407908, 5929.644221346712, 5929.733162007698, 5930.318013428447, 5931.0, 5709.143628455723, 5874.383189765077, 5892.558058145656, 5899.380565040652, 5902.88194236115, 5261.184516399964, 5356.4107948125675, 5362.222477740745, 5367.543758780469, 5373.677579345252, 23720.0, 24085.7591424087, 24136.0, 24324.027038918422, 24414.145504907243, 2728.9590656139976, 2731.740484653955, 3004.669486356499, 3172.254520187754, 3262.8531716072835, 15287.617809554738, 15306.005109667836, 15324.233788310652, 15443.0, 16048.35806567736, 1894.1855002348984, 2046.7134601155851, 2088.4256829371893, 2112.5669237806214, 2161.91352345906, 63569.36430635727, 68674.65673145534, 69637.0, 81958.0, 87818.5609071957, 11375.521182246255, 11615.245009074382, 11664.475098620413, 11833.467493962793, 11993.940030299967, 16775.2451139699, 16784.664306714043, 16794.496165115066, 16804.57988550296, 16805.24376403065, 8683.348748843862, 8753.912460875437, 8797.780055498664, 8808.955955220183, 8827.16141966512, 8303.875441868377, 8335.499870007698, 8339.666413343519, 8513.148685131437, 8537.786555336166, 5087.949120508822, 5128.794848206105, 5144.6913185209005, 5198.2722418861385, 5250.448702886142, 1961.2743284984647, 1964.4499540128786, 1998.1407994562478, 2026.1490174126902, 2030.46192758919, 937.8218138553653, 1005.8893521712606, 1073.4257172412722, 1095.4741723972538, 1109.517359948425, 18918.905405472884, 20219.696704549442, 20470.181192752123, 20694.172233110807, 20847.37457876266, 1048.9003544663244, 1060.4485667452882, 1080.4631976541891, 1108.5621179634, 1130.3669944830922, 10582.841257381146, 11484.425778711031, 11508.251963622506, 11512.654620361403, 11575.479103440366, 165022.0, 165475.0, 165626.1718691399, 167927.0, 392802.0, 92119.36492758724, 92629.0, 109107.0, 110404.0, 111353.65939021842, 1041.1306559023149, 1075.6074032977906, 1077.5097330714507, 1086.1039642295138, 1090.6618948126106, 18179.909100454413, 18300.72548911794, 18680.439586812416, 18701.90649046746, 19083.61832763365, 44560.331595025455, 44759.77620111879, 44819.32771008372, 45061.0, 45066.77466612646, 62268.68865655643, 62884.94487764266, 64733.35266647273, 64994.0, 65088.0, 9107.544622768968, 9265.258779297776, 9438.575264112995, 9462.195713364166, 9465.621375144918, 9793.559289832117, 13396.665083372995, 13568.52510162179, 13661.726765464833, 14064.578062658136, 11298.039666628429, 12034.398280086136, 12108.091893107876, 12369.381530923238, 12481.126321157431, 6004.42957918997, 11361.261518001304, 11416.600418985296, 11627.360495172508, 12175.939120304341, 7792.986911701442, 7844.725434609762, 12090.637280881587, 12528.248305101723, 12619.621411357673, 8094.31198348147, 8190.099089100075, 9288.628454862, 12468.563600273947, 13612.65968350799, 11926.701832454259, 12388.380580971096, 12426.689332766753, 12872.678183045498, 12975.0], "value": 9572.783998783449, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.9653008674788, 1513.1828812441279, 1567.0754254989556, 1691.9915400422997, 1807.3945228348502, 8497.617607207674, 9060.818783624323, 9319.161275485205, 9381.108794664504, 9512.66705665302, 9564.09141131593, 9628.229741620671, 9629.518524073803, 9642.758931026729, 9650.662226822064, 2510.2469259222253, 2535.7210706822234, 2537.53055684698, 2537.936551586207, 2539.873006349684, 2462.101333013446, 2533.8353007054575, 2537.835040722347, 2543.0844895837577, 2543.834650747705, 2507.3104896153523, 2515.157422263544, 2548.7323830997757, 2556.386467247856, 2560.2063360358256, 2474.158786012755, 2485.9378515537164, 2496.5755821510297, 2506.0602274147195, 2511.0458025950206, 2417.9481925362347, 2425.599776036952, 2461.2247142150163, 2464.051340234023, 2468.5556599812026, 9193.862092068624, 9328.813423731555, 9454.101860323328, 9462.716118516455, 9476.952615236949, 5523.834284971457, 5680.261565996394, 5680.630759000652, 5681.147827825859, 5683.005474042026, 3648.2885837261742, 3658.396364599838, 3711.832967516468, 3714.0900479382453, 3736.271427071722, 1207.4506099724604, 1251.555697727303, 1272.243015405832, 1299.961001169957, 1302.3358087375507, 12852.871471285262, 13074.0, 13117.278549679764, 13131.803022954664, 13139.60581182566, 4762.97596016858, 4796.928046079312, 4815.614750819926, 4903.0, 4948.826791062295, 10413.687589372332, 10419.895801042045, 10422.21833362501, 10426.895731042592, 10439.791204175874, 5670.234518339971, 5676.403977582377, 5682.801101961411, 5684.573656975661, 5687.090065589486, 4470.473401659346, 4682.1103990241745, 4758.738269395217, 5176.482351764868, 5287.07476191665, 4031.475908131924, 4095.2423801596206, 4125.360569111733, 4131.029208136086, 4220.957790422057, 1183.928964262147, 1214.9392530373445, 1222.266640016001, 1222.8471441069867, 1233.7224124572078, 857.5883575883611, 921.3412410126791, 922.0272612393854, 950.4439902656885, 1026.338011982282, 6192.783252586228, 6306.180196574508, 6358.23701155855, 6394.23269207698, 6405.231372235362, 977.0620204603518, 1034.7413146713322, 1079.1205167788228, 1084.1218612923558, 1107.5293000474767, 4092.0, 4197.411213412488, 4238.576142385798, 4239.788010599457, 4389.736615803062, 12113.636590902288, 12429.875701243052, 12462.31457269859, 12475.064370172273, 12478.0, 12309.446074926649, 12334.691632709255, 12360.196587221983, 12510.812337814757, 12515.311657858723, 8570.271526920282, 8946.731598051938, 8950.14973577509, 9010.63957441695, 9181.632734690538, 6592.604443733391, 6633.436157926631, 6655.900161497679, 6732.293109223461, 6904.0, 10937.234393592373, 11405.771884562097, 11455.713607159887, 11478.540858365572, 11631.59289424866, 10266.178705703674, 10584.89415105839, 11597.6520704379, 11630.302181869114, 11636.53453861836, 8426.873596895928, 8694.04365519805, 8703.651853925772, 8806.163414475615, 8915.331350148894, 8843.380963332505, 9005.774855628662, 9161.816763664556, 9163.266938645025, 9176.220021298264, 7834.238376471494, 7917.208279172037, 8002.159773223728, 8137.6338064788415, 8459.915400845914, 7827.804304892423, 8077.7576672699915, 8289.709860155106, 8305.958470207852, 8351.791205219919, 7329.230430804689, 7338.156112047183, 7429.108506979197, 7430.3684186842565, 7435.442341824493, 5435.9280246545695, 5595.440455954372, 5599.04816181242, 5685.374608792947, 5686.2607860977805, 5360.973195133999, 5497.47773961473, 5573.303337082864, 5789.884202316014, 5818.418158184148], "value": 4971.340778077933, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.24127780798955, 352.24267824178014, 356.15413393191164, 356.6273244459543, 357.33892299246395, 5270.183121616146, 5374.973125134378, 5433.48381903719, 5475.890482190353, 5481.342238931329, 5225.634205605609, 5321.753730224569, 5338.359396872371, 5356.464353564642, 5402.91895621565, 4227.936580951288, 4268.935965960513, 4269.466316710411, 4289.099289149282, 4313.568643135693, 4176.0, 4256.616294874864, 4261.76560289184, 4295.1839150561445, 4298.785060746965, 4221.641160501361, 4221.831126754926, 4230.392450868666, 4230.640395566381, 4235.174141042498, 4199.664026877843, 4215.45199124115, 4218.367244913272, 4228.936565951513, 4276.465441819772, 3591.892243232707, 3693.9445908311395, 3699.519062521882, 3713.702903767719, 3841.980790096032, 5287.339082614673, 5288.391834938954, 5295.384907603179, 5295.708736019517, 5340.839774806762, 4784.497627749106, 4821.68659037165, 4822.879428014293, 4844.4186697596515, 4885.633577481668, 5422.810201642924, 5605.915911261334, 5617.376791969198, 5628.605997580171, 5657.2928383952, 4024.7786371749544, 4035.414864844581, 4036.1725846201753, 4048.6153815387493, 4052.837886484537, 5853.385394533598, 5891.882162356772, 5901.7934372297195, 5908.143319218732, 5930.495907847838, 4087.795610219477, 4181.310083836133, 4186.895327616834, 4193.559676234013, 4203.138356636882, 4225.239456897726, 4229.323308270662, 4229.6404805591255, 4252.659787217015, 4289.63538099265, 4873.317735516959, 4893.755312234374, 4896.877578060506, 4904.681195722338, 4917.1149193144865, 5622.582289615423, 5687.289088863892, 5711.143328500675, 5735.770569177186, 5775.653460792366, 1356.9932150339184, 1363.3796622536722, 1433.1329545624956, 1456.1190479759805, 1459.511063793641, 992.6972273456521, 1008.2287050406445, 1019.8164330420595, 1021.9080282774586, 1028.2956175020136, 5459.918101228484, 5461.306994831615, 5469.480399362054, 5489.231507588941, 5490.341159060858, 5719.513841323451, 5787.479126878601, 5792.710364481759, 5794.536437085023, 5857.941420585825, 5218.086834803894, 5422.8373148805595, 5471.534919531805, 5527.668339899619, 5558.499735023867, 2690.2870739254113, 2716.9184924452297, 2733.2097476153153, 2744.986275068612, 2753.026731130374, 5164.25118357836, 5221.668474538968, 5224.686518808883, 5230.372355317386, 5282.815101471507, 4972.707096155026, 5050.747462626928, 5149.45930677281, 5217.530422262014, 5235.267062611238, 5120.92318615221, 5226.9215961761365, 5232.2674825524455, 5256.658317209369, 5265.420803711589, 5104.310918026019, 5122.282880396822, 5129.384473863161, 5152.27868098474, 5185.407296351824, 5426.914617076522, 5781.710914454345, 5802.750459742389, 5802.796902108406, 5816.9127463088935, 6015.969920150371, 6045.576809623284, 6053.273607167168, 6086.665233412028, 6098.146259523759, 4062.512498500199, 4215.557366476476, 4275.743455392686, 4280.95719042818, 4290.184864875664, 5639.520640745583, 5794.797182098607, 5794.82615521535, 5803.187553742564, 5806.796762113475, 5599.832005039855, 5726.79956201531, 5752.274317704756, 5754.8849023018465, 5775.364709881826, 5690.089585666274, 5692.800751973661, 5694.743736531783, 5767.798127065533, 5817.534597232296, 5523.944760552504, 5535.861603459945, 5615.522680572197, 5624.0, 5639.577031722555, 5696.0, 5716.342620598684, 5740.712964351682, 5742.28221472316, 5751.424857514383, 5427.4301198373605, 5595.580331475075, 5621.80323688669, 5663.433656634304, 5696.629719068247], "value": 4271.279069456918, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [863.9956800215998, 871.6818361298128, 904.6019751309419, 906.4787747045447, 918.1461241045827, 16534.338626454926, 17824.821751782478, 17851.73222401665, 17884.64230715388, 17913.193906274217, 15993.520194394157, 16130.516084517454, 16151.273192706327, 16166.272517736701, 16187.35250589978, 726.3789460011693, 741.0255513999101, 854.8247609240121, 862.2455351567379, 886.4858382138344, 881.7398867334152, 890.9821803563925, 891.233539156325, 891.6032365597312, 893.499640201486, 937.2595649436937, 937.5780898595625, 937.6202637931615, 940.0787228516058, 941.4398432932394, 771.5794891783963, 790.1150711203431, 905.6739573753443, 924.1359329027381, 934.5747684803432, 684.3327755438457, 684.387473211473, 684.650828077679, 684.7740245718901, 684.8219462939621, 15655.92172039144, 15712.292946817306, 15727.292271847795, 15729.37082516698, 15746.212689365486, 15622.687546249124, 15759.054456732518, 15917.602059948478, 16055.0, 16135.0, 14079.436822527188, 14237.359318830677, 14252.501162459264, 14466.421343146261, 14812.777808332883, 4557.361969324297, 4582.931256031162, 4584.7478388688605, 4615.215413379734, 4635.5364463553715, 89149.0, 90286.5485672574, 90942.0, 91485.54257228671, 92045.0, 11861.703457413634, 12038.39808009596, 12134.0, 12310.446029928675, 12418.75162496763, 21096.47258818511, 21292.787072129082, 21618.351449456542, 22138.0, 22762.20332288362, 9379.624815007459, 9417.576209070608, 9663.420194788336, 9684.03159684026, 9823.410595364301, 4991.101601711727, 5213.921791173136, 5273.2617433559335, 5285.947140528622, 5370.9731451342495, 3566.375884220251, 3660.469231961404, 3663.743537952371, 3666.4683620875358, 3671.6511931366476, 599.7690889007677, 615.5844804756771, 615.6613862375675, 618.1315252070758, 625.8435391152212, 568.8520984543966, 686.9484788640872, 711.0294448078336, 711.5659447736876, 717.9964100179466, 9469.810603787886, 9768.90231097694, 9970.700878973497, 10036.397816131055, 10350.120239779702, 601.6299975515115, 627.6892937995722, 669.223700507409, 692.2834865913755, 740.6704016712512, 4552.0, 4556.703814252063, 4622.237330840374, 4625.838095666635, 4704.364910737075, 108367.0, 109392.4530377343, 112411.0, 119957.40021299837, 135272.0, 99036.0, 105140.0, 108211.45894270478, 108248.45875770571, 109175.0, 91205.0, 92561.0, 93582.53208734049, 94194.0, 95711.52144239235, 10377.792444150924, 10401.843972340572, 10411.583536658449, 10543.472826358498, 10569.365838049742, 41777.582224178586, 42588.0, 55372.44627553673, 56449.15326270191, 56805.0, 72197.6390118067, 77732.61133694295, 79849.6007519982, 80903.0, 82520.58739706263, 13384.929205663719, 13686.178829270275, 13836.377363018488, 14233.928830355782, 14256.786148207993, 15284.0, 15325.846741532441, 15461.0, 15519.224038797789, 15982.360705571647, 14642.34109465098, 14807.555773326818, 15073.397064117313, 15348.0, 15682.529524114294, 14400.639984000065, 14437.422503099759, 15176.620584485476, 15354.0, 15747.763783543027, 14668.0, 15285.388584456497, 15719.135447550494, 15738.9213053934, 15824.0, 12415.503379864704, 12540.686482838002, 12698.682532936751, 12895.548655797002, 13773.655658608615, 12601.306928119042, 12762.0, 13002.130438453278, 13049.869501304865, 13249.337533123113], "value": 8128.839360498366, "unit": "score"}], "name": "dromaeo_css", "value": 7651.922574114619, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 110.0, 111.0, 113.0, 111.0, 110.0, 111.0, 109.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 115.0, 157.0, 117.0, 125.0, 116.0, 116.0, 157.0, 116.0], "value": 127.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 159.0, 162.0, 160.0, 163.0, 160.0, 163.0, 160.0, 169.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 115.0, 76.0, 76.0, 76.0, 74.0, 96.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 123.0, 82.0, 82.0, 81.0, 115.0, 81.0, 82.0, 107.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 50.0, 49.0, 50.0, 51.0, 52.0, 50.0, 50.0, 51.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 59.0, 59.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 73.0, 75.0, 72.0, 73.0, 79.0, 76.0, 74.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 125.0, 123.0, 120.0, 124.0, 122.0, 122.0, 125.0, 161.0, 131.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 154.0, 154.0, 153.0, 156.0, 159.0, 155.0, 149.0, 154.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 64.0, 62.0, 62.0, 65.0, 61.0, 66.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1459.3, "alertThreshold": 2.0}]} 15:46:19 INFO - Return code: 0 15:46:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:46:19 INFO - # TBPL SUCCESS # 15:46:19 INFO - Running post-action listener: _resource_record_post_action 15:46:19 INFO - [mozharness: 2016-11-08 23:46:19.605510Z] Finished run-tests step (success) 15:46:19 INFO - Running post-run listener: _resource_record_post_run 15:46:19 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 357990400; Read time: 0; Write time: 245464 15:46:19 INFO - TinderboxPrint: CPU usage
13.0% 15:46:19 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:46:19 INFO - TinderboxPrint: I/O write bytes / time
357,990,400 / 245,464 15:46:19 INFO - TinderboxPrint: CPU idle
8,266.2 (87.0%) 15:46:19 INFO - TinderboxPrint: CPU user
1,187.6 (12.5%) 15:46:19 INFO - TinderboxPrint: Swap in / out
0 / 0 15:46:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115068928; Read time: 0; Write time: 89656 15:46:19 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 242921472; Read time: 0; Write time: 155808 15:46:20 INFO - Running post-run listener: _upload_blobber_files 15:46:20 INFO - Blob upload gear active. 15:46:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:46:20 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 15:46:20 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:46:20 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:46:20 INFO - (blobuploader) - INFO - Open directory for files ... 15:46:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:46:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:46:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:46:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:46:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:46:21 INFO - (blobuploader) - INFO - Done attempting. 15:46:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:46:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:46:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:46:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:46:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:46:22 INFO - (blobuploader) - INFO - Done attempting. 15:46:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:46:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:46:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:46:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:46:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:46:25 INFO - (blobuploader) - INFO - Done attempting. 15:46:25 INFO - (blobuploader) - INFO - Iteration through files over. 15:46:25 INFO - Return code: 0 15:46:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:46:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:46:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8bdbe738089791a5a7c3556c8b0c6fe59f96f9b26558c6169b0333d6ef64184f5bf824f5975d41b31e00984ff711209c92624354a23f434ae64180fa683addf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e15193c333ffc6d7bc8f358d9a4ccb36e8d2000c84bb7eea94face7f1fa71805dc1db3c2ca6c1a58e9f8b33b8aee6445feb1e548f5e5e91f4d1a3dad3d29490", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/15acf9497a57c37cfa41e2ce139d5ea979aabea0b8a7fd6c7987d30e55ac439636716418e466a29032f3349aefd14ae67bf1c51ac6296f13d8e5a2721d1bd8e9"} 15:46:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:46:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:46:25 INFO - Contents: 15:46:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8bdbe738089791a5a7c3556c8b0c6fe59f96f9b26558c6169b0333d6ef64184f5bf824f5975d41b31e00984ff711209c92624354a23f434ae64180fa683addf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e15193c333ffc6d7bc8f358d9a4ccb36e8d2000c84bb7eea94face7f1fa71805dc1db3c2ca6c1a58e9f8b33b8aee6445feb1e548f5e5e91f4d1a3dad3d29490", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/15acf9497a57c37cfa41e2ce139d5ea979aabea0b8a7fd6c7987d30e55ac439636716418e466a29032f3349aefd14ae67bf1c51ac6296f13d8e5a2721d1bd8e9"} 15:46:25 INFO - Running post-run listener: copy_logs_to_upload_dir 15:46:25 INFO - Copying logs to upload dir... 15:46:25 INFO - mkdir: /builds/slave/test/build/upload/logs 15:46:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.341088 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-11-08 15:46:25.044724) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 15:46:25.048681) ========= 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=bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8bdbe738089791a5a7c3556c8b0c6fe59f96f9b26558c6169b0333d6ef64184f5bf824f5975d41b31e00984ff711209c92624354a23f434ae64180fa683addf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e15193c333ffc6d7bc8f358d9a4ccb36e8d2000c84bb7eea94face7f1fa71805dc1db3c2ca6c1a58e9f8b33b8aee6445feb1e548f5e5e91f4d1a3dad3d29490", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/15acf9497a57c37cfa41e2ce139d5ea979aabea0b8a7fd6c7987d30e55ac439636716418e466a29032f3349aefd14ae67bf1c51ac6296f13d8e5a2721d1bd8e9"} build_url:https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/OM6O9xX_QYWuhv8xTJN5aA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8bdbe738089791a5a7c3556c8b0c6fe59f96f9b26558c6169b0333d6ef64184f5bf824f5975d41b31e00984ff711209c92624354a23f434ae64180fa683addf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e15193c333ffc6d7bc8f358d9a4ccb36e8d2000c84bb7eea94face7f1fa71805dc1db3c2ca6c1a58e9f8b33b8aee6445feb1e548f5e5e91f4d1a3dad3d29490", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/15acf9497a57c37cfa41e2ce139d5ea979aabea0b8a7fd6c7987d30e55ac439636716418e466a29032f3349aefd14ae67bf1c51ac6296f13d8e5a2721d1bd8e9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 15:46:25.076643) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 15:46:25.077201) ========= 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=bb9b54edd4a927dc735d112f000001d9-1478647551.720984-1312514498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 15:46:25.159082) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 15:46:25.159405) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 15:46:25.159728) ========= ========= Total master_lag: 0.17 =========