builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1477409923.57 results: success (0) buildid: 20161025054420 builduid: 54f1fd3350c648b3af3cf2752ff08f84 revision: b82a286b69e040dc2e8f180e33cffd25f7a09ff4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 08:38:43.569617) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 08:38:43.570162) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 08:38:43.570496) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 08:38:43.593670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:38:43.594012) ========= 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=00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-25 08:38:43-- 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% 617K=0.02s 2016-10-25 08:38:43 (617 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128241 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:38:43.742612) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:38:43.742920) ========= 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=00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015798 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:38:43.805764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:38:43.806105) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b82a286b69e040dc2e8f180e33cffd25f7a09ff4 --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 b82a286b69e040dc2e8f180e33cffd25f7a09ff4 --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=00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-25 08:38:43,940 truncating revision to first 12 chars 2016-10-25 08:38:43,940 Setting DEBUG logging. 2016-10-25 08:38:43,940 attempt 1/10 2016-10-25 08:38:43,940 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b82a286b69e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 08:38:44,274 unpacking tar archive at: mozilla-aurora-b82a286b69e0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652650 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:38:44.476728) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 08:38:44.477050) ========= script_repo_revision: b82a286b69e040dc2e8f180e33cffd25f7a09ff4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 08:38:44.477502) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 08:38:44.477784) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 08:38:44.488176) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-25 08:38:44.488487) ========= /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=00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:38:44 INFO - MultiFileLogger online at 20161025 08:38:44 in /builds/slave/test 08:38:44 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 08:38:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:38:44 INFO - {'append_to_log': False, 08:38:44 INFO - 'base_work_dir': '/builds/slave/test', 08:38:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:38:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:38:44 INFO - 'branch': 'Mozilla-Aurora', 08:38:44 INFO - 'buildbot_json_path': 'buildprops.json', 08:38:44 INFO - 'config_files': ('talos/linux_config.py',), 08:38:44 INFO - 'default_actions': ('clobber', 08:38:44 INFO - 'read-buildbot-config', 08:38:44 INFO - 'download-and-extract', 08:38:44 INFO - 'populate-webroot', 08:38:44 INFO - 'create-virtualenv', 08:38:44 INFO - 'install', 08:38:44 INFO - 'run-tests'), 08:38:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:38:44 INFO - 'download_minidump_stackwalk': True, 08:38:44 INFO - 'download_symbols': 'ondemand', 08:38:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:38:44 INFO - 'tooltool.py': '/tools/tooltool.py', 08:38:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:38:44 INFO - '/tools/misc-python/virtualenv.py')}, 08:38:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:38:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:38:44 INFO - 'installer_path': 'installer.exe', 08:38:44 INFO - 'log_level': 'info', 08:38:44 INFO - 'log_name': 'talos', 08:38:44 INFO - 'log_to_console': True, 08:38:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:38:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:38:44 INFO - 'opt_config_files': (), 08:38:44 INFO - 'pip_index': False, 08:38:44 INFO - 'sps_profile': False, 08:38:44 INFO - 'sps_profile_interval': 0, 08:38:44 INFO - 'suite': 'dromaeojs', 08:38:44 INFO - 'system_bits': '32', 08:38:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:38:44 INFO - 'title': 'talos-linux64-ix-016', 08:38:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:38:44 INFO - 'use_talos_json': True, 08:38:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:38:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:38:44 INFO - 'work_dir': 'build'} 08:38:44 INFO - [mozharness: 2016-10-25 15:38:44.711733Z] Running clobber step. 08:38:44 INFO - Running pre-action listener: _resource_record_pre_action 08:38:44 INFO - Running main action method: clobber 08:38:44 INFO - rmtree: /builds/slave/test/build 08:38:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:38:45 INFO - Running post-action listener: _resource_record_post_action 08:38:45 INFO - [mozharness: 2016-10-25 15:38:45.674039Z] Finished clobber step (success) 08:38:45 INFO - [mozharness: 2016-10-25 15:38:45.674138Z] Running read-buildbot-config step. 08:38:45 INFO - Running pre-action listener: _resource_record_pre_action 08:38:45 INFO - Running main action method: read_buildbot_config 08:38:45 INFO - Using buildbot properties: 08:38:45 INFO - { 08:38:45 INFO - "project": "", 08:38:45 INFO - "product": "firefox", 08:38:45 INFO - "script_repo_revision": "production", 08:38:45 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:38:45 INFO - "repository": "", 08:38:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:38:45 INFO - "buildid": "20161025054420", 08:38:45 INFO - "pgo_build": "True", 08:38:45 INFO - "basedir": "/builds/slave/test", 08:38:45 INFO - "buildnumber": 835, 08:38:45 INFO - "slavename": "talos-linux64-ix-016", 08:38:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:38:45 INFO - "platform": "ubuntu64_hw", 08:38:45 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:38:45 INFO - "branch": "mozilla-aurora", 08:38:45 INFO - "repo_path": "releases/mozilla-aurora", 08:38:45 INFO - "revision": "b82a286b69e040dc2e8f180e33cffd25f7a09ff4", 08:38:45 INFO - "stage_platform": "linux64-pgo", 08:38:45 INFO - "builduid": "54f1fd3350c648b3af3cf2752ff08f84", 08:38:45 INFO - "slavebuilddir": "test" 08:38:45 INFO - } 08:38:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 08:38:45 INFO - Running post-action listener: _resource_record_post_action 08:38:45 INFO - [mozharness: 2016-10-25 15:38:45.676565Z] Finished read-buildbot-config step (success) 08:38:45 INFO - [mozharness: 2016-10-25 15:38:45.676654Z] Running download-and-extract step. 08:38:45 INFO - Running pre-action listener: _resource_record_pre_action 08:38:45 INFO - Running main action method: download_and_extract 08:38:45 INFO - mkdir: /builds/slave/test/build/tests 08:38: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')]} 08:38:45 INFO - trying https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 08:38:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/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 08:38:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/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 08:38:46 INFO - Downloaded 1361 bytes. 08:38:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 08:38:46 INFO - Using the following test package requirements: 08:38:46 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 08:38:46 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:38:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:38:46 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:38:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:38:46 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:38:46 INFO - u'jsshell-linux-x86_64.zip'], 08:38:46 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:38:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:38:46 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 08:38:46 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:38:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:38:46 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:38:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:38:46 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:38:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:38:46 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:38:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:38:46 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:38:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 08:38:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:38:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:38:46 INFO - Expected file size: 21912989 08:38:51 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 08:38:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 08:38:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:38:51 INFO - Fetch https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:38:51 INFO - Expected file size: 21912989 08:38:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 08:38:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:38:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:38:56 INFO - Expected file size: 14414081 08:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:57 INFO - trying https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 08:38:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/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 08:38:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/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 08:38:58 INFO - Downloaded 63995540 bytes. 08:38:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 08:38:58 INFO - mkdir: /builds/slave/test/properties 08:38:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:38:58 INFO - Writing to file /builds/slave/test/properties/build_url 08:38:58 INFO - Contents: 08:38:58 INFO - build_url:https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 08:38:59 INFO - Running post-action listener: _resource_record_post_action 08:38:59 INFO - Running post-action listener: set_extra_try_arguments 08:38:59 INFO - [mozharness: 2016-10-25 15:38:59.599217Z] Finished download-and-extract step (success) 08:38:59 INFO - [mozharness: 2016-10-25 15:38:59.599445Z] Running populate-webroot step. 08:38:59 INFO - Running pre-action listener: _resource_record_pre_action 08:38:59 INFO - Running main action method: populate_webroot 08:38:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:38:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:38:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:38:59 INFO - '--tppagecycles', 08:38:59 INFO - '7'], 08:38:59 INFO - 'tests': ['tsvgm']}}, 08:38:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:38:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:38:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:38:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:38:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:38:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:38:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:59 INFO - 'talos_options': ['--disable-e10s'], 08:38:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:38:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:38:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:59 INFO - 'talos_options': ['--disable-e10s'], 08:38:59 INFO - 'tests': ['damp', 'tps']}, 08:38:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:59 INFO - 'tests': ['damp', 'tps']}, 08:38:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:38:59 INFO - 'tests': ['dromaeo_dom']}, 08:38:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:38:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:38:59 INFO - 'tests': ['basic_compositor_video']}, 08:38:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:38:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:38:59 INFO - 'tests': ['a11yr', 08:38:59 INFO - 'ts_paint', 08:38:59 INFO - 'tpaint', 08:38:59 INFO - 'sessionrestore', 08:38:59 INFO - 'sessionrestore_no_auto_restore', 08:38:59 INFO - 'tabpaint']}, 08:38:59 INFO - 'other-e10s': {'tests': ['a11yr', 08:38:59 INFO - 'ts_paint', 08:38:59 INFO - 'tpaint', 08:38:59 INFO - 'sessionrestore', 08:38:59 INFO - 'sessionrestore_no_auto_restore', 08:38:59 INFO - 'tabpaint']}, 08:38:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:38:59 INFO - 'ts_paint', 08:38:59 INFO - 'tpaint', 08:38:59 INFO - 'sessionrestore', 08:38:59 INFO - 'sessionrestore_no_auto_restore', 08:38:59 INFO - 'tabpaint']}, 08:38:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:38:59 INFO - 'ts_paint', 08:38:59 INFO - 'tpaint', 08:38:59 INFO - 'sessionrestore', 08:38:59 INFO - 'sessionrestore_no_auto_restore', 08:38:59 INFO - 'tabpaint']}, 08:38:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:38:59 INFO - 'tests': ['a11yr', 08:38:59 INFO - 'ts_paint', 08:38:59 INFO - 'tpaint', 08:38:59 INFO - 'sessionrestore', 08:38:59 INFO - 'sessionrestore_no_auto_restore', 08:38:59 INFO - 'tabpaint']}, 08:38:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:38:59 INFO - 'tests': ['a11yr', 08:38:59 INFO - 'ts_paint', 08:38:59 INFO - 'tpaint', 08:38:59 INFO - 'sessionrestore', 08:38:59 INFO - 'sessionrestore_no_auto_restore', 08:38:59 INFO - 'tabpaint']}, 08:38:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:38:59 INFO - 'tests': ['tsvgx', 08:38:59 INFO - 'tsvgr_opacity', 08:38:59 INFO - 'tart', 08:38:59 INFO - 'tscrollx', 08:38:59 INFO - 'cart']}, 08:38:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:38:59 INFO - 'tsvgr_opacity', 08:38:59 INFO - 'tart', 08:38:59 INFO - 'tscrollx', 08:38:59 INFO - 'cart']}, 08:38:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:59 INFO - 'talos_options': ['--disable-e10s'], 08:38:59 INFO - 'tests': ['tp5o']}, 08:38:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:59 INFO - 'tests': ['tp5o']}, 08:38:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:59 INFO - 'talos_options': ['--disable-e10s', 08:38:59 INFO - '--xperf_path', 08:38:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:38:59 INFO - 'tests': ['tp5n']}, 08:38:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:59 INFO - 'talos_options': ['--xperf_path', 08:38:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:38:59 INFO - 'tests': ['tp5n']}}, 08:38:59 INFO - 'talos.zip': {'path': '', 08:38:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:38:59 INFO - Running post-action listener: _resource_record_post_action 08:38:59 INFO - [mozharness: 2016-10-25 15:38:59.621689Z] Finished populate-webroot step (success) 08:38:59 INFO - [mozharness: 2016-10-25 15:38:59.621778Z] Running create-virtualenv step. 08:38:59 INFO - Running pre-action listener: _resource_record_pre_action 08:38:59 INFO - Running main action method: create_virtualenv 08:38:59 INFO - Creating virtualenv /builds/slave/test/build/venv 08:38:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:38:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:38:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:38:59 INFO - Using real prefix '/usr' 08:38:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:39:00 INFO - Installing distribute.............................................................................................................................................................................................done. 08:39:02 INFO - Installing pip.................done. 08:39:02 INFO - Return code: 0 08:39:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:02 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 0x7f01372d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263cf60>, '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 0x263dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e1d0>, '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': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:39:02 INFO - Using env: {'DISPLAY': ':0', 08:39:02 INFO - 'HOME': '/home/cltbld', 08:39:02 INFO - 'LANG': 'en_US.UTF-8', 08:39:02 INFO - 'LANGUAGE': 'en_US:en', 08:39:02 INFO - 'LOGNAME': 'cltbld', 08:39:02 INFO - 'MAIL': '/var/mail/cltbld', 08:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:02 INFO - 'MOZ_NO_REMOTE': '1', 08:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:02 INFO - 'NO_EM_RESTART': '1', 08:39:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:02 INFO - 'PWD': '/builds/slave/test', 08:39:02 INFO - 'SHELL': '/bin/bash', 08:39:02 INFO - 'SHLVL': '1', 08:39:02 INFO - 'TERM': 'linux', 08:39:02 INFO - 'TMOUT': '86400', 08:39:02 INFO - 'USER': 'cltbld', 08:39:02 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 08:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:02 INFO - '_': '/tools/buildbot/bin/python'} 08:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:39:02 INFO - Cleaning up... 08:39:02 INFO - Return code: 0 08:39:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:02 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 0x7f01372d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263cf60>, '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 0x263dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e1d0>, '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': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:39:02 INFO - Using env: {'DISPLAY': ':0', 08:39:02 INFO - 'HOME': '/home/cltbld', 08:39:02 INFO - 'LANG': 'en_US.UTF-8', 08:39:02 INFO - 'LANGUAGE': 'en_US:en', 08:39:02 INFO - 'LOGNAME': 'cltbld', 08:39:02 INFO - 'MAIL': '/var/mail/cltbld', 08:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:02 INFO - 'MOZ_NO_REMOTE': '1', 08:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:02 INFO - 'NO_EM_RESTART': '1', 08:39:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:02 INFO - 'PWD': '/builds/slave/test', 08:39:02 INFO - 'SHELL': '/bin/bash', 08:39:02 INFO - 'SHLVL': '1', 08:39:02 INFO - 'TERM': 'linux', 08:39:02 INFO - 'TMOUT': '86400', 08:39:02 INFO - 'USER': 'cltbld', 08:39:02 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 08:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:02 INFO - '_': '/tools/buildbot/bin/python'} 08:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:02 INFO - Downloading/unpacking psutil>=3.1.1 08:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:39:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:04 INFO - Installing collected packages: psutil 08:39:04 INFO - Running setup.py install for psutil 08:39:04 INFO - building 'psutil._psutil_linux' extension 08:39:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:39:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:39:04 INFO - building 'psutil._psutil_posix' extension 08:39:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:39:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:39:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:05 INFO - Successfully installed psutil 08:39:05 INFO - Cleaning up... 08:39:05 INFO - Return code: 0 08:39:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:05 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 0x7f01372d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263cf60>, '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 0x263dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e1d0>, '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': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:39:05 INFO - Using env: {'DISPLAY': ':0', 08:39:05 INFO - 'HOME': '/home/cltbld', 08:39:05 INFO - 'LANG': 'en_US.UTF-8', 08:39:05 INFO - 'LANGUAGE': 'en_US:en', 08:39:05 INFO - 'LOGNAME': 'cltbld', 08:39:05 INFO - 'MAIL': '/var/mail/cltbld', 08:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:05 INFO - 'MOZ_NO_REMOTE': '1', 08:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:05 INFO - 'NO_EM_RESTART': '1', 08:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:05 INFO - 'PWD': '/builds/slave/test', 08:39:05 INFO - 'SHELL': '/bin/bash', 08:39:05 INFO - 'SHLVL': '1', 08:39:05 INFO - 'TERM': 'linux', 08:39:05 INFO - 'TMOUT': '86400', 08:39:05 INFO - 'USER': 'cltbld', 08:39:05 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 08:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:05 INFO - '_': '/tools/buildbot/bin/python'} 08:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:39:07 INFO - Installing collected packages: mozsystemmonitor 08:39:07 INFO - Running setup.py install for mozsystemmonitor 08:39:07 INFO - Successfully installed mozsystemmonitor 08:39:07 INFO - Cleaning up... 08:39:07 INFO - Return code: 0 08:39:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:07 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 0x7f01372d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263cf60>, '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 0x263dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e1d0>, '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': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:39:07 INFO - Using env: {'DISPLAY': ':0', 08:39:07 INFO - 'HOME': '/home/cltbld', 08:39:07 INFO - 'LANG': 'en_US.UTF-8', 08:39:07 INFO - 'LANGUAGE': 'en_US:en', 08:39:07 INFO - 'LOGNAME': 'cltbld', 08:39:07 INFO - 'MAIL': '/var/mail/cltbld', 08:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:07 INFO - 'MOZ_NO_REMOTE': '1', 08:39:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:07 INFO - 'NO_EM_RESTART': '1', 08:39:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:07 INFO - 'PWD': '/builds/slave/test', 08:39:07 INFO - 'SHELL': '/bin/bash', 08:39:07 INFO - 'SHLVL': '1', 08:39:07 INFO - 'TERM': 'linux', 08:39:07 INFO - 'TMOUT': '86400', 08:39:07 INFO - 'USER': 'cltbld', 08:39:07 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 08:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:07 INFO - '_': '/tools/buildbot/bin/python'} 08:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:07 INFO - Downloading/unpacking jsonschema==2.5.1 08:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:39:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:09 INFO - Downloading functools32-3.2.3-2.tar.gz 08:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:39:09 INFO - warning: no files found matching '*.txt' 08:39:09 INFO - no previously-included directories found matching 'build' 08:39:09 INFO - no previously-included directories found matching 'dist' 08:39:09 INFO - no previously-included directories found matching '.git*' 08:39:09 INFO - Installing collected packages: jsonschema, functools32 08:39:09 INFO - Running setup.py install for functools32 08:39:10 INFO - warning: no files found matching '*.txt' 08:39:10 INFO - no previously-included directories found matching 'build' 08:39:10 INFO - no previously-included directories found matching 'dist' 08:39:10 INFO - no previously-included directories found matching '.git*' 08:39:10 INFO - Successfully installed jsonschema functools32 08:39:10 INFO - Cleaning up... 08:39:10 INFO - Return code: 0 08:39:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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', '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 0x7f01372d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263cf60>, '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 0x263dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e1d0>, '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': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:39: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 functools32==3.2.3-2 08:39:10 INFO - Using env: {'DISPLAY': ':0', 08:39:10 INFO - 'HOME': '/home/cltbld', 08:39:10 INFO - 'LANG': 'en_US.UTF-8', 08:39:10 INFO - 'LANGUAGE': 'en_US:en', 08:39:10 INFO - 'LOGNAME': 'cltbld', 08:39:10 INFO - 'MAIL': '/var/mail/cltbld', 08:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:10 INFO - 'MOZ_NO_REMOTE': '1', 08:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:10 INFO - 'NO_EM_RESTART': '1', 08:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:10 INFO - 'PWD': '/builds/slave/test', 08:39:10 INFO - 'SHELL': '/bin/bash', 08:39:10 INFO - 'SHLVL': '1', 08:39:10 INFO - 'TERM': 'linux', 08:39:10 INFO - 'TMOUT': '86400', 08:39:10 INFO - 'USER': 'cltbld', 08:39:10 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 08:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:10 INFO - '_': '/tools/buildbot/bin/python'} 08:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:39:10 INFO - Cleaning up... 08:39:10 INFO - Return code: 0 08:39:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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', '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 0x7f01372d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263cf60>, '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 0x263dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e1d0>, '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': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:39: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 blobuploader==1.2.4 08:39:10 INFO - Using env: {'DISPLAY': ':0', 08:39:10 INFO - 'HOME': '/home/cltbld', 08:39:10 INFO - 'LANG': 'en_US.UTF-8', 08:39:10 INFO - 'LANGUAGE': 'en_US:en', 08:39:10 INFO - 'LOGNAME': 'cltbld', 08:39:10 INFO - 'MAIL': '/var/mail/cltbld', 08:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:10 INFO - 'MOZ_NO_REMOTE': '1', 08:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:10 INFO - 'NO_EM_RESTART': '1', 08:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:10 INFO - 'PWD': '/builds/slave/test', 08:39:10 INFO - 'SHELL': '/bin/bash', 08:39:10 INFO - 'SHLVL': '1', 08:39:10 INFO - 'TERM': 'linux', 08:39:10 INFO - 'TMOUT': '86400', 08:39:10 INFO - 'USER': 'cltbld', 08:39:10 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 08:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:10 INFO - '_': '/tools/buildbot/bin/python'} 08:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:10 INFO - Downloading/unpacking blobuploader==1.2.4 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39:12 INFO - Downloading blobuploader-1.2.4.tar.gz 08:39:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:39:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:39:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:13 INFO - Downloading docopt-0.6.1.tar.gz 08:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:39:13 INFO - Installing collected packages: blobuploader, requests, docopt 08:39:13 INFO - Running setup.py install for blobuploader 08:39:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:39:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:39:13 INFO - Running setup.py install for requests 08:39:13 INFO - Running setup.py install for docopt 08:39:13 INFO - Successfully installed blobuploader requests docopt 08:39:13 INFO - Cleaning up... 08:39:13 INFO - Return code: 0 08:39:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:13 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 0x7f01372d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263cf60>, '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 0x263dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e1d0>, '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': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:39:13 INFO - Using env: {'DISPLAY': ':0', 08:39:13 INFO - 'HOME': '/home/cltbld', 08:39:13 INFO - 'LANG': 'en_US.UTF-8', 08:39:13 INFO - 'LANGUAGE': 'en_US:en', 08:39:13 INFO - 'LOGNAME': 'cltbld', 08:39:13 INFO - 'MAIL': '/var/mail/cltbld', 08:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:13 INFO - 'MOZ_NO_REMOTE': '1', 08:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:13 INFO - 'NO_EM_RESTART': '1', 08:39:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:13 INFO - 'PWD': '/builds/slave/test', 08:39:13 INFO - 'SHELL': '/bin/bash', 08:39:13 INFO - 'SHLVL': '1', 08:39:13 INFO - 'TERM': 'linux', 08:39:13 INFO - 'TMOUT': '86400', 08:39:13 INFO - 'USER': 'cltbld', 08:39:13 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 08:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:13 INFO - '_': '/tools/buildbot/bin/python'} 08:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:14 INFO - Running setup.py (path:/tmp/pip-eVZVLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:14 INFO - Running setup.py (path:/tmp/pip-AGnJxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:14 INFO - Running setup.py (path:/tmp/pip-owH81e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:14 INFO - Running setup.py (path:/tmp/pip-mFxWJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:14 INFO - Running setup.py (path:/tmp/pip-ZX9DGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:14 INFO - Running setup.py (path:/tmp/pip-42SHJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:14 INFO - Running setup.py (path:/tmp/pip-Pw89qB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:14 INFO - Running setup.py (path:/tmp/pip-aQTbNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:14 INFO - Running setup.py (path:/tmp/pip-MSUnAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:14 INFO - Running setup.py (path:/tmp/pip-tkFkNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:14 INFO - Running setup.py (path:/tmp/pip-FQdvGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:14 INFO - Running setup.py (path:/tmp/pip-1Lifmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:14 INFO - Running setup.py (path:/tmp/pip-aT6LM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:15 INFO - Running setup.py (path:/tmp/pip-JKI3Y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:15 INFO - Running setup.py (path:/tmp/pip-ybkWlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:15 INFO - Running setup.py (path:/tmp/pip-oleLiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:15 INFO - Running setup.py (path:/tmp/pip-E1a_GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:39:15 INFO - Running setup.py install for manifestparser 08:39:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:39:15 INFO - Running setup.py install for mozcrash 08:39:15 INFO - Running setup.py install for mozdebug 08:39:15 INFO - Running setup.py install for mozdevice 08:39:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:39:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:39:15 INFO - Running setup.py install for mozfile 08:39:15 INFO - Running setup.py install for mozhttpd 08:39:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:39:15 INFO - Running setup.py install for mozinfo 08:39:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:39:15 INFO - Running setup.py install for mozInstall 08:39:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:39:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:39:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:39:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:39:16 INFO - Running setup.py install for mozleak 08:39:16 INFO - Running setup.py install for mozlog 08:39:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:39:16 INFO - Running setup.py install for moznetwork 08:39:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:39:16 INFO - Running setup.py install for mozprocess 08:39:16 INFO - Running setup.py install for mozprofile 08:39:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:39:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:39:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:39:16 INFO - Running setup.py install for mozrunner 08:39:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:39:16 INFO - Running setup.py install for mozscreenshot 08:39:16 INFO - Running setup.py install for moztest 08:39:16 INFO - Running setup.py install for mozversion 08:39:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:39:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:39:17 INFO - Cleaning up... 08:39:17 INFO - Return code: 0 08:39:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:17 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 0x7f01372d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263cf60>, '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 0x263dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e1d0>, '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': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:39:17 INFO - Using env: {'DISPLAY': ':0', 08:39:17 INFO - 'HOME': '/home/cltbld', 08:39:17 INFO - 'LANG': 'en_US.UTF-8', 08:39:17 INFO - 'LANGUAGE': 'en_US:en', 08:39:17 INFO - 'LOGNAME': 'cltbld', 08:39:17 INFO - 'MAIL': '/var/mail/cltbld', 08:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:17 INFO - 'MOZ_NO_REMOTE': '1', 08:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:17 INFO - 'NO_EM_RESTART': '1', 08:39:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:17 INFO - 'PWD': '/builds/slave/test', 08:39:17 INFO - 'SHELL': '/bin/bash', 08:39:17 INFO - 'SHLVL': '1', 08:39:17 INFO - 'TERM': 'linux', 08:39:17 INFO - 'TMOUT': '86400', 08:39:17 INFO - 'USER': 'cltbld', 08:39:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 08:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:17 INFO - '_': '/tools/buildbot/bin/python'} 08:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:17 INFO - Running setup.py (path:/tmp/pip-nEw69D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:17 INFO - Running setup.py (path:/tmp/pip-DuM9Md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:17 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)) 08:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:17 INFO - Running setup.py (path:/tmp/pip-e1oYkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:17 INFO - Running setup.py (path:/tmp/pip-KM4m_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:17 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)) 08:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:17 INFO - Running setup.py (path:/tmp/pip-bZ6j7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:17 INFO - Running setup.py (path:/tmp/pip-4Yzp7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:17 INFO - Running setup.py (path:/tmp/pip-ZGYpXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:17 INFO - Running setup.py (path:/tmp/pip-2o7t3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:17 INFO - Running setup.py (path:/tmp/pip-Y6m_jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:17 INFO - Running setup.py (path:/tmp/pip-Uuwh5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:18 INFO - Running setup.py (path:/tmp/pip-eFer57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:18 INFO - Running setup.py (path:/tmp/pip-Aaa68h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:18 INFO - Running setup.py (path:/tmp/pip-3BjaoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:18 INFO - Running setup.py (path:/tmp/pip-aq6Cce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:18 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)) 08:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:18 INFO - Running setup.py (path:/tmp/pip-hqrPNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:18 INFO - Running setup.py (path:/tmp/pip-SiY1dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:18 INFO - Running setup.py (path:/tmp/pip-IbAS8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:39:18 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)) 08:39:18 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)) 08:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:39:18 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)) 08:39:18 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)) 08:39:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39:20 INFO - Downloading blessings-1.6.tar.gz 08:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:39:20 INFO - Installing collected packages: blessings 08:39:20 INFO - Running setup.py install for blessings 08:39:20 INFO - Successfully installed blessings 08:39:20 INFO - Cleaning up... 08:39:20 INFO - Return code: 0 08:39:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:39:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:20 INFO - Reading from file tmpfile_stdout 08:39:20 INFO - Current package versions: 08:39:20 INFO - argparse == 1.2.1 08:39:20 INFO - blessings == 1.6 08:39:20 INFO - blobuploader == 1.2.4 08:39:20 INFO - docopt == 0.6.1 08:39:20 INFO - functools32 == 3.2.3-2 08:39:20 INFO - jsonschema == 2.5.1 08:39:20 INFO - manifestparser == 1.1 08:39:20 INFO - mozInstall == 1.12 08:39:20 INFO - mozcrash == 0.17 08:39:20 INFO - mozdebug == 0.1 08:39:20 INFO - mozdevice == 0.48 08:39:20 INFO - mozfile == 1.2 08:39:20 INFO - mozhttpd == 0.7 08:39:20 INFO - mozinfo == 0.9 08:39:20 INFO - mozleak == 0.1 08:39:20 INFO - mozlog == 3.4 08:39:20 INFO - moznetwork == 0.27 08:39:20 INFO - mozprocess == 0.23 08:39:20 INFO - mozprofile == 0.28 08:39:20 INFO - mozrunner == 6.12 08:39:20 INFO - mozscreenshot == 0.1 08:39:20 INFO - mozsystemmonitor == 0.3 08:39:20 INFO - moztest == 0.7 08:39:20 INFO - mozversion == 1.4 08:39:20 INFO - psutil == 3.1.1 08:39:20 INFO - requests == 1.2.3 08:39:20 INFO - wsgiref == 0.1.2 08:39:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:20 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 0x7f01372d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263cf60>, '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 0x263dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e1d0>, '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': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:39:20 INFO - Using env: {'DISPLAY': ':0', 08:39:20 INFO - 'HOME': '/home/cltbld', 08:39:20 INFO - 'LANG': 'en_US.UTF-8', 08:39:20 INFO - 'LANGUAGE': 'en_US:en', 08:39:20 INFO - 'LOGNAME': 'cltbld', 08:39:20 INFO - 'MAIL': '/var/mail/cltbld', 08:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:20 INFO - 'MOZ_NO_REMOTE': '1', 08:39:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:20 INFO - 'NO_EM_RESTART': '1', 08:39:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:20 INFO - 'PWD': '/builds/slave/test', 08:39:20 INFO - 'SHELL': '/bin/bash', 08:39:20 INFO - 'SHLVL': '1', 08:39:20 INFO - 'TERM': 'linux', 08:39:20 INFO - 'TMOUT': '86400', 08:39:20 INFO - 'USER': 'cltbld', 08:39:20 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 08:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:20 INFO - '_': '/tools/buildbot/bin/python'} 08:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:39:21 INFO - Cleaning up... 08:39:21 INFO - Return code: 0 08:39:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:21 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 0x7f01372d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263cf60>, '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 0x263dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e1d0>, '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': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:39:21 INFO - Using env: {'DISPLAY': ':0', 08:39:21 INFO - 'HOME': '/home/cltbld', 08:39:21 INFO - 'LANG': 'en_US.UTF-8', 08:39:21 INFO - 'LANGUAGE': 'en_US:en', 08:39:21 INFO - 'LOGNAME': 'cltbld', 08:39:21 INFO - 'MAIL': '/var/mail/cltbld', 08:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:21 INFO - 'MOZ_NO_REMOTE': '1', 08:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:21 INFO - 'NO_EM_RESTART': '1', 08:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:21 INFO - 'PWD': '/builds/slave/test', 08:39:21 INFO - 'SHELL': '/bin/bash', 08:39:21 INFO - 'SHLVL': '1', 08:39:21 INFO - 'TERM': 'linux', 08:39:21 INFO - 'TMOUT': '86400', 08:39:21 INFO - 'USER': 'cltbld', 08:39:21 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 08:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:21 INFO - '_': '/tools/buildbot/bin/python'} 08:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:39:21 INFO - Cleaning up... 08:39:21 INFO - Return code: 0 08:39:21 INFO - Running post-action listener: _resource_record_post_action 08:39:21 INFO - Running post-action listener: _start_resource_monitoring 08:39:21 INFO - Starting resource monitoring. 08:39:21 INFO - [mozharness: 2016-10-25 15:39:21.388470Z] Finished create-virtualenv step (success) 08:39:21 INFO - [mozharness: 2016-10-25 15:39:21.388916Z] Running install step. 08:39:21 INFO - Running pre-action listener: _resource_record_pre_action 08:39:21 INFO - Running main action method: install 08:39:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:21 INFO - Reading from file tmpfile_stdout 08:39:21 INFO - Detecting whether we're running mozinstall >=1.0... 08:39:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:39:21 INFO - Reading from file tmpfile_stdout 08:39:21 INFO - Output received: 08:39:21 INFO - Usage: mozinstall [options] installer 08:39:21 INFO - Options: 08:39:21 INFO - -h, --help show this help message and exit 08:39:21 INFO - -d DEST, --destination=DEST 08:39:21 INFO - Directory to install application into. [default: 08:39:21 INFO - "/builds/slave/test"] 08:39:21 INFO - --app=APP Application being installed. [default: firefox] 08:39:21 INFO - mkdir: /builds/slave/test/build/application 08:39:21 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'] 08:39:21 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 08:39:37 INFO - Reading from file tmpfile_stdout 08:39:37 INFO - Output received: 08:39:37 INFO - /builds/slave/test/build/application/firefox/firefox 08:39:37 INFO - Running post-action listener: _resource_record_post_action 08:39:37 INFO - [mozharness: 2016-10-25 15:39:37.650358Z] Finished install step (success) 08:39:37 INFO - [mozharness: 2016-10-25 15:39:37.650692Z] Running run-tests step. 08:39:37 INFO - Running pre-action listener: _resource_record_pre_action 08:39:37 INFO - Running main action method: run_tests 08:39:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:39:37 INFO - Python 2.7.3 08:39:37 INFO - Return code: 0 08:39:37 INFO - grabbing minidump binary from tooltool 08:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:37 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 0x263cf60>, '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 0x263dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:39:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:39:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:39:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:39:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:39:37 INFO - Return code: 0 08:39:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:39:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:39:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:39:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:39:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:39:37 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/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 08:39:37 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/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 08:39:37 INFO - Using env: {'DISPLAY': ':0', 08:39:37 INFO - 'HOME': '/home/cltbld', 08:39:37 INFO - 'LANG': 'en_US.UTF-8', 08:39:37 INFO - 'LANGUAGE': 'en_US:en', 08:39:37 INFO - 'LOGNAME': 'cltbld', 08:39:37 INFO - 'MAIL': '/var/mail/cltbld', 08:39:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:39:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:39:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:37 INFO - 'MOZ_NO_REMOTE': '1', 08:39:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:39:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:37 INFO - 'NO_EM_RESTART': '1', 08:39:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:37 INFO - 'PWD': '/builds/slave/test', 08:39:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:39:37 INFO - 'SHELL': '/bin/bash', 08:39:37 INFO - 'SHLVL': '1', 08:39:37 INFO - 'TERM': 'linux', 08:39:37 INFO - 'TMOUT': '86400', 08:39:37 INFO - 'USER': 'cltbld', 08:39:37 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894', 08:39:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:37 INFO - '_': '/tools/buildbot/bin/python'} 08:39:37 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/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 08:39:37 INFO - mozversion application_buildid: 20161025054420 08:39:37 INFO - mozversion application_changeset: b82a286b69e040dc2e8f180e33cffd25f7a09ff4 08:39:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:39:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:39:37 INFO - mozversion application_name: Firefox 08:39:37 INFO - mozversion application_remotingname: firefox-dev 08:39:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:39:37 INFO - mozversion application_vendor: Mozilla 08:39:37 INFO - mozversion application_version: 51.0a2 08:39:37 INFO - mozversion platform_buildid: 20161025054420 08:39:37 INFO - mozversion platform_changeset: b82a286b69e040dc2e8f180e33cffd25f7a09ff4 08:39:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:39:37 INFO - mozversion platform_version: 51.0a2 08:39:37 INFO - using testdate: 1477409977 08:39:37 INFO - actual date: 1477409977 08:39:37 INFO - starting webserver on 'localhost:53417' 08:39:37 INFO - SUITE-START | Running 2 tests 08:39:37 INFO - TEST-START | dromaeo_css 08:39:37 INFO - operating with platform_type : linux_ 08:39:37 INFO - Initialising browser for dromaeo_css test... 08:39:37 INFO - TEST-INFO | started process 11283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRH3klp/profile http://localhost:53417/getInfo.html) 08:39:42 INFO - PROCESS | 11283 | __metrics Screen width/height:1600/1200 08:39:42 INFO - PROCESS | 11283 | colorDepth:24 08:39:42 INFO - PROCESS | 11283 | Browser inner width/height: 1024/697 08:39:42 INFO - PROCESS | 11283 | __metrics 08:39:42 INFO - PROCESS | 11283 | 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" 08:39:42 INFO - PROCESS | 11283 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:39:43 INFO - PROCESS | 11283 | console.error: PushService: 08:39:43 INFO - PROCESS | 11283 | stateChangeProcessEnqueue: Error transitioning state 08:39:43 INFO - PROCESS | 11283 | UnknownError 08:39:43 INFO - TEST-INFO | 11283: exit 0 08:39:43 INFO - Browser initialized. 08:39:43 INFO - Running cycle 1/1 for dromaeo_css test... 08:39:43 INFO - TEST-INFO | started process 11373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRH3klp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:55 INFO - PROCESS | 11373 | RSS: Main: 144928768 08:39:55 INFO - PROCESS | 11373 | 08:40:46 INFO - PROCESS | 11373 | 1477410046740 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] 08:42:56 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:53417/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53417/tests/dromaeo/cssquery-ext.html) 08:42:57 INFO - PROCESS | 11373 | RSS: Main: 250236928 08:42:57 INFO - PROCESS | 11373 | 08:45:59 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:53417/tests/dromaeo/cssquery-ext.html (next: http://localhost:53417/tests/dromaeo/cssquery-jquery.html) 08:45:59 INFO - PROCESS | 11373 | RSS: Main: 228421632 08:45:59 INFO - PROCESS | 11373 | 08:49:01 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:53417/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53417/tests/dromaeo/cssquery-mootools.html) 08:49:02 INFO - PROCESS | 11373 | RSS: Main: 173727744 08:49:02 INFO - PROCESS | 11373 | 08:52:04 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:53417/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53417/tests/dromaeo/cssquery-prototype.html) 08:52:04 INFO - PROCESS | 11373 | RSS: Main: 202342400 08:52:04 INFO - PROCESS | 11373 | 08:55:07 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:53417/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53417/tests/dromaeo/cssquery-yui.html) 08:55:08 INFO - PROCESS | 11373 | RSS: Main: 173985792 08:55:08 INFO - PROCESS | 11373 | 08:58:10 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:53417/tests/dromaeo/cssquery-yui.html (next: http://localhost:53417/tests/dromaeo/cssquery-dojo.html) 08:58:10 INFO - PROCESS | 11373 | RSS: Main: 268349440 08:58:10 INFO - PROCESS | 11373 | 08:58:10 INFO - PROCESS | 11373 | __start_tp_report 08:58:10 INFO - PROCESS | 11373 | _x_x_mozilla_page_load 08:58:10 INFO - PROCESS | 11373 | _x_x_mozilla_page_load_details 08:58:10 INFO - PROCESS | 11373 | |i|pagename|runs| 08:58:10 INFO - PROCESS | 11373 | |0;dojo.html;3201.5037669161275;3237.417264892319;3245.058932909455;3266;3285.523599078134;5648.8587785305335;5702.087665973445;5715.257016587843;5746.626469279504;5755.798547050854;5703.828885133442;5759.049756790125;5760.2511673482495;5766.769329226826;5770.682612456324;5215.5566776823825;5221.530062294383;5231.267622532849;5246.081935661263;5292.232626269189;5102.668326558762;5124.308218390507;5298.4436634153435;5303.549198318147;5332.893342133155;5114.744262786864;5146.897062058757;5164.690118592896;5183.792648294064;5198.7660555274915;5209.348831396075;5221.895562088756;5281.63028587999;5290.100682883919;5310.283111779899;4953.4303555091265;5062.924056139161;5180.222966555047;5205.843824685227;5266.7366631668265;5532.861678458031;5535.474129957647;5547.472990065938;5551.278333816578;5576.609637325389;5945.1973983512535;6050.455459008666;6072.635641861502;6074.908876366858;6077.604955677867;5919.644821310735;5995.040793473024;6113.358097399798;6121.173641558377;6121.846953826145;5588.189712491707;5649.06790379591;5654.46282603152;5666.631668941547;5685.545156387479;6225.750969961241;6226.439620434183;6229.283632382243;6232.750689972441;6237.625742455467;5870.178175055496;5921.851953701192;5969.641821490724;5974.9402505974385;5981.641101533922;5855.648661080349;5903.0555111182;5903.557233207441;5919.940800592025;5967.671778052249;5890.970545147246;5891.116332550066;5894.145348924382;5898.734556944948;5900.4099590041515;5846.444587764156;5911.852203694942;5914.083317085859;5930.8813823723285;5941.316748573883;4603.654725895504;4607.124646317189;4649.163150632851;4652.418447694038;4677.32178834074;4148.605882441163;4152.397902304209;4159.896002599899;4163.500379954425;4184.539700632928;5797.072468405035;5802.187693722883;5803.158542011384;5807;5841.240638716939;5962.046072628359;6016.909746353808;6054.243219597551;6089.2997305310455;6118.969405153035;5825.88348233033;5828.12578113278;5828.446297601721;5828.854278643068;5840.8539786504825;5322.175062865262;5325.627206095536;5334.626576139633;5337.626366154332;5338.172583249602;6129.35641757609;6167.167432396659;6170.167027451236;6191.25704915413;6306.747730090837;6092.147099406176;6100.1154832548145;6118.680093383066;6124.350421260821;6124.8775024500155;6240.567687771798;6292.590981586182;6292.842678933063;6300.495960323255;6304.65324407162;5818.76724930998;5867.882642347044;5921.348651648229;6015.248093988252;6018.969905150446;5992.910106348321;6105.3894610540365;6110.205673262448;6149.907751383822;6150.169727086786;5909.852253693692;5952.910706339495;5953.434423729739;5958.672273025025;5974.551908606959;5829.854253643693;5892.734826932712;5941.197938278277;5963.165156877953;5969.313528944053;5815.185873977562;5868.471837534642;5920.644761314335;5924.703764811656;6005.339412664691;6054.182685337423;6055.939440605537;6056.788012419721;6060.424259695322;6065.272167339947;5715.9142612860005;5730.656160630376;5803.158542011469;5886.087656413263;5898.321693005188 08:58:10 INFO - PROCESS | 11373 | |1;ext.html;565.2708006671394;590.1649166429503;614.3579958942908;620.8044465993212;637.0794202377566;35659.821700891494;36450;38380;38567;38687.22625547491;47362;48721.269180962314;48819.26771098428;52367.476325236734;52393.214101788406;9359.20446762026;9503;9506.524673766284;9508.952455237713;9511.619535218582;8574.871376929352;8782.824343513126;9434.386764860263;9525.047495250454;9535.570899309512;11088.55645774172;11362.261453005569;11367.658970230865;11786.35175065371;11807.704807379798;11304.717382065432;11349.546018159304;11406.42967851604;11407.429628518625;11424.086073114215;8492.193241642035;8716.215540601313;10797.136229101652;11234.269772464764;11307.773844523064;42724.359134613005;46494;46570.5342946573;46579.53420465786;46608;3713.3687273163355;3721.5534135903595;3767.924641507182;3906.2968665640174;4495.887602809923;34108.48837267418;34307.82846085779;34678.47982280268;34836.65163348359;34878.825605872065;4563.338315944203;4571.497135315112;4683.320918466803;4710.128626204163;4714.080754252922;383623.9999999972;384057;384200;385137;385866;64092;64362;64649.67675161594;64743.35256647468;64773.35226647673;67623;67633.66183169052;67702.66148669324;67791.3220867785;68024.3197568018;18405.53986150357;18850.434486965412;18853.90573047126;18861.90569047146;18862.71705924412;14744.852551474563;14856.92571537157;14862.033967792275;14866.554003379915;14874.776878346833;15942.681146377008;16455.177241138135;16839.32642694303;17523;18044;6137.938620613826;6406.711697973602;6502.536929190989;6505.282920885941;6539.182602174728;1017.7862648843677;1081.1296905990753;1114.3425379026414;1141.1270378160714;1159.287038471334;34794.30411391758;34881.47677784835;34984.300313993575;35171.64828351735;35431;1097.665212110298;1104.4091411095026;1192.7316353820495;1200.7118291610125;1228.7419641875128;17151.313947441962;18186.63626727458;18390.264389424272;18395;18441.1701473434;559031;562950;565987;566302;566555;63382.68308658427;63563.68218158972;63678;63698;63769.68115159395;1398.2519352146553;1415.4409008441608;1426.3866537388815;1433.4624515806572;1442.8412874583787;32808;33717.83141084279;34006.48990265099;34448.82775586106;34777.82611086928;55838.16242756443;56188.719056406095;56418;56472.71763641156;56504;488124;488233;491239;493168;493599;37449.6255037457;38535.6146438532;40532.3920141204;40839.38740918948;43936;52881;52969.735151324;53207.4679253218;53324;53913.19130213129;43298.35052474152;44476.55523444853;45308;46052.7697361511;46989.295160571935;44873.32690009718;45353.546464534935;45445;45534;46466.30300545427;43772.78113609411;44558;44629.33056004097;44737.23671188435;45125;36960.815195923846;39696.603033970445;40115;40164.1967160661;40539.594604053585;30272.697273026988;30336.241593960327;30551.694483054885;30598;30609.23476913006 08:58:10 INFO - PROCESS | 11373 | |2;jquery.html;399.09405649176387;404.7086098009436;435.2448501849291;435.30351437699676;435.40132318062666;15922.601934951632;19943.30198443055;21378;22096.447588810286;22222;19365;19955.900220498912;20039.298624548144;20650.277240296593;20705.792942070613;5510.586705997056;5682.829515114532;5687.687177205252;5694.943050569504;5770.365259821438;6055.273367195942;6061.212042434499;6079.240094988127;6137.232845894263;6234.594751341148;5539.861503462405;5562.610617256773;6046.1837651917085;6047.213862197908;6050.636961782285;5641.633293835887;5676.602637815355;5681.630694004876;5682.346530149024;5685.061964775828;5326.334208223972;5456.8090116846115;5518.834434966958;5531.25328080708;5537.861553461155;13816.654583635389;14109.78835317471;14861.331240094221;14968.251587420586;15016.324265408082;2298;2344;2513.710923243832;2720.0071973729646;2996.310848504856;10418.635347762867;10500.2649814513;10526.578936842518;10548.261621686484;11314.773704525946;1966.1742068331334;1993.9601207975904;2058.1561559760426;2070.710100585904;2114.302280247515;85410.57294713486;89412;89994.5500272501;91617;92903.07096929011;10990.395528245863;12164.69588260283;12174.452149653287;12250.938745306217;12265.816012759815;15182.620434489005;16011.119388433515;16706.49880503587;16831.41090061842;17361.826381736275;8721.30229581632;8781.560921953876;8962.551872406484;9037.231835294073;9087;8548.529830859237;8732.58866321615;8794.164554367326;8971.865422018675;9012.684556040507;5130.12787826063;5195.532402083831;5217.321748172789;5241.187615919539;5347.304850369427;2058.217877206652;2158.7949144831214;2169.2516081951703;2180.9890950545464;2185.967210491844;964.9372790768577;992.6476100984191;993.7267251505749;1069.6095924987324;1074.5970261152067;20007.299744509164;20077.39767806939;20204.59590808205;20921.37235882926;21173.576528469344;968.588349951282;975.5366201054584;1002.6240159940022;1021.2646894236138;1026.7997740440542;10995.615153469591;11769.234999724991;11848.348340841336;11941.880581194251;12031.518739250507;485851;496354;525236;547713;555463;98751.50624246977;99692;99952.50023749835;101205.49397252967;103197.48401257946;1000.6847842929454;1000.9899901001043;1016.4257194684832;1023.1150055202345;1023.1405619279841;17974.5506362342;18316.908415457838;18464.35374761877;18640.440786776417;18666.906665466584;33533.83233083916;40981.79509102435;42898.14203715846;43773.78113109414;46343;56106;57908;59441.405585945315;59538.70230648819;61846.69076654588;8065.314448271963;8927.598258078273;9186.678466253648;9211.078892110736;9234.676786312446;12249.203801752858;13654;14039.789403158757;14169.645758856112;14401.207933563335;11737.706557336134;11771;11973.640790776291;12322.75354492923;12365.07261955375;11056.502457389275;11477.196596238517;11635.47640356169;11954.342511161969;12229.816552751894;11828;11887.524499019943;11950.103742219195;12454.25274483534;12516.186447880858;8795.47227166372;8956.925168979764;9204.631814727336;9215.723528294162;9226.861597075915;11773.76452470963;12198.14612977083;12257.69355766113;12316.384180790745;12469.75060498803 08:58:10 INFO - PROCESS | 11373 | |3;mootools.html;1500.9399624015043;1520.5970417839274;1677.4212896550694;1775.6803775320436;1811.864110191735;9200.769980750485;9987.950060249688;9993.250506212045;10004;10006.049425304584;8394.874076888851;8705.390622656416;9109.635614575409;9404.388714733555;9416.81166376672;2605.3747100695837;2642.7357264273514;2642.8282161659527;2643.629891815138;2643.6563246777987;2536.5941449368106;2620.6724159480063;2622.423066925283;2624.3701511637164;2626.842389456629;2579.61305804129;2587.2884956636885;2604.0234911908033;2605.5179791738587;2607.713151553337;2537.568613335728;2547.337692200023;2573;2573.4209802794408;2582.302778249862;2512.836665616729;2523.470071285032;2535.5055764126005;2575.0601030623875;2580.458103798205;9699.321047526675;9782.75543111428;9805.264605154642;9818;9818.361806482555;5801;5955.315138759055;5961.582689211757;5974.402559744034;5980.940190598082;3491.0923159978333;3617.728670349708;3645.398509245971;3662.4689420033947;3678.8528458861615;1249.8250244965711;1269.0672355818558;1287.34345483803;1305.1255658708687;1309.6660351610374;13462.326883655778;13468.663283417993;13506.527271545448;13514.391852366667;13634.181949082988;5123.129068058439;5195;5328.040952628487;5372.543333816591;5412.83761487156;11506.19456638044;11519.136064795173;11530.59642912494;11542.365169915734;11548;5956.821295361146;5963.165156878041;5963.731632076567;5980.461758441674;5985.311689155803;4656;4789.592884604778;5124.48755124492;5169.767360468788;5472.20653005312;4338.696291259582;4370.104128653682;4446.799894004777;4487.214737420938;4494.797734101973;1413.1238632048196;1414.2221778022047;1429.335359058043;1431.5991522373752;1439.2731670506328;962.9744322296732;1012.377387906447;1025.6769117727893;1040.661784919904;1045.6549338718205;6497.740090396425;6560.770373036921;6582.17722784652;6621.801345959629;6775.186977562724;482.6862539349451;483.93224948507236;484.92726091085916;522.5949888836183;524.6773234460856;4181.268278051329;4214.831406743696;4394.450693663292;4422.402975598253;4583.060472603109;11800.586979455678;12053.578124765767;12111.87888121125;12195;12195.756084878252;12030.278183308854;12046.216995895238;12091.395430228453;12091.637250882488;12098.213616114925;8430.494170349799;8780.692675756318;8781.077986811293;8974.955125224462;9037.593308301011;6532.5753826001155;6665.600063996176;6678.332166783282;6862.725490980504;6930.653467326512;10756.193285503776;11319.151063670422;11327.490262938352;11375.374354410587;11421.029212517029;11133.498992545517;11271.323720576791;11554.48004839801;11562.075033997427;11593.188476806543;9084.90915090867;9239.630414783333;9287.257019438564;9341.859872101788;9413.388129771543;9452.054794520493;9500.904990950003;9574.808503830023;9575.808483830424;9587.041295870356;8257.463264887763;8408.327333813402;8410.032846222519;8434.072252052147;8623.87064194025;8290.958545207235;8329.292010179202;8404.285635721033;8514.91485085166;8531.616077276414;7618.162002179866;7618.923810761821;7690.807729806799;7761;7764.9223507766455;5737.627054241461;5767.826965191051;5840.415958404125;5895.528357731457;6015.518758499222;5922.111683247547;5959.761609535743;5967.283925928917;5968.4926781224085;6035.456808887221 08:58:10 INFO - PROCESS | 11373 | |4;prototype.html;340.15301898273293;346.82658670664665;348.891843528506;354.2260161547018;354.57096912735597;5293.550048245894;5436.401995780471;5522.3947693091495;5534.446555344463;5544.750486228119;5298.390685071218;5411.702356370398;5459.535939445152;5472.945270547293;5474.507294343508;4349.630281426067;4353.303471444569;4356.390105385249;4368.885934086803;4370.97814510927;4198.496180458349;4338.566143385652;4347.717398369112;4359.738415695068;4363;4281.486221653406;4290.742555446667;4304.268274393361;4313.352997050436;4339.978300108511;4290.1848648756795;4310;4311.547287534795;4312.072904325585;4314.611684948354;3600.225951420457;3695.6489133532273;3707.536557930259;3708.388115960863;3713.4615480755137;5307.495787900143;5317.175837745156;5323.307969963918;5330.946690533123;5341.626086173969;4830.372051633265;4836.975815120937;4838.524250103717;4848.151573474628;4852.17513022787;5597.216389705444;5729.742161602738;5755.971220143914;5756.107803290497;5761.567882408836;4063.7358571692744;4081.9591804081874;4085.20338533986;4091.8772436826944;4101.589841015904;5756.625819321773;5950.404959504058;5970.581914324705;5974.37269086744;5994.880102397971;4186.28833098374;4213.936790948138;4222.635324218448;4224.5353011168745;4242.61816436516;4276.893077673083;4284.143171365739;4289.485261768607;4291.1846749118195;4293.742375457483;4873.415190177201;4890.584300334512;4899.951000489949;4902.377228182976;4905.087016063738;5442.782288708487;5639.520640745583;5737.799177028867;5755.65466072037;5802.912956305659;1410.75311820431;1412.3856122586708;1452.6658868460313;1464.633841539615;1465.413834466222;979.6277414582413;1004.2668851738272;1013.4426065663855;1015.7816069545083;1024.7540590258434;5488.69812160327;5495.53287970527;5498.340199176045;5508.724563771795;5516.289950115397;5788.507976821933;5795.624303650801;5817.534597232211;5839.9124013139835;5842.853928651818;5294.364676238876;5458.344998600114;5478.685115572313;5537.335519737577;5642.435756424325;3139.6703346148784;3141.167590588496;3141.874325027019;3142.277276226481;3168.603924509436;5932.970335148383;6099.969500152471;6126.356732543108;6135.386461353829;6159.168512250789;6084.6349219047;6097.3292937776805;6110.358412366726;6121.173641558333;6136.509079273647;6167.321594624677;6170.56806023583;6176.455886028493;6197.225346831646;6223.844403889939;5675.858103547444;5909.734061967136;5958.404159584007;5967.254093238345;5981.431763982415;5895.6440018796775;5896.941030589811;5906.557008224315;5915.85210369727;5920.141579471038;5903.881922361443;6119.724612392364;6196.318404975539;6228.283747369111;6233.314335423191;4302.440682711227;4305.806238719328;4327.675424343124;4327.740335579875;4331.501877284027;5688.317401911797;5846.649201047951;5930.28836539618;5950.315713692808;5961.791337303173;5657.490825825531;5662.462066103713;5714.514266287412;5833.9498890200175;5837.6497410155525;5802.506786923159;5832.912506312494;5835.299764028174;5835.328937172279;5838.503727183237;5620;5721.799737009184;5774.797882074107;5786.5081468074;5792.768289268382;5817.109439432286;5857.355690873916;5863.824085277449;5871.295444546682;5873.236479257669;5418.512333889968;5711.200431939615;5717.856428714191;5721.197822685841;5731.140328950691 08:58:10 INFO - PROCESS | 11373 | |5;yui.html;805.9637316320765;827.2513375395266;849.8172892828045;861.987070193947;931.1293940165943;16439.2602332895;17745.822541774578;17760.11199440028;17791.466256012325;17795.82204177961;16111.436099736482;16364.754528682079;16376.83623163768;16384.75422868658;16385.508434746946;695.7286658203304;711.9074520312353;837.9078301386843;849.0914721248251;867.2931560777946;860.0797147052656;863.6977058029702;865.3466632692308;866.2377108144855;868.288003836854;915.3501014279869;916.4134953629649;916.7020718266557;916.7616419730851;917.334932174175;766.5553978692373;779.4426984705934;884.2483888694622;905.8414777413926;915.0346384564282;674.9156355455568;675.3550359406755;675.7972608217515;675.8884784010633;676.1109141478939;15052.32264548098;15091.773623395658;15104.924475377662;15110.093394396372;15124.395024199019;14372.35324410404;14588.927055364762;14591.708165836624;14593.92703036478;14756.48352307664;13984.510542130976;14017.64955876101;14074.577762667137;14091.50679726215;14491.492797752027;4576.702514336557;4736.171170045262;4807.351007613962;4838.056578967103;4871.683340582851;86167.56916215378;86366.56816715939;87778.56110719405;89731.55134224288;90725;10915.181361397927;11191.2725672831;11216.887831121747;11224.494897729623;11367.545298188144;22355.55288894213;22396.888015559816;22520.887395562917;22540.32379028599;22551.77448225497;8532.189442003;8537.487750734976;8662.956685216534;8993.14565116326;9359.859602105973;5022.748862556858;5195.558377537952;5209.947900520946;5240.737963101829;5276.736163191825;3460.1349662584353;3550.520679708258;3564.055525285801;3566.2510872716502;3566.7694645347315;500.8497450764756;571.8084441712073;572.5105035194931;574.7471112710477;575.6459777237053;673.8921772516373;749.5090715581302;784.9450538462366;807.6255807924682;836.4061516323356;10705.785884282272;10759.193060520493;10762.946185269024;11014.669559913216;11064;717.8277213468834;746.9402447804163;752.4035112163865;799.9720009799629;808.2685169921231;4923.384576927884;5164.819231326961;5255.816046438356;5268.262443257947;5435.728213589305;122830;124472;128495.35752321179;132631.33684331708;135488;111246.44376778226;111329.44335278272;112660;113847;114429;92694;95814.52092739491;102626;102647.4867625672;105318.47340763247;9605.327627066039;10040.899591004289;10098.8485172721;10147.289689721649;10157.238207134642;54737.1789423151;54773.45226547684;55245.723771380886;55627.72186139043;56581;74515.62742186255;79921.2007879937;84972.57513712392;85160;86936;12899.032572557284;13197.20816750998;13469.12450690702;13952.58142255734;14137.929310353382;15080;15543.689126217638;16224.67550649004;16543.09013004296;17407.30370785205;13404.32978351059;13551.457941682222;13701.520446784314;14111.788323174955;15056.548303550911;14855.851441485878;15180.24098795078;15410.383584656489;15426.9228653856;15683.921580392025;14331.140131592138;14590.270486475845;14807;14906.58427381334;15374;11437.812554424767;12106.213096148722;12195.390230488263;12231.877681223074;12327.9383603085;12684.175528590613;12691.42888570035;12747.426365813375;12921;12962.870371296167 08:58:10 INFO - PROCESS | 11373 | __end_tp_report 08:58:10 INFO - PROCESS | 11373 | __start_cc_report 08:58:10 INFO - PROCESS | 11373 | _x_x_mozilla_cycle_collect,842 08:58:10 INFO - PROCESS | 11373 | __end_cc_report 08:58:10 INFO - PROCESS | 11373 | __startTimestamp1477411090799__endTimestamp 08:58:10 INFO - PROCESS | 11373 | 08:58:10 INFO - PROCESS | 11373 | ------- Summary: start ------- 08:58:10 INFO - PROCESS | 11373 | Number of tests: 6 08:58:10 INFO - PROCESS | 11373 | 08:58:10 INFO - PROCESS | 11373 | [#0] dojo.html Cycles:165 Average:5636.72 Median:5855.65 stddev:628.87 (10.7%) stddev-sans-first:601.08 08:58:10 INFO - PROCESS | 11373 | Values: 3201.5 3237.4 3245.1 3266.0 3285.5 5648.9 5702.1 5715.3 5746.6 5755.8 5703.8 5759.0 5760.3 5766.8 5770.7 5215.6 5221.5 5231.3 5246.1 5292.2 5102.7 5124.3 5298.4 5303.5 5332.9 5114.7 5146.9 5164.7 5183.8 5198.8 5209.3 5221.9 5281.6 5290.1 5310.3 4953.4 5062.9 5180.2 5205.8 5266.7 5532.9 5535.5 5547.5 5551.3 5576.6 5945.2 6050.5 6072.6 6074.9 6077.6 5919.6 5995.0 6113.4 6121.2 6121.8 5588.2 5649.1 5654.5 5666.6 5685.5 6225.8 6226.4 6229.3 6232.8 6237.6 5870.2 5921.9 5969.6 5974.9 5981.6 5855.6 5903.1 5903.6 5919.9 5967.7 5891.0 5891.1 5894.1 5898.7 5900.4 5846.4 5911.9 5914.1 5930.9 5941.3 4603.7 4607.1 4649.2 4652.4 4677.3 4148.6 4152.4 4159.9 4163.5 4184.5 5797.1 5802.2 5803.2 5807.0 5841.2 5962.0 6016.9 6054.2 6089.3 6119.0 5825.9 5828.1 5828.4 5828.9 5840.9 5322.2 5325.6 5334.6 5337.6 5338.2 6129.4 6167.2 6170.2 6191.3 6306.7 6092.1 6100.1 6118.7 6124.4 6124.9 6240.6 6292.6 6292.8 6300.5 6304.7 5818.8 5867.9 5921.3 6015.2 6019.0 5992.9 6105.4 6110.2 6149.9 6150.2 5909.9 5952.9 5953.4 5958.7 5974.6 5829.9 5892.7 5941.2 5963.2 5969.3 5815.2 5868.5 5920.6 5924.7 6005.3 6054.2 6055.9 6056.8 6060.4 6065.3 5715.9 5730.7 5803.2 5886.1 5898.3 08:58:10 INFO - PROCESS | 11373 | 08:58:10 INFO - PROCESS | 11373 | [#1] ext.html Cycles:180 Average:65750.96 Median:41781.87 stddev:128587.35 (307.8%) stddev-sans-first:128854.93 08:58:10 INFO - PROCESS | 11373 | Values: 565.3 590.2 614.4 620.8 637.1 35659.8 36450.0 38380.0 38567.0 38687.2 47362.0 48721.3 48819.3 52367.5 52393.2 9359.2 9503.0 9506.5 9509.0 9511.6 8574.9 8782.8 9434.4 9525.0 9535.6 11088.6 11362.3 11367.7 11786.4 11807.7 11304.7 11349.5 11406.4 11407.4 11424.1 8492.2 8716.2 10797.1 11234.3 11307.8 42724.4 46494.0 46570.5 46579.5 46608.0 3713.4 3721.6 3767.9 3906.3 4495.9 34108.5 34307.8 34678.5 34836.7 34878.8 4563.3 4571.5 4683.3 4710.1 4714.1 383624.0 384057.0 384200.0 385137.0 385866.0 64092.0 64362.0 64649.7 64743.4 64773.4 67623.0 67633.7 67702.7 67791.3 68024.3 18405.5 18850.4 18853.9 18861.9 18862.7 14744.9 14856.9 14862.0 14866.6 14874.8 15942.7 16455.2 16839.3 17523.0 18044.0 6137.9 6406.7 6502.5 6505.3 6539.2 1017.8 1081.1 1114.3 1141.1 1159.3 34794.3 34881.5 34984.3 35171.6 35431.0 1097.7 1104.4 1192.7 1200.7 1228.7 17151.3 18186.6 18390.3 18395.0 18441.2 559031.0 562950.0 565987.0 566302.0 566555.0 63382.7 63563.7 63678.0 63698.0 63769.7 1398.3 1415.4 1426.4 1433.5 1442.8 32808.0 33717.8 34006.5 34448.8 34777.8 55838.2 56188.7 56418.0 56472.7 56504.0 488124.0 488233.0 491239.0 493168.0 493599.0 37449.6 38535.6 40532.4 40839.4 43936.0 52881.0 52969.7 53207.5 53324.0 53913.2 43298.4 44476.6 45308.0 46052.8 46989.3 44873.3 45353.5 45445.0 45534.0 46466.3 43772.8 44558.0 44629.3 44737.2 45125.0 36960.8 39696.6 40115.0 40164.2 40539.6 30272.7 30336.2 30551.7 30598.0 30609.2 08:58:10 INFO - PROCESS | 11373 | 08:58:10 INFO - PROCESS | 11373 | [#2] jquery.html Cycles:180 Average:30538.58 Median:22159.22 stddev:86354.94 (389.7%) stddev-sans-first:86567.54 08:58:10 INFO - PROCESS | 11373 | Values: 399.1 404.7 435.2 435.3 435.4 15922.6 19943.3 21378.0 22096.4 22222.0 19365.0 19955.9 20039.3 20650.3 20705.8 5510.6 5682.8 5687.7 5694.9 5770.4 6055.3 6061.2 6079.2 6137.2 6234.6 5539.9 5562.6 6046.2 6047.2 6050.6 5641.6 5676.6 5681.6 5682.3 5685.1 5326.3 5456.8 5518.8 5531.3 5537.9 13816.7 14109.8 14861.3 14968.3 15016.3 2298.0 2344.0 2513.7 2720.0 2996.3 10418.6 10500.3 10526.6 10548.3 11314.8 1966.2 1994.0 2058.2 2070.7 2114.3 85410.6 89412.0 89994.6 91617.0 92903.1 10990.4 12164.7 12174.5 12250.9 12265.8 15182.6 16011.1 16706.5 16831.4 17361.8 8721.3 8781.6 8962.6 9037.2 9087.0 8548.5 8732.6 8794.2 8971.9 9012.7 5130.1 5195.5 5217.3 5241.2 5347.3 2058.2 2158.8 2169.3 2181.0 2186.0 964.9 992.6 993.7 1069.6 1074.6 20007.3 20077.4 20204.6 20921.4 21173.6 968.6 975.5 1002.6 1021.3 1026.8 10995.6 11769.2 11848.3 11941.9 12031.5 485851.0 496354.0 525236.0 547713.0 555463.0 98751.5 99692.0 99952.5 101205.5 103197.5 1000.7 1001.0 1016.4 1023.1 1023.1 17974.6 18316.9 18464.4 18640.4 18666.9 33533.8 40981.8 42898.1 43773.8 46343.0 56106.0 57908.0 59441.4 59538.7 61846.7 8065.3 8927.6 9186.7 9211.1 9234.7 12249.2 13654.0 14039.8 14169.6 14401.2 11737.7 11771.0 11973.6 12322.8 12365.1 11056.5 11477.2 11635.5 11954.3 12229.8 11828.0 11887.5 11950.1 12454.3 12516.2 8795.5 8956.9 9204.6 9215.7 9226.9 11773.8 12198.1 12257.7 12316.4 12469.8 08:58:10 INFO - PROCESS | 11373 | 08:58:10 INFO - PROCESS | 11373 | [#3] mootools.html Cycles:180 Average:6423.87 Median:4619.53 stddev:3677.20 (79.6%) stddev-sans-first:3668.90 08:58:10 INFO - PROCESS | 11373 | Values: 1500.9 1520.6 1677.4 1775.7 1811.9 9200.8 9988.0 9993.3 10004.0 10006.0 8394.9 8705.4 9109.6 9404.4 9416.8 2605.4 2642.7 2642.8 2643.6 2643.7 2536.6 2620.7 2622.4 2624.4 2626.8 2579.6 2587.3 2604.0 2605.5 2607.7 2537.6 2547.3 2573.0 2573.4 2582.3 2512.8 2523.5 2535.5 2575.1 2580.5 9699.3 9782.8 9805.3 9818.0 9818.4 5801.0 5955.3 5961.6 5974.4 5980.9 3491.1 3617.7 3645.4 3662.5 3678.9 1249.8 1269.1 1287.3 1305.1 1309.7 13462.3 13468.7 13506.5 13514.4 13634.2 5123.1 5195.0 5328.0 5372.5 5412.8 11506.2 11519.1 11530.6 11542.4 11548.0 5956.8 5963.2 5963.7 5980.5 5985.3 4656.0 4789.6 5124.5 5169.8 5472.2 4338.7 4370.1 4446.8 4487.2 4494.8 1413.1 1414.2 1429.3 1431.6 1439.3 963.0 1012.4 1025.7 1040.7 1045.7 6497.7 6560.8 6582.2 6621.8 6775.2 482.7 483.9 484.9 522.6 524.7 4181.3 4214.8 4394.5 4422.4 4583.1 11800.6 12053.6 12111.9 12195.0 12195.8 12030.3 12046.2 12091.4 12091.6 12098.2 8430.5 8780.7 8781.1 8975.0 9037.6 6532.6 6665.6 6678.3 6862.7 6930.7 10756.2 11319.2 11327.5 11375.4 11421.0 11133.5 11271.3 11554.5 11562.1 11593.2 9084.9 9239.6 9287.3 9341.9 9413.4 9452.1 9500.9 9574.8 9575.8 9587.0 8257.5 8408.3 8410.0 8434.1 8623.9 8291.0 8329.3 8404.3 8514.9 8531.6 7618.2 7618.9 7690.8 7761.0 7764.9 5737.6 5767.8 5840.4 5895.5 6015.5 5922.1 5959.8 5967.3 5968.5 6035.5 08:58:10 INFO - PROCESS | 11373 | 08:58:10 INFO - PROCESS | 11373 | [#4] prototype.html Cycles:180 Average:4859.44 Median:5483.69 stddev:1428.71 (26.1%) stddev-sans-first:1391.87 08:58:10 INFO - PROCESS | 11373 | Values: 340.2 346.8 348.9 354.2 354.6 5293.6 5436.4 5522.4 5534.4 5544.8 5298.4 5411.7 5459.5 5472.9 5474.5 4349.6 4353.3 4356.4 4368.9 4371.0 4198.5 4338.6 4347.7 4359.7 4363.0 4281.5 4290.7 4304.3 4313.4 4340.0 4290.2 4310.0 4311.5 4312.1 4314.6 3600.2 3695.6 3707.5 3708.4 3713.5 5307.5 5317.2 5323.3 5330.9 5341.6 4830.4 4837.0 4838.5 4848.2 4852.2 5597.2 5729.7 5756.0 5756.1 5761.6 4063.7 4082.0 4085.2 4091.9 4101.6 5756.6 5950.4 5970.6 5974.4 5994.9 4186.3 4213.9 4222.6 4224.5 4242.6 4276.9 4284.1 4289.5 4291.2 4293.7 4873.4 4890.6 4900.0 4902.4 4905.1 5442.8 5639.5 5737.8 5755.7 5802.9 1410.8 1412.4 1452.7 1464.6 1465.4 979.6 1004.3 1013.4 1015.8 1024.8 5488.7 5495.5 5498.3 5508.7 5516.3 5788.5 5795.6 5817.5 5839.9 5842.9 5294.4 5458.3 5478.7 5537.3 5642.4 3139.7 3141.2 3141.9 3142.3 3168.6 5933.0 6100.0 6126.4 6135.4 6159.2 6084.6 6097.3 6110.4 6121.2 6136.5 6167.3 6170.6 6176.5 6197.2 6223.8 5675.9 5909.7 5958.4 5967.3 5981.4 5895.6 5896.9 5906.6 5915.9 5920.1 5903.9 6119.7 6196.3 6228.3 6233.3 4302.4 4305.8 4327.7 4327.7 4331.5 5688.3 5846.6 5930.3 5950.3 5961.8 5657.5 5662.5 5714.5 5833.9 5837.6 5802.5 5832.9 5835.3 5835.3 5838.5 5620.0 5721.8 5774.8 5786.5 5792.8 5817.1 5857.4 5863.8 5871.3 5873.2 5418.5 5711.2 5717.9 5721.2 5731.1 08:58:10 INFO - PROCESS | 11373 | 08:58:10 INFO - PROCESS | 11373 | [#5] yui.html Cycles:180 Average:23125.69 Median:22546.05 stddev:33973.79 (150.7%) stddev-sans-first:34027.76 08:58:10 INFO - PROCESS | 11373 | Values: 806.0 827.3 849.8 862.0 931.1 16439.3 17745.8 17760.1 17791.5 17795.8 16111.4 16364.8 16376.8 16384.8 16385.5 695.7 711.9 837.9 849.1 867.3 860.1 863.7 865.3 866.2 868.3 915.4 916.4 916.7 916.8 917.3 766.6 779.4 884.2 905.8 915.0 674.9 675.4 675.8 675.9 676.1 15052.3 15091.8 15104.9 15110.1 15124.4 14372.4 14588.9 14591.7 14593.9 14756.5 13984.5 14017.6 14074.6 14091.5 14491.5 4576.7 4736.2 4807.4 4838.1 4871.7 86167.6 86366.6 87778.6 89731.6 90725.0 10915.2 11191.3 11216.9 11224.5 11367.5 22355.6 22396.9 22520.9 22540.3 22551.8 8532.2 8537.5 8663.0 8993.1 9359.9 5022.7 5195.6 5209.9 5240.7 5276.7 3460.1 3550.5 3564.1 3566.3 3566.8 500.8 571.8 572.5 574.7 575.6 673.9 749.5 784.9 807.6 836.4 10705.8 10759.2 10762.9 11014.7 11064.0 717.8 746.9 752.4 800.0 808.3 4923.4 5164.8 5255.8 5268.3 5435.7 122830.0 124472.0 128495.4 132631.3 135488.0 111246.4 111329.4 112660.0 113847.0 114429.0 92694.0 95814.5 102626.0 102647.5 105318.5 9605.3 10040.9 10098.8 10147.3 10157.2 54737.2 54773.5 55245.7 55627.7 56581.0 74515.6 79921.2 84972.6 85160.0 86936.0 12899.0 13197.2 13469.1 13952.6 14137.9 15080.0 15543.7 16224.7 16543.1 17407.3 13404.3 13551.5 13701.5 14111.8 15056.5 14855.9 15180.2 15410.4 15426.9 15683.9 14331.1 14590.3 14807.0 14906.6 15374.0 11437.8 12106.2 12195.4 12231.9 12327.9 12684.2 12691.4 12747.4 12921.0 12962.9 08:58:10 INFO - PROCESS | 11373 | -------- Summary: end -------- 08:58:10 INFO - PROCESS | 11373 | 08:58:11 INFO - TEST-INFO | 11373: exit 0 08:58:11 INFO - TEST-OK | dromaeo_css | took 1113557ms 08:58:11 INFO - TEST-START | kraken 08:58:11 INFO - operating with platform_type : linux_ 08:58:11 INFO - Initialising browser for kraken test... 08:58:11 INFO - TEST-INFO | started process 11694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwCGYTV/profile http://localhost:53417/getInfo.html) 08:58:15 INFO - PROCESS | 11694 | __metrics Screen width/height:1600/1200 08:58:15 INFO - PROCESS | 11694 | colorDepth:24 08:58:15 INFO - PROCESS | 11694 | Browser inner width/height: 1024/697 08:58:15 INFO - PROCESS | 11694 | __metrics 08:58:16 INFO - PROCESS | 11694 | 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" 08:58:16 INFO - PROCESS | 11694 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:58:16 INFO - PROCESS | 11694 | console.error: PushService: 08:58:16 INFO - PROCESS | 11694 | stateChangeProcessEnqueue: Error transitioning state 08:58:16 INFO - PROCESS | 11694 | UnknownError 08:58:17 INFO - TEST-INFO | 11694: exit 0 08:58:17 INFO - Browser initialized. 08:58:17 INFO - Running cycle 1/1 for kraken test... 08:58:17 INFO - TEST-INFO | started process 11782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwCGYTV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:58:29 INFO - PROCESS | 11782 | RSS: Main: 145108992 08:58:29 INFO - PROCESS | 11782 | 08:58:31 INFO - PROCESS | 11782 | Cycle 1(1): loaded http://localhost:53417/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53417/tests/kraken/driver.html?testName=audio-beat-detection) 08:58:32 INFO - PROCESS | 11782 | RSS: Main: 186040320 08:58:32 INFO - PROCESS | 11782 | 08:58:34 INFO - PROCESS | 11782 | Cycle 1(1): loaded http://localhost:53417/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53417/tests/kraken/driver.html?testName=audio-dft) 08:58:35 INFO - PROCESS | 11782 | RSS: Main: 175652864 08:58:35 INFO - PROCESS | 11782 | 08:58:38 INFO - PROCESS | 11782 | Cycle 1(1): loaded http://localhost:53417/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53417/tests/kraken/driver.html?testName=audio-fft) 08:58:38 INFO - PROCESS | 11782 | RSS: Main: 267440128 08:58:38 INFO - PROCESS | 11782 | 08:58:40 INFO - PROCESS | 11782 | Cycle 1(1): loaded http://localhost:53417/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53417/tests/kraken/driver.html?testName=audio-oscillator) 08:58:41 INFO - PROCESS | 11782 | RSS: Main: 173756416 08:58:41 INFO - PROCESS | 11782 | 08:58:43 INFO - PROCESS | 11782 | Cycle 1(1): loaded http://localhost:53417/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53417/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:58:44 INFO - PROCESS | 11782 | RSS: Main: 175177728 08:58:44 INFO - PROCESS | 11782 | 08:58:47 INFO - PROCESS | 11782 | Cycle 1(1): loaded http://localhost:53417/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53417/tests/kraken/driver.html?testName=imaging-darkroom) 08:58:47 INFO - PROCESS | 11782 | RSS: Main: 210956288 08:58:47 INFO - PROCESS | 11782 | 08:58:51 INFO - PROCESS | 11782 | Cycle 1(1): loaded http://localhost:53417/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53417/tests/kraken/driver.html?testName=imaging-desaturate) 08:58:51 INFO - PROCESS | 11782 | RSS: Main: 210178048 08:58:51 INFO - PROCESS | 11782 | 08:58:54 INFO - PROCESS | 11782 | Cycle 1(1): loaded http://localhost:53417/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53417/tests/kraken/driver.html?testName=json-parse-financial) 08:58:55 INFO - PROCESS | 11782 | RSS: Main: 209735680 08:58:55 INFO - PROCESS | 11782 | 08:58:56 INFO - PROCESS | 11782 | Cycle 1(1): loaded http://localhost:53417/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53417/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:58:57 INFO - PROCESS | 11782 | RSS: Main: 172060672 08:58:57 INFO - PROCESS | 11782 | 08:58:59 INFO - PROCESS | 11782 | Cycle 1(1): loaded http://localhost:53417/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53417/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:58:59 INFO - PROCESS | 11782 | RSS: Main: 179212288 08:58:59 INFO - PROCESS | 11782 | 08:59:01 INFO - PROCESS | 11782 | Cycle 1(1): loaded http://localhost:53417/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53417/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:59:02 INFO - PROCESS | 11782 | RSS: Main: 189161472 08:59:02 INFO - PROCESS | 11782 | 08:59:04 INFO - PROCESS | 11782 | Cycle 1(1): loaded http://localhost:53417/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:59:05 INFO - PROCESS | 11782 | RSS: Main: 191131648 08:59:05 INFO - PROCESS | 11782 | 08:59:08 INFO - PROCESS | 11782 | Cycle 1(1): loaded http://localhost:53417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:59:08 INFO - PROCESS | 11782 | RSS: Main: 193495040 08:59:08 INFO - PROCESS | 11782 | 08:59:10 INFO - PROCESS | 11782 | Cycle 1(1): loaded http://localhost:53417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53417/tests/kraken/driver.html?testName=ai-astar) 08:59:10 INFO - PROCESS | 11782 | RSS: Main: 243789824 08:59:10 INFO - PROCESS | 11782 | 08:59:10 INFO - PROCESS | 11782 | __start_tp_report 08:59:10 INFO - PROCESS | 11782 | _x_x_mozilla_page_load 08:59:10 INFO - PROCESS | 11782 | _x_x_mozilla_page_load_details 08:59:10 INFO - PROCESS | 11782 | |i|pagename|runs| 08:59:10 INFO - PROCESS | 11782 | |0;ai-astar;109;112;111;111;113;110;109;111;111;109 08:59:10 INFO - PROCESS | 11782 | |1;audio-beat-detection;146;115;118;158;118;123;121;118;144;118 08:59:10 INFO - PROCESS | 11782 | |2;audio-dft;162;159;162;161;159;161;161;164;160;161 08:59:10 INFO - PROCESS | 11782 | |3;audio-fft;76;75;75;111;75;76;75;76;105;76 08:59:10 INFO - PROCESS | 11782 | |4;audio-oscillator;82;81;112;82;81;82;98;82;82;127 08:59:10 INFO - PROCESS | 11782 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 08:59:10 INFO - PROCESS | 11782 | |6;imaging-darkroom;146;146;146;146;147;146;147;146;145;146 08:59:10 INFO - PROCESS | 11782 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;95;94 08:59:10 INFO - PROCESS | 11782 | |8;json-parse-financial;50;49;49;49;51;52;48;49;49;56 08:59:10 INFO - PROCESS | 11782 | |9;json-stringify-tinderbox;60;61;59;59;59;59;59;59;59;59 08:59:10 INFO - PROCESS | 11782 | |10;stanford-crypto-aes;75;89;74;73;82;74;75;74;73;73 08:59:10 INFO - PROCESS | 11782 | |11;stanford-crypto-ccm;140;131;122;135;122;122;119;129;152;137 08:59:10 INFO - PROCESS | 11782 | |12;stanford-crypto-pbkdf2;157;155;156;153;154;152;154;154;158;154 08:59:10 INFO - PROCESS | 11782 | |13;stanford-crypto-sha256-iterative;67;64;62;63;63;63;63;63;62;61 08:59:10 INFO - PROCESS | 11782 | __end_tp_report 08:59:10 INFO - PROCESS | 11782 | __start_cc_report 08:59:10 INFO - PROCESS | 11782 | _x_x_mozilla_cycle_collect,1572 08:59:10 INFO - PROCESS | 11782 | __end_cc_report 08:59:10 INFO - PROCESS | 11782 | __startTimestamp1477411150583__endTimestamp 08:59:10 INFO - PROCESS | 11782 | 08:59:10 INFO - PROCESS | 11782 | ------- Summary: start ------- 08:59:10 INFO - PROCESS | 11782 | Number of tests: 14 08:59:10 INFO - PROCESS | 11782 | 08:59:10 INFO - PROCESS | 11782 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.35 (1.2%) stddev-sans-first:1.30 08:59:10 INFO - PROCESS | 11782 | Values: 109.0 112.0 111.0 111.0 113.0 110.0 109.0 111.0 111.0 109.0 08:59:10 INFO - PROCESS | 11782 | 08:59:10 INFO - PROCESS | 11782 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:122.00 stddev:15.36 (12.6%) stddev-sans-first:14.83 08:59:10 INFO - PROCESS | 11782 | Values: 146.0 115.0 118.0 158.0 118.0 123.0 121.0 118.0 144.0 118.0 08:59:10 INFO - PROCESS | 11782 | 08:59:10 INFO - PROCESS | 11782 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.49 (0.9%) stddev-sans-first:1.54 08:59:10 INFO - PROCESS | 11782 | Values: 162.0 159.0 162.0 161.0 159.0 161.0 161.0 164.0 160.0 161.0 08:59:10 INFO - PROCESS | 11782 | 08:59:10 INFO - PROCESS | 11782 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.50 stddev:13.78 (18.3%) stddev-sans-first:14.45 08:59:10 INFO - PROCESS | 11782 | Values: 76.0 75.0 75.0 111.0 75.0 76.0 75.0 76.0 105.0 76.0 08:59:10 INFO - PROCESS | 11782 | 08:59:10 INFO - PROCESS | 11782 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:82.00 stddev:16.30 (19.9%) stddev-sans-first:16.97 08:59:10 INFO - PROCESS | 11782 | Values: 82.0 81.0 112.0 82.0 81.0 82.0 98.0 82.0 82.0 127.0 08:59:10 INFO - PROCESS | 11782 | 08:59:10 INFO - PROCESS | 11782 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:59:10 INFO - PROCESS | 11782 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 08:59:10 INFO - PROCESS | 11782 | 08:59:10 INFO - PROCESS | 11782 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:59:10 INFO - PROCESS | 11782 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 145.0 146.0 08:59:10 INFO - PROCESS | 11782 | 08:59:10 INFO - PROCESS | 11782 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:59:10 INFO - PROCESS | 11782 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 08:59:10 INFO - PROCESS | 11782 | 08:59:10 INFO - PROCESS | 11782 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:49.50 stddev:2.35 (4.7%) stddev-sans-first:2.49 08:59:10 INFO - PROCESS | 11782 | Values: 50.0 49.0 49.0 49.0 51.0 52.0 48.0 49.0 49.0 56.0 08:59:10 INFO - PROCESS | 11782 | 08:59:10 INFO - PROCESS | 11782 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 08:59:10 INFO - PROCESS | 11782 | Values: 60.0 61.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 08:59:10 INFO - PROCESS | 11782 | 08:59:10 INFO - PROCESS | 11782 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:74.50 stddev:5.22 (7.0%) stddev-sans-first:5.52 08:59:10 INFO - PROCESS | 11782 | Values: 75.0 89.0 74.0 73.0 82.0 74.0 75.0 74.0 73.0 73.0 08:59:10 INFO - PROCESS | 11782 | 08:59:10 INFO - PROCESS | 11782 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:133.00 stddev:10.35 (7.8%) stddev-sans-first:10.45 08:59:10 INFO - PROCESS | 11782 | Values: 140.0 131.0 122.0 135.0 122.0 122.0 119.0 129.0 152.0 137.0 08:59:10 INFO - PROCESS | 11782 | 08:59:10 INFO - PROCESS | 11782 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:154.50 stddev:1.83 (1.2%) stddev-sans-first:1.74 08:59:10 INFO - PROCESS | 11782 | Values: 157.0 155.0 156.0 153.0 154.0 152.0 154.0 154.0 158.0 154.0 08:59:10 INFO - PROCESS | 11782 | 08:59:10 INFO - PROCESS | 11782 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:1.60 (2.5%) stddev-sans-first:0.87 08:59:10 INFO - PROCESS | 11782 | Values: 67.0 64.0 62.0 63.0 63.0 63.0 63.0 63.0 62.0 61.0 08:59:10 INFO - PROCESS | 11782 | -------- Summary: end -------- 08:59:10 INFO - PROCESS | 11782 | 08:59:11 INFO - TEST-INFO | 11782: exit 0 08:59:11 INFO - TEST-OK | kraken | took 60056ms 08:59:11 INFO - SUITE-END | took 1173s 08:59:11 INFO - Completed test suite (00:19:33) 08:59:11 INFO - javascript benchmark 08:59:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3201.5037669161275, 3237.417264892319, 3245.058932909455, 3266.0, 3285.523599078134, 5648.8587785305335, 5702.087665973445, 5715.257016587843, 5746.626469279504, 5755.798547050854, 5703.828885133442, 5759.049756790125, 5760.2511673482495, 5766.769329226826, 5770.682612456324, 5215.5566776823825, 5221.530062294383, 5231.267622532849, 5246.081935661263, 5292.232626269189, 5102.668326558762, 5124.308218390507, 5298.4436634153435, 5303.549198318147, 5332.893342133155, 5114.744262786864, 5146.897062058757, 5164.690118592896, 5183.792648294064, 5198.7660555274915, 5209.348831396075, 5221.895562088756, 5281.63028587999, 5290.100682883919, 5310.283111779899, 4953.4303555091265, 5062.924056139161, 5180.222966555047, 5205.843824685227, 5266.7366631668265, 5532.861678458031, 5535.474129957647, 5547.472990065938, 5551.278333816578, 5576.609637325389, 5945.1973983512535, 6050.455459008666, 6072.635641861502, 6074.908876366858, 6077.604955677867, 5919.644821310735, 5995.040793473024, 6113.358097399798, 6121.173641558377, 6121.846953826145, 5588.189712491707, 5649.06790379591, 5654.46282603152, 5666.631668941547, 5685.545156387479, 6225.750969961241, 6226.439620434183, 6229.283632382243, 6232.750689972441, 6237.625742455467, 5870.178175055496, 5921.851953701192, 5969.641821490724, 5974.9402505974385, 5981.641101533922, 5855.648661080349, 5903.0555111182, 5903.557233207441, 5919.940800592025, 5967.671778052249, 5890.970545147246, 5891.116332550066, 5894.145348924382, 5898.734556944948, 5900.4099590041515, 5846.444587764156, 5911.852203694942, 5914.083317085859, 5930.8813823723285, 5941.316748573883, 4603.654725895504, 4607.124646317189, 4649.163150632851, 4652.418447694038, 4677.32178834074, 4148.605882441163, 4152.397902304209, 4159.896002599899, 4163.500379954425, 4184.539700632928, 5797.072468405035, 5802.187693722883, 5803.158542011384, 5807.0, 5841.240638716939, 5962.046072628359, 6016.909746353808, 6054.243219597551, 6089.2997305310455, 6118.969405153035, 5825.88348233033, 5828.12578113278, 5828.446297601721, 5828.854278643068, 5840.8539786504825, 5322.175062865262, 5325.627206095536, 5334.626576139633, 5337.626366154332, 5338.172583249602, 6129.35641757609, 6167.167432396659, 6170.167027451236, 6191.25704915413, 6306.747730090837, 6092.147099406176, 6100.1154832548145, 6118.680093383066, 6124.350421260821, 6124.8775024500155, 6240.567687771798, 6292.590981586182, 6292.842678933063, 6300.495960323255, 6304.65324407162, 5818.76724930998, 5867.882642347044, 5921.348651648229, 6015.248093988252, 6018.969905150446, 5992.910106348321, 6105.3894610540365, 6110.205673262448, 6149.907751383822, 6150.169727086786, 5909.852253693692, 5952.910706339495, 5953.434423729739, 5958.672273025025, 5974.551908606959, 5829.854253643693, 5892.734826932712, 5941.197938278277, 5963.165156877953, 5969.313528944053, 5815.185873977562, 5868.471837534642, 5920.644761314335, 5924.703764811656, 6005.339412664691, 6054.182685337423, 6055.939440605537, 6056.788012419721, 6060.424259695322, 6065.272167339947, 5715.9142612860005, 5730.656160630376, 5803.158542011469, 5886.087656413263, 5898.321693005188], "value": 5594.387992154652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.2708006671394, 590.1649166429503, 614.3579958942908, 620.8044465993212, 637.0794202377566, 35659.821700891494, 36450.0, 38380.0, 38567.0, 38687.22625547491, 47362.0, 48721.269180962314, 48819.26771098428, 52367.476325236734, 52393.214101788406, 9359.20446762026, 9503.0, 9506.524673766284, 9508.952455237713, 9511.619535218582, 8574.871376929352, 8782.824343513126, 9434.386764860263, 9525.047495250454, 9535.570899309512, 11088.55645774172, 11362.261453005569, 11367.658970230865, 11786.35175065371, 11807.704807379798, 11304.717382065432, 11349.546018159304, 11406.42967851604, 11407.429628518625, 11424.086073114215, 8492.193241642035, 8716.215540601313, 10797.136229101652, 11234.269772464764, 11307.773844523064, 42724.359134613005, 46494.0, 46570.5342946573, 46579.53420465786, 46608.0, 3713.3687273163355, 3721.5534135903595, 3767.924641507182, 3906.2968665640174, 4495.887602809923, 34108.48837267418, 34307.82846085779, 34678.47982280268, 34836.65163348359, 34878.825605872065, 4563.338315944203, 4571.497135315112, 4683.320918466803, 4710.128626204163, 4714.080754252922, 383623.9999999972, 384057.0, 384200.0, 385137.0, 385866.0, 64092.0, 64362.0, 64649.67675161594, 64743.35256647468, 64773.35226647673, 67623.0, 67633.66183169052, 67702.66148669324, 67791.3220867785, 68024.3197568018, 18405.53986150357, 18850.434486965412, 18853.90573047126, 18861.90569047146, 18862.71705924412, 14744.852551474563, 14856.92571537157, 14862.033967792275, 14866.554003379915, 14874.776878346833, 15942.681146377008, 16455.177241138135, 16839.32642694303, 17523.0, 18044.0, 6137.938620613826, 6406.711697973602, 6502.536929190989, 6505.282920885941, 6539.182602174728, 1017.7862648843677, 1081.1296905990753, 1114.3425379026414, 1141.1270378160714, 1159.287038471334, 34794.30411391758, 34881.47677784835, 34984.300313993575, 35171.64828351735, 35431.0, 1097.665212110298, 1104.4091411095026, 1192.7316353820495, 1200.7118291610125, 1228.7419641875128, 17151.313947441962, 18186.63626727458, 18390.264389424272, 18395.0, 18441.1701473434, 559031.0, 562950.0, 565987.0, 566302.0, 566555.0, 63382.68308658427, 63563.68218158972, 63678.0, 63698.0, 63769.68115159395, 1398.2519352146553, 1415.4409008441608, 1426.3866537388815, 1433.4624515806572, 1442.8412874583787, 32808.0, 33717.83141084279, 34006.48990265099, 34448.82775586106, 34777.82611086928, 55838.16242756443, 56188.719056406095, 56418.0, 56472.71763641156, 56504.0, 488124.0, 488233.0, 491239.0, 493168.0, 493599.0, 37449.6255037457, 38535.6146438532, 40532.3920141204, 40839.38740918948, 43936.0, 52881.0, 52969.735151324, 53207.4679253218, 53324.0, 53913.19130213129, 43298.35052474152, 44476.55523444853, 45308.0, 46052.7697361511, 46989.295160571935, 44873.32690009718, 45353.546464534935, 45445.0, 45534.0, 46466.30300545427, 43772.78113609411, 44558.0, 44629.33056004097, 44737.23671188435, 45125.0, 36960.815195923846, 39696.603033970445, 40115.0, 40164.1967160661, 40539.594604053585, 30272.697273026988, 30336.241593960327, 30551.694483054885, 30598.0, 30609.23476913006], "value": 21892.706371400425, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.09405649176387, 404.7086098009436, 435.2448501849291, 435.30351437699676, 435.40132318062666, 15922.601934951632, 19943.30198443055, 21378.0, 22096.447588810286, 22222.0, 19365.0, 19955.900220498912, 20039.298624548144, 20650.277240296593, 20705.792942070613, 5510.586705997056, 5682.829515114532, 5687.687177205252, 5694.943050569504, 5770.365259821438, 6055.273367195942, 6061.212042434499, 6079.240094988127, 6137.232845894263, 6234.594751341148, 5539.861503462405, 5562.610617256773, 6046.1837651917085, 6047.213862197908, 6050.636961782285, 5641.633293835887, 5676.602637815355, 5681.630694004876, 5682.346530149024, 5685.061964775828, 5326.334208223972, 5456.8090116846115, 5518.834434966958, 5531.25328080708, 5537.861553461155, 13816.654583635389, 14109.78835317471, 14861.331240094221, 14968.251587420586, 15016.324265408082, 2298.0, 2344.0, 2513.710923243832, 2720.0071973729646, 2996.310848504856, 10418.635347762867, 10500.2649814513, 10526.578936842518, 10548.261621686484, 11314.773704525946, 1966.1742068331334, 1993.9601207975904, 2058.1561559760426, 2070.710100585904, 2114.302280247515, 85410.57294713486, 89412.0, 89994.5500272501, 91617.0, 92903.07096929011, 10990.395528245863, 12164.69588260283, 12174.452149653287, 12250.938745306217, 12265.816012759815, 15182.620434489005, 16011.119388433515, 16706.49880503587, 16831.41090061842, 17361.826381736275, 8721.30229581632, 8781.560921953876, 8962.551872406484, 9037.231835294073, 9087.0, 8548.529830859237, 8732.58866321615, 8794.164554367326, 8971.865422018675, 9012.684556040507, 5130.12787826063, 5195.532402083831, 5217.321748172789, 5241.187615919539, 5347.304850369427, 2058.217877206652, 2158.7949144831214, 2169.2516081951703, 2180.9890950545464, 2185.967210491844, 964.9372790768577, 992.6476100984191, 993.7267251505749, 1069.6095924987324, 1074.5970261152067, 20007.299744509164, 20077.39767806939, 20204.59590808205, 20921.37235882926, 21173.576528469344, 968.588349951282, 975.5366201054584, 1002.6240159940022, 1021.2646894236138, 1026.7997740440542, 10995.615153469591, 11769.234999724991, 11848.348340841336, 11941.880581194251, 12031.518739250507, 485851.0, 496354.0, 525236.0, 547713.0, 555463.0, 98751.50624246977, 99692.0, 99952.50023749835, 101205.49397252967, 103197.48401257946, 1000.6847842929454, 1000.9899901001043, 1016.4257194684832, 1023.1150055202345, 1023.1405619279841, 17974.5506362342, 18316.908415457838, 18464.35374761877, 18640.440786776417, 18666.906665466584, 33533.83233083916, 40981.79509102435, 42898.14203715846, 43773.78113109414, 46343.0, 56106.0, 57908.0, 59441.405585945315, 59538.70230648819, 61846.69076654588, 8065.314448271963, 8927.598258078273, 9186.678466253648, 9211.078892110736, 9234.676786312446, 12249.203801752858, 13654.0, 14039.789403158757, 14169.645758856112, 14401.207933563335, 11737.706557336134, 11771.0, 11973.640790776291, 12322.75354492923, 12365.07261955375, 11056.502457389275, 11477.196596238517, 11635.47640356169, 11954.342511161969, 12229.816552751894, 11828.0, 11887.524499019943, 11950.103742219195, 12454.25274483534, 12516.186447880858, 8795.47227166372, 8956.925168979764, 9204.631814727336, 9215.723528294162, 9226.861597075915, 11773.76452470963, 12198.14612977083, 12257.69355766113, 12316.384180790745, 12469.75060498803], "value": 9546.080425323202, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.9399624015043, 1520.5970417839274, 1677.4212896550694, 1775.6803775320436, 1811.864110191735, 9200.769980750485, 9987.950060249688, 9993.250506212045, 10004.0, 10006.049425304584, 8394.874076888851, 8705.390622656416, 9109.635614575409, 9404.388714733555, 9416.81166376672, 2605.3747100695837, 2642.7357264273514, 2642.8282161659527, 2643.629891815138, 2643.6563246777987, 2536.5941449368106, 2620.6724159480063, 2622.423066925283, 2624.3701511637164, 2626.842389456629, 2579.61305804129, 2587.2884956636885, 2604.0234911908033, 2605.5179791738587, 2607.713151553337, 2537.568613335728, 2547.337692200023, 2573.0, 2573.4209802794408, 2582.302778249862, 2512.836665616729, 2523.470071285032, 2535.5055764126005, 2575.0601030623875, 2580.458103798205, 9699.321047526675, 9782.75543111428, 9805.264605154642, 9818.0, 9818.361806482555, 5801.0, 5955.315138759055, 5961.582689211757, 5974.402559744034, 5980.940190598082, 3491.0923159978333, 3617.728670349708, 3645.398509245971, 3662.4689420033947, 3678.8528458861615, 1249.8250244965711, 1269.0672355818558, 1287.34345483803, 1305.1255658708687, 1309.6660351610374, 13462.326883655778, 13468.663283417993, 13506.527271545448, 13514.391852366667, 13634.181949082988, 5123.129068058439, 5195.0, 5328.040952628487, 5372.543333816591, 5412.83761487156, 11506.19456638044, 11519.136064795173, 11530.59642912494, 11542.365169915734, 11548.0, 5956.821295361146, 5963.165156878041, 5963.731632076567, 5980.461758441674, 5985.311689155803, 4656.0, 4789.592884604778, 5124.48755124492, 5169.767360468788, 5472.20653005312, 4338.696291259582, 4370.104128653682, 4446.799894004777, 4487.214737420938, 4494.797734101973, 1413.1238632048196, 1414.2221778022047, 1429.335359058043, 1431.5991522373752, 1439.2731670506328, 962.9744322296732, 1012.377387906447, 1025.6769117727893, 1040.661784919904, 1045.6549338718205, 6497.740090396425, 6560.770373036921, 6582.17722784652, 6621.801345959629, 6775.186977562724, 482.6862539349451, 483.93224948507236, 484.92726091085916, 522.5949888836183, 524.6773234460856, 4181.268278051329, 4214.831406743696, 4394.450693663292, 4422.402975598253, 4583.060472603109, 11800.586979455678, 12053.578124765767, 12111.87888121125, 12195.0, 12195.756084878252, 12030.278183308854, 12046.216995895238, 12091.395430228453, 12091.637250882488, 12098.213616114925, 8430.494170349799, 8780.692675756318, 8781.077986811293, 8974.955125224462, 9037.593308301011, 6532.5753826001155, 6665.600063996176, 6678.332166783282, 6862.725490980504, 6930.653467326512, 10756.193285503776, 11319.151063670422, 11327.490262938352, 11375.374354410587, 11421.029212517029, 11133.498992545517, 11271.323720576791, 11554.48004839801, 11562.075033997427, 11593.188476806543, 9084.90915090867, 9239.630414783333, 9287.257019438564, 9341.859872101788, 9413.388129771543, 9452.054794520493, 9500.904990950003, 9574.808503830023, 9575.808483830424, 9587.041295870356, 8257.463264887763, 8408.327333813402, 8410.032846222519, 8434.072252052147, 8623.87064194025, 8290.958545207235, 8329.292010179202, 8404.285635721033, 8514.91485085166, 8531.616077276414, 7618.162002179866, 7618.923810761821, 7690.807729806799, 7761.0, 7764.9223507766455, 5737.627054241461, 5767.826965191051, 5840.415958404125, 5895.528357731457, 6015.518758499222, 5922.111683247547, 5959.761609535743, 5967.283925928917, 5968.4926781224085, 6035.456808887221], "value": 5043.111705838479, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.15301898273293, 346.82658670664665, 348.891843528506, 354.2260161547018, 354.57096912735597, 5293.550048245894, 5436.401995780471, 5522.3947693091495, 5534.446555344463, 5544.750486228119, 5298.390685071218, 5411.702356370398, 5459.535939445152, 5472.945270547293, 5474.507294343508, 4349.630281426067, 4353.303471444569, 4356.390105385249, 4368.885934086803, 4370.97814510927, 4198.496180458349, 4338.566143385652, 4347.717398369112, 4359.738415695068, 4363.0, 4281.486221653406, 4290.742555446667, 4304.268274393361, 4313.352997050436, 4339.978300108511, 4290.1848648756795, 4310.0, 4311.547287534795, 4312.072904325585, 4314.611684948354, 3600.225951420457, 3695.6489133532273, 3707.536557930259, 3708.388115960863, 3713.4615480755137, 5307.495787900143, 5317.175837745156, 5323.307969963918, 5330.946690533123, 5341.626086173969, 4830.372051633265, 4836.975815120937, 4838.524250103717, 4848.151573474628, 4852.17513022787, 5597.216389705444, 5729.742161602738, 5755.971220143914, 5756.107803290497, 5761.567882408836, 4063.7358571692744, 4081.9591804081874, 4085.20338533986, 4091.8772436826944, 4101.589841015904, 5756.625819321773, 5950.404959504058, 5970.581914324705, 5974.37269086744, 5994.880102397971, 4186.28833098374, 4213.936790948138, 4222.635324218448, 4224.5353011168745, 4242.61816436516, 4276.893077673083, 4284.143171365739, 4289.485261768607, 4291.1846749118195, 4293.742375457483, 4873.415190177201, 4890.584300334512, 4899.951000489949, 4902.377228182976, 4905.087016063738, 5442.782288708487, 5639.520640745583, 5737.799177028867, 5755.65466072037, 5802.912956305659, 1410.75311820431, 1412.3856122586708, 1452.6658868460313, 1464.633841539615, 1465.413834466222, 979.6277414582413, 1004.2668851738272, 1013.4426065663855, 1015.7816069545083, 1024.7540590258434, 5488.69812160327, 5495.53287970527, 5498.340199176045, 5508.724563771795, 5516.289950115397, 5788.507976821933, 5795.624303650801, 5817.534597232211, 5839.9124013139835, 5842.853928651818, 5294.364676238876, 5458.344998600114, 5478.685115572313, 5537.335519737577, 5642.435756424325, 3139.6703346148784, 3141.167590588496, 3141.874325027019, 3142.277276226481, 3168.603924509436, 5932.970335148383, 6099.969500152471, 6126.356732543108, 6135.386461353829, 6159.168512250789, 6084.6349219047, 6097.3292937776805, 6110.358412366726, 6121.173641558333, 6136.509079273647, 6167.321594624677, 6170.56806023583, 6176.455886028493, 6197.225346831646, 6223.844403889939, 5675.858103547444, 5909.734061967136, 5958.404159584007, 5967.254093238345, 5981.431763982415, 5895.6440018796775, 5896.941030589811, 5906.557008224315, 5915.85210369727, 5920.141579471038, 5903.881922361443, 6119.724612392364, 6196.318404975539, 6228.283747369111, 6233.314335423191, 4302.440682711227, 4305.806238719328, 4327.675424343124, 4327.740335579875, 4331.501877284027, 5688.317401911797, 5846.649201047951, 5930.28836539618, 5950.315713692808, 5961.791337303173, 5657.490825825531, 5662.462066103713, 5714.514266287412, 5833.9498890200175, 5837.6497410155525, 5802.506786923159, 5832.912506312494, 5835.299764028174, 5835.328937172279, 5838.503727183237, 5620.0, 5721.799737009184, 5774.797882074107, 5786.5081468074, 5792.768289268382, 5817.109439432286, 5857.355690873916, 5863.824085277449, 5871.295444546682, 5873.236479257669, 5418.512333889968, 5711.200431939615, 5717.856428714191, 5721.197822685841, 5731.140328950691], "value": 4405.585970815545, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.9637316320765, 827.2513375395266, 849.8172892828045, 861.987070193947, 931.1293940165943, 16439.2602332895, 17745.822541774578, 17760.11199440028, 17791.466256012325, 17795.82204177961, 16111.436099736482, 16364.754528682079, 16376.83623163768, 16384.75422868658, 16385.508434746946, 695.7286658203304, 711.9074520312353, 837.9078301386843, 849.0914721248251, 867.2931560777946, 860.0797147052656, 863.6977058029702, 865.3466632692308, 866.2377108144855, 868.288003836854, 915.3501014279869, 916.4134953629649, 916.7020718266557, 916.7616419730851, 917.334932174175, 766.5553978692373, 779.4426984705934, 884.2483888694622, 905.8414777413926, 915.0346384564282, 674.9156355455568, 675.3550359406755, 675.7972608217515, 675.8884784010633, 676.1109141478939, 15052.32264548098, 15091.773623395658, 15104.924475377662, 15110.093394396372, 15124.395024199019, 14372.35324410404, 14588.927055364762, 14591.708165836624, 14593.92703036478, 14756.48352307664, 13984.510542130976, 14017.64955876101, 14074.577762667137, 14091.50679726215, 14491.492797752027, 4576.702514336557, 4736.171170045262, 4807.351007613962, 4838.056578967103, 4871.683340582851, 86167.56916215378, 86366.56816715939, 87778.56110719405, 89731.55134224288, 90725.0, 10915.181361397927, 11191.2725672831, 11216.887831121747, 11224.494897729623, 11367.545298188144, 22355.55288894213, 22396.888015559816, 22520.887395562917, 22540.32379028599, 22551.77448225497, 8532.189442003, 8537.487750734976, 8662.956685216534, 8993.14565116326, 9359.859602105973, 5022.748862556858, 5195.558377537952, 5209.947900520946, 5240.737963101829, 5276.736163191825, 3460.1349662584353, 3550.520679708258, 3564.055525285801, 3566.2510872716502, 3566.7694645347315, 500.8497450764756, 571.8084441712073, 572.5105035194931, 574.7471112710477, 575.6459777237053, 673.8921772516373, 749.5090715581302, 784.9450538462366, 807.6255807924682, 836.4061516323356, 10705.785884282272, 10759.193060520493, 10762.946185269024, 11014.669559913216, 11064.0, 717.8277213468834, 746.9402447804163, 752.4035112163865, 799.9720009799629, 808.2685169921231, 4923.384576927884, 5164.819231326961, 5255.816046438356, 5268.262443257947, 5435.728213589305, 122830.0, 124472.0, 128495.35752321179, 132631.33684331708, 135488.0, 111246.44376778226, 111329.44335278272, 112660.0, 113847.0, 114429.0, 92694.0, 95814.52092739491, 102626.0, 102647.4867625672, 105318.47340763247, 9605.327627066039, 10040.899591004289, 10098.8485172721, 10147.289689721649, 10157.238207134642, 54737.1789423151, 54773.45226547684, 55245.723771380886, 55627.72186139043, 56581.0, 74515.62742186255, 79921.2007879937, 84972.57513712392, 85160.0, 86936.0, 12899.032572557284, 13197.20816750998, 13469.12450690702, 13952.58142255734, 14137.929310353382, 15080.0, 15543.689126217638, 16224.67550649004, 16543.09013004296, 17407.30370785205, 13404.32978351059, 13551.457941682222, 13701.520446784314, 14111.788323174955, 15056.548303550911, 14855.851441485878, 15180.24098795078, 15410.383584656489, 15426.9228653856, 15683.921580392025, 14331.140131592138, 14590.270486475845, 14807.0, 14906.58427381334, 15374.0, 11437.812554424767, 12106.213096148722, 12195.390230488263, 12231.877681223074, 12327.9383603085, 12684.175528590613, 12691.42888570035, 12747.426365813375, 12921.0, 12962.870371296167], "value": 8146.647365262161, "unit": "score"}], "name": "dromaeo_css", "value": 7719.697566917823, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 111.0, 111.0, 113.0, 110.0, 109.0, 111.0, 111.0, 109.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 115.0, 118.0, 158.0, 118.0, 123.0, 121.0, 118.0, 144.0, 118.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 162.0, 161.0, 159.0, 161.0, 161.0, 164.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 111.0, 75.0, 76.0, 75.0, 76.0, 105.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 112.0, 82.0, 81.0, 82.0, 98.0, 82.0, 82.0, 127.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 49.0, 51.0, 52.0, 48.0, 49.0, 49.0, 56.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 89.0, 74.0, 73.0, 82.0, 74.0, 75.0, 74.0, 73.0, 73.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 131.0, 122.0, 135.0, 122.0, 122.0, 119.0, 129.0, 152.0, 137.0], "value": 130.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 155.0, 156.0, 153.0, 154.0, 152.0, 154.0, 154.0, 158.0, 154.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 61.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1464.6000000000001, "alertThreshold": 2.0}]} 08:59:11 INFO - Return code: 0 08:59:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:59:11 INFO - # TBPL SUCCESS # 08:59:11 INFO - Running post-action listener: _resource_record_post_action 08:59:11 INFO - [mozharness: 2016-10-25 15:59:11.894591Z] Finished run-tests step (success) 08:59:11 INFO - Running post-run listener: _resource_record_post_run 08:59:11 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 2007040; Write bytes: 374206464; Read time: 484; Write time: 263916 08:59:11 INFO - TinderboxPrint: CPU usage
12.9% 08:59:11 INFO - TinderboxPrint: I/O read bytes / time
2,007,040 / 484 08:59:11 INFO - TinderboxPrint: I/O write bytes / time
374,206,464 / 263,916 08:59:11 INFO - TinderboxPrint: CPU idle
8,271.6 (87.1%) 08:59:11 INFO - TinderboxPrint: CPU user
1,182.4 (12.4%) 08:59:11 INFO - TinderboxPrint: Swap in / out
0 / 0 08:59:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 123957248; Read time: 208; Write time: 86588 08:59:11 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250249216; Read time: 228; Write time: 177328 08:59:12 INFO - Running post-run listener: _upload_blobber_files 08:59:12 INFO - Blob upload gear active. 08:59:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:59:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:59:12 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'] 08:59:12 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 08:59:12 INFO - (blobuploader) - INFO - Open directory for files ... 08:59:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:59:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:59:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:13 INFO - (blobuploader) - INFO - Done attempting. 08:59:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:59:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:59:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:18 INFO - (blobuploader) - INFO - Done attempting. 08:59:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:59:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:59:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:19 INFO - (blobuploader) - INFO - Done attempting. 08:59:19 INFO - (blobuploader) - INFO - Iteration through files over. 08:59:19 INFO - Return code: 0 08:59:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:59:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:59:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6954dc9132894ce730a2fc107e4b7f1d899ca753f6ee71aa88e7e84c1f6adc9979f83a50db2747fbc7ff92ffca941265515c83ddada42c5104edd2f63524d618", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05491556aa735c2445bbb88a7af6e1f8adc9d9cd4efb785ea731d09d7dc2fb2f8ec78425c1c0d812ec560bf9614137087cad990af0d68faa71f9378178dc1a5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc5ddd0d627dbac2bce92691626437dab8a5de7ed5e2401213e8466d51e0deb039b8ff1ba4869be719ad43bb0090bb4e64a132181d4d7c503b2bd5bf1a8eb68e"} 08:59:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:59:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:59:19 INFO - Contents: 08:59:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6954dc9132894ce730a2fc107e4b7f1d899ca753f6ee71aa88e7e84c1f6adc9979f83a50db2747fbc7ff92ffca941265515c83ddada42c5104edd2f63524d618", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05491556aa735c2445bbb88a7af6e1f8adc9d9cd4efb785ea731d09d7dc2fb2f8ec78425c1c0d812ec560bf9614137087cad990af0d68faa71f9378178dc1a5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc5ddd0d627dbac2bce92691626437dab8a5de7ed5e2401213e8466d51e0deb039b8ff1ba4869be719ad43bb0090bb4e64a132181d4d7c503b2bd5bf1a8eb68e"} 08:59:19 INFO - Running post-run listener: copy_logs_to_upload_dir 08:59:19 INFO - Copying logs to upload dir... 08:59:19 INFO - mkdir: /builds/slave/test/build/upload/logs 08:59:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.946828 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-25 08:59:19.470055) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 08:59:19.474731) ========= 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=00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894 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/6954dc9132894ce730a2fc107e4b7f1d899ca753f6ee71aa88e7e84c1f6adc9979f83a50db2747fbc7ff92ffca941265515c83ddada42c5104edd2f63524d618", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05491556aa735c2445bbb88a7af6e1f8adc9d9cd4efb785ea731d09d7dc2fb2f8ec78425c1c0d812ec560bf9614137087cad990af0d68faa71f9378178dc1a5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc5ddd0d627dbac2bce92691626437dab8a5de7ed5e2401213e8466d51e0deb039b8ff1ba4869be719ad43bb0090bb4e64a132181d4d7c503b2bd5bf1a8eb68e"} build_url:https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/Jv0E-EECS7maNke5TzLp7w/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/6954dc9132894ce730a2fc107e4b7f1d899ca753f6ee71aa88e7e84c1f6adc9979f83a50db2747fbc7ff92ffca941265515c83ddada42c5104edd2f63524d618", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05491556aa735c2445bbb88a7af6e1f8adc9d9cd4efb785ea731d09d7dc2fb2f8ec78425c1c0d812ec560bf9614137087cad990af0d68faa71f9378178dc1a5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc5ddd0d627dbac2bce92691626437dab8a5de7ed5e2401213e8466d51e0deb039b8ff1ba4869be719ad43bb0090bb4e64a132181d4d7c503b2bd5bf1a8eb68e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 08:59:19.502893) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:59:19.503224) ========= 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=00204705a9daa57ed339a427000001b9-1477406981.984529-1629602894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:59:19.585007) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 08:59:19.588359) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 08:59:19.588713) ========= ========= Total master_lag: 0.21 =========