builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1472569745.55 results: success (0) buildid: 20160830065222 builduid: 67f6230901914b53aa0f93b794d0bc8a revision: cd0957de64a0186a148f5f781044456b94d231c6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 08:09:05.551641) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 08:09:05.552069) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 08:09:05.552363) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 08:09:05.619511) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:09:05.619830) ========= 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=df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 08:09:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.9M=0s 2016-08-30 08:09:05 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075960 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:09:05.744413) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:09:05.744729) ========= 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=df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015152 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:09:05.815486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:09:05.815859) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cd0957de64a0186a148f5f781044456b94d231c6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cd0957de64a0186a148f5f781044456b94d231c6 --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=df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 08:09:05,889 truncating revision to first 12 chars 2016-08-30 08:09:05,889 Setting DEBUG logging. 2016-08-30 08:09:05,889 attempt 1/10 2016-08-30 08:09:05,889 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cd0957de64a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 08:09:06,341 unpacking tar archive at: mozilla-central-cd0957de64a0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.772743 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:09:06.608376) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 08:09:06.608684) ========= script_repo_revision: cd0957de64a0186a148f5f781044456b94d231c6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 08:09:06.609094) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 08:09:06.609364) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 08:09:06.621384) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-30 08:09:06.621699) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:09:06 INFO - MultiFileLogger online at 20160830 08:09:06 in /builds/slave/test 08:09:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:09:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:09:06 INFO - {'append_to_log': False, 08:09:06 INFO - 'base_work_dir': '/builds/slave/test', 08:09:06 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:09:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:09:06 INFO - 'branch': 'Firefox-Non-PGO', 08:09:06 INFO - 'buildbot_json_path': 'buildprops.json', 08:09:06 INFO - 'config_files': ('talos/linux_config.py',), 08:09:06 INFO - 'default_actions': ('clobber', 08:09:06 INFO - 'read-buildbot-config', 08:09:06 INFO - 'download-and-extract', 08:09:06 INFO - 'populate-webroot', 08:09:06 INFO - 'create-virtualenv', 08:09:06 INFO - 'install', 08:09:06 INFO - 'run-tests'), 08:09:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:09:06 INFO - 'download_minidump_stackwalk': True, 08:09:06 INFO - 'download_symbols': 'ondemand', 08:09:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:09:06 INFO - 'tooltool.py': '/tools/tooltool.py', 08:09:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:09:06 INFO - '/tools/misc-python/virtualenv.py')}, 08:09:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:09:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:09:06 INFO - 'installer_path': 'installer.exe', 08:09:06 INFO - 'log_level': 'info', 08:09:06 INFO - 'log_name': 'talos', 08:09:06 INFO - 'log_to_console': True, 08:09:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:09:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:09:06 INFO - 'opt_config_files': (), 08:09:06 INFO - 'pip_index': False, 08:09:06 INFO - 'sps_profile': False, 08:09:06 INFO - 'sps_profile_interval': 0, 08:09:06 INFO - 'suite': 'dromaeojs', 08:09:06 INFO - 'system_bits': '32', 08:09:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:09:06 INFO - 'title': 'talos-linux64-ix-021', 08:09:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:09:06 INFO - 'use_talos_json': True, 08:09:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:09:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:09:06 INFO - 'work_dir': 'build'} 08:09:06 INFO - [mozharness: 2016-08-30 15:09:06.789061Z] Running clobber step. 08:09:06 INFO - Running pre-action listener: _resource_record_pre_action 08:09:06 INFO - Running main action method: clobber 08:09:06 INFO - rmtree: /builds/slave/test/build 08:09:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:09:07 INFO - Running post-action listener: _resource_record_post_action 08:09:07 INFO - [mozharness: 2016-08-30 15:09:07.246193Z] Finished clobber step (success) 08:09:07 INFO - [mozharness: 2016-08-30 15:09:07.246296Z] Running read-buildbot-config step. 08:09:07 INFO - Running pre-action listener: _resource_record_pre_action 08:09:07 INFO - Running main action method: read_buildbot_config 08:09:07 INFO - Using buildbot properties: 08:09:07 INFO - { 08:09:07 INFO - "project": "", 08:09:07 INFO - "product": "firefox", 08:09:07 INFO - "script_repo_revision": "production", 08:09:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:09:07 INFO - "repository": "", 08:09:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:09:07 INFO - "buildid": "20160830065222", 08:09:07 INFO - "pgo_build": "False", 08:09:07 INFO - "basedir": "/builds/slave/test", 08:09:07 INFO - "buildnumber": 194, 08:09:07 INFO - "slavename": "talos-linux64-ix-021", 08:09:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:09:07 INFO - "platform": "ubuntu64_hw", 08:09:07 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:09:07 INFO - "branch": "mozilla-central", 08:09:07 INFO - "repo_path": "mozilla-central", 08:09:07 INFO - "revision": "cd0957de64a0186a148f5f781044456b94d231c6", 08:09:07 INFO - "stage_platform": "linux64", 08:09:07 INFO - "builduid": "67f6230901914b53aa0f93b794d0bc8a", 08:09:07 INFO - "slavebuilddir": "test" 08:09:07 INFO - } 08:09:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:09:07 INFO - Running post-action listener: _resource_record_post_action 08:09:07 INFO - [mozharness: 2016-08-30 15:09:07.248740Z] Finished read-buildbot-config step (success) 08:09:07 INFO - [mozharness: 2016-08-30 15:09:07.248829Z] Running download-and-extract step. 08:09:07 INFO - Running pre-action listener: _resource_record_pre_action 08:09:07 INFO - Running main action method: download_and_extract 08:09:07 INFO - mkdir: /builds/slave/test/build/tests 08:09: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:09:07 INFO - trying https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:09:07 INFO - Downloading https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:09:07 INFO - Downloaded 1361 bytes. 08:09:07 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:09:07 INFO - Using the following test package requirements: 08:09:07 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:09:07 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:09:07 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:09:07 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:07 INFO - u'jsshell-linux-x86_64.zip'], 08:09:07 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:09:07 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:09:07 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:09:07 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:09:07 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:09:07 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:09:07 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:09: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:09:07 INFO - trying https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:09:07 INFO - Downloading https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:09:08 INFO - Downloaded 20315656 bytes. 08:09:08 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:09:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:09: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:09:13 INFO - trying https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:09:13 INFO - Downloading https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:09:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:09:14 INFO - Downloaded 20315656 bytes. 08:09:14 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:18 INFO - trying https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:09:18 INFO - Downloading https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:09:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:09:19 INFO - Downloaded 14413998 bytes. 08:09:19 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:19 INFO - trying https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:09:19 INFO - Downloading https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:09:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:09:21 INFO - Downloaded 55850563 bytes. 08:09:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:09:21 INFO - mkdir: /builds/slave/test/properties 08:09:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:09:21 INFO - Writing to file /builds/slave/test/properties/build_url 08:09:21 INFO - Contents: 08:09:21 INFO - build_url:https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:09:22 INFO - Running post-action listener: _resource_record_post_action 08:09:22 INFO - Running post-action listener: set_extra_try_arguments 08:09:22 INFO - [mozharness: 2016-08-30 15:09:22.287800Z] Finished download-and-extract step (success) 08:09:22 INFO - [mozharness: 2016-08-30 15:09:22.288031Z] Running populate-webroot step. 08:09:22 INFO - Running pre-action listener: _resource_record_pre_action 08:09:22 INFO - Running main action method: populate_webroot 08:09:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:09:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:09:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:09:22 INFO - '--tppagecycles', 08:09:22 INFO - '7'], 08:09:22 INFO - 'tests': ['tsvgm']}}, 08:09:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:09:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:09:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:09:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:09:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:09:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:09:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:22 INFO - 'talos_options': ['--disable-e10s'], 08:09:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:22 INFO - 'talos_options': ['--disable-e10s'], 08:09:22 INFO - 'tests': ['damp', 'tps']}, 08:09:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:22 INFO - 'tests': ['damp', 'tps']}, 08:09:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:09:22 INFO - 'tests': ['dromaeo_dom']}, 08:09:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:09:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:09:22 INFO - 'tests': ['basic_compositor_video']}, 08:09:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:09:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:09:22 INFO - 'tests': ['a11yr', 08:09:22 INFO - 'ts_paint', 08:09:22 INFO - 'tpaint', 08:09:22 INFO - 'sessionrestore', 08:09:22 INFO - 'sessionrestore_no_auto_restore', 08:09:22 INFO - 'tabpaint']}, 08:09:22 INFO - 'other-e10s': {'tests': ['a11yr', 08:09:22 INFO - 'ts_paint', 08:09:22 INFO - 'tpaint', 08:09:22 INFO - 'sessionrestore', 08:09:22 INFO - 'sessionrestore_no_auto_restore', 08:09:22 INFO - 'tabpaint']}, 08:09:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:09:22 INFO - 'ts_paint', 08:09:22 INFO - 'tpaint', 08:09:22 INFO - 'sessionrestore', 08:09:22 INFO - 'sessionrestore_no_auto_restore', 08:09:22 INFO - 'tabpaint']}, 08:09:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:09:22 INFO - 'ts_paint', 08:09:22 INFO - 'tpaint', 08:09:22 INFO - 'sessionrestore', 08:09:22 INFO - 'sessionrestore_no_auto_restore', 08:09:22 INFO - 'tabpaint']}, 08:09:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:09:22 INFO - 'tests': ['a11yr', 08:09:22 INFO - 'ts_paint', 08:09:22 INFO - 'tpaint', 08:09:22 INFO - 'sessionrestore', 08:09:22 INFO - 'sessionrestore_no_auto_restore', 08:09:22 INFO - 'tabpaint']}, 08:09:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:09:22 INFO - 'tests': ['a11yr', 08:09:22 INFO - 'ts_paint', 08:09:22 INFO - 'tpaint', 08:09:22 INFO - 'sessionrestore', 08:09:22 INFO - 'sessionrestore_no_auto_restore', 08:09:22 INFO - 'tabpaint']}, 08:09:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:09:22 INFO - 'tests': ['tsvgx', 08:09:22 INFO - 'tsvgr_opacity', 08:09:22 INFO - 'tart', 08:09:22 INFO - 'tscrollx', 08:09:22 INFO - 'cart']}, 08:09:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:09:22 INFO - 'tsvgr_opacity', 08:09:22 INFO - 'tart', 08:09:22 INFO - 'tscrollx', 08:09:22 INFO - 'cart']}, 08:09:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:22 INFO - 'talos_options': ['--disable-e10s'], 08:09:22 INFO - 'tests': ['tp5o']}, 08:09:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:22 INFO - 'tests': ['tp5o']}, 08:09:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:22 INFO - 'talos_options': ['--disable-e10s', 08:09:22 INFO - '--xperf_path', 08:09:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:22 INFO - 'tests': ['tp5n']}, 08:09:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:22 INFO - 'talos_options': ['--xperf_path', 08:09:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:22 INFO - 'tests': ['tp5n']}}, 08:09:22 INFO - 'talos.zip': {'path': '', 08:09:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:09:22 INFO - Running post-action listener: _resource_record_post_action 08:09:22 INFO - [mozharness: 2016-08-30 15:09:22.304669Z] Finished populate-webroot step (success) 08:09:22 INFO - [mozharness: 2016-08-30 15:09:22.304759Z] Running create-virtualenv step. 08:09:22 INFO - Running pre-action listener: _resource_record_pre_action 08:09:22 INFO - Running main action method: create_virtualenv 08:09:22 INFO - Creating virtualenv /builds/slave/test/build/venv 08:09:22 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:09:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:09:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:09:22 INFO - Using real prefix '/usr' 08:09:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:09:22 INFO - Installing distribute.............................................................................................................................................................................................done. 08:09:24 INFO - Installing pip.................done. 08:09:24 INFO - Return code: 0 08:09:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f609040df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bde230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8090>, '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 0x2bdb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbe40>, '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': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', '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:09:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:09:24 INFO - Using env: {'DISPLAY': ':0', 08:09:24 INFO - 'HOME': '/home/cltbld', 08:09:24 INFO - 'LANG': 'en_US.UTF-8', 08:09:24 INFO - 'LANGUAGE': 'en_US:en', 08:09:24 INFO - 'LOGNAME': 'cltbld', 08:09:24 INFO - 'MAIL': '/var/mail/cltbld', 08:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:24 INFO - 'MOZ_NO_REMOTE': '1', 08:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:24 INFO - 'NO_EM_RESTART': '1', 08:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:24 INFO - 'PWD': '/builds/slave/test', 08:09:24 INFO - 'SHELL': '/bin/bash', 08:09:24 INFO - 'SHLVL': '1', 08:09:24 INFO - 'TERM': 'linux', 08:09:24 INFO - 'TMOUT': '86400', 08:09:24 INFO - 'USER': 'cltbld', 08:09:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', 08:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:24 INFO - '_': '/tools/buildbot/bin/python'} 08:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:25 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:09:25 INFO - Cleaning up... 08:09:25 INFO - Return code: 0 08:09:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:25 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 0x7f609040df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bde230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8090>, '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 0x2bdb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbe40>, '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': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', '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:09:25 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:09:25 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:09:25 INFO - Using env: {'DISPLAY': ':0', 08:09:25 INFO - 'HOME': '/home/cltbld', 08:09:25 INFO - 'LANG': 'en_US.UTF-8', 08:09:25 INFO - 'LANGUAGE': 'en_US:en', 08:09:25 INFO - 'LOGNAME': 'cltbld', 08:09:25 INFO - 'MAIL': '/var/mail/cltbld', 08:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:25 INFO - 'MOZ_NO_REMOTE': '1', 08:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:25 INFO - 'NO_EM_RESTART': '1', 08:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:25 INFO - 'PWD': '/builds/slave/test', 08:09:25 INFO - 'SHELL': '/bin/bash', 08:09:25 INFO - 'SHLVL': '1', 08:09:25 INFO - 'TERM': 'linux', 08:09:25 INFO - 'TMOUT': '86400', 08:09:25 INFO - 'USER': 'cltbld', 08:09:25 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', 08:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:25 INFO - '_': '/tools/buildbot/bin/python'} 08:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:25 INFO - Downloading/unpacking psutil>=3.1.1 08:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:09:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:27 INFO - Installing collected packages: psutil 08:09:27 INFO - Running setup.py install for psutil 08:09:27 INFO - building 'psutil._psutil_linux' extension 08:09:27 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:09:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:09:27 INFO - building 'psutil._psutil_posix' extension 08:09:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:09:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:09:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:27 INFO - Successfully installed psutil 08:09:27 INFO - Cleaning up... 08:09:27 INFO - Return code: 0 08:09:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f609040df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bde230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8090>, '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 0x2bdb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbe40>, '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': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', '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:09:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:09:27 INFO - Using env: {'DISPLAY': ':0', 08:09:27 INFO - 'HOME': '/home/cltbld', 08:09:27 INFO - 'LANG': 'en_US.UTF-8', 08:09:27 INFO - 'LANGUAGE': 'en_US:en', 08:09:27 INFO - 'LOGNAME': 'cltbld', 08:09:27 INFO - 'MAIL': '/var/mail/cltbld', 08:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:27 INFO - 'MOZ_NO_REMOTE': '1', 08:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:27 INFO - 'NO_EM_RESTART': '1', 08:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:27 INFO - 'PWD': '/builds/slave/test', 08:09:27 INFO - 'SHELL': '/bin/bash', 08:09:27 INFO - 'SHLVL': '1', 08:09:27 INFO - 'TERM': 'linux', 08:09:27 INFO - 'TMOUT': '86400', 08:09:27 INFO - 'USER': 'cltbld', 08:09:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', 08:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:27 INFO - '_': '/tools/buildbot/bin/python'} 08:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:09:28 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:09:28 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:09:28 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:09:28 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:09:28 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:09:28 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:09:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:09:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:09:30 INFO - Installing collected packages: mozsystemmonitor 08:09:30 INFO - Running setup.py install for mozsystemmonitor 08:09:30 INFO - Successfully installed mozsystemmonitor 08:09:30 INFO - Cleaning up... 08:09:30 INFO - Return code: 0 08:09:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f609040df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bde230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8090>, '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 0x2bdb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbe40>, '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': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', '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:09:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:09:30 INFO - Using env: {'DISPLAY': ':0', 08:09:30 INFO - 'HOME': '/home/cltbld', 08:09:30 INFO - 'LANG': 'en_US.UTF-8', 08:09:30 INFO - 'LANGUAGE': 'en_US:en', 08:09:30 INFO - 'LOGNAME': 'cltbld', 08:09:30 INFO - 'MAIL': '/var/mail/cltbld', 08:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:30 INFO - 'MOZ_NO_REMOTE': '1', 08:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:30 INFO - 'NO_EM_RESTART': '1', 08:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:30 INFO - 'PWD': '/builds/slave/test', 08:09:30 INFO - 'SHELL': '/bin/bash', 08:09:30 INFO - 'SHLVL': '1', 08:09:30 INFO - 'TERM': 'linux', 08:09:30 INFO - 'TMOUT': '86400', 08:09:30 INFO - 'USER': 'cltbld', 08:09:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', 08:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:30 INFO - '_': '/tools/buildbot/bin/python'} 08:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:30 INFO - Downloading/unpacking jsonschema==2.5.1 08:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:09:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:32 INFO - Downloading functools32-3.2.3-2.tar.gz 08:09:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:09:32 INFO - warning: no files found matching '*.txt' 08:09:32 INFO - no previously-included directories found matching 'build' 08:09:32 INFO - no previously-included directories found matching 'dist' 08:09:32 INFO - no previously-included directories found matching '.git*' 08:09:32 INFO - Installing collected packages: jsonschema, functools32 08:09:32 INFO - Running setup.py install for functools32 08:09:32 INFO - warning: no files found matching '*.txt' 08:09:32 INFO - no previously-included directories found matching 'build' 08:09:32 INFO - no previously-included directories found matching 'dist' 08:09:32 INFO - no previously-included directories found matching '.git*' 08:09:32 INFO - Successfully installed jsonschema functools32 08:09:32 INFO - Cleaning up... 08:09:32 INFO - Return code: 0 08:09:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f609040df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bde230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8090>, '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 0x2bdb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbe40>, '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': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', '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:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:09:32 INFO - Using env: {'DISPLAY': ':0', 08:09:32 INFO - 'HOME': '/home/cltbld', 08:09:32 INFO - 'LANG': 'en_US.UTF-8', 08:09:32 INFO - 'LANGUAGE': 'en_US:en', 08:09:32 INFO - 'LOGNAME': 'cltbld', 08:09:32 INFO - 'MAIL': '/var/mail/cltbld', 08:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:32 INFO - 'MOZ_NO_REMOTE': '1', 08:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:32 INFO - 'NO_EM_RESTART': '1', 08:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:32 INFO - 'PWD': '/builds/slave/test', 08:09:32 INFO - 'SHELL': '/bin/bash', 08:09:32 INFO - 'SHLVL': '1', 08:09:32 INFO - 'TERM': 'linux', 08:09:32 INFO - 'TMOUT': '86400', 08:09:32 INFO - 'USER': 'cltbld', 08:09:32 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', 08:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:32 INFO - '_': '/tools/buildbot/bin/python'} 08:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:09:32 INFO - Cleaning up... 08:09:32 INFO - Return code: 0 08:09:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f609040df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bde230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8090>, '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 0x2bdb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbe40>, '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': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', '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:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:09:32 INFO - Using env: {'DISPLAY': ':0', 08:09:32 INFO - 'HOME': '/home/cltbld', 08:09:32 INFO - 'LANG': 'en_US.UTF-8', 08:09:32 INFO - 'LANGUAGE': 'en_US:en', 08:09:32 INFO - 'LOGNAME': 'cltbld', 08:09:32 INFO - 'MAIL': '/var/mail/cltbld', 08:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:32 INFO - 'MOZ_NO_REMOTE': '1', 08:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:32 INFO - 'NO_EM_RESTART': '1', 08:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:32 INFO - 'PWD': '/builds/slave/test', 08:09:32 INFO - 'SHELL': '/bin/bash', 08:09:32 INFO - 'SHLVL': '1', 08:09:32 INFO - 'TERM': 'linux', 08:09:32 INFO - 'TMOUT': '86400', 08:09:32 INFO - 'USER': 'cltbld', 08:09:32 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', 08:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:32 INFO - '_': '/tools/buildbot/bin/python'} 08:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:33 INFO - Downloading/unpacking blobuploader==1.2.4 08:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:35 INFO - Downloading blobuploader-1.2.4.tar.gz 08:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:09:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:09:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:35 INFO - Downloading docopt-0.6.1.tar.gz 08:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:09:35 INFO - Installing collected packages: blobuploader, requests, docopt 08:09:35 INFO - Running setup.py install for blobuploader 08:09:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:09:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:09:35 INFO - Running setup.py install for requests 08:09:36 INFO - Running setup.py install for docopt 08:09:36 INFO - Successfully installed blobuploader requests docopt 08:09:36 INFO - Cleaning up... 08:09:36 INFO - Return code: 0 08:09:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f609040df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bde230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8090>, '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 0x2bdb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbe40>, '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': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', '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:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:36 INFO - Using env: {'DISPLAY': ':0', 08:09:36 INFO - 'HOME': '/home/cltbld', 08:09:36 INFO - 'LANG': 'en_US.UTF-8', 08:09:36 INFO - 'LANGUAGE': 'en_US:en', 08:09:36 INFO - 'LOGNAME': 'cltbld', 08:09:36 INFO - 'MAIL': '/var/mail/cltbld', 08:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:36 INFO - 'MOZ_NO_REMOTE': '1', 08:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:36 INFO - 'NO_EM_RESTART': '1', 08:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:36 INFO - 'PWD': '/builds/slave/test', 08:09:36 INFO - 'SHELL': '/bin/bash', 08:09:36 INFO - 'SHLVL': '1', 08:09:36 INFO - 'TERM': 'linux', 08:09:36 INFO - 'TMOUT': '86400', 08:09:36 INFO - 'USER': 'cltbld', 08:09:36 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', 08:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:36 INFO - '_': '/tools/buildbot/bin/python'} 08:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:36 INFO - Running setup.py (path:/tmp/pip-EsIgWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:36 INFO - Running setup.py (path:/tmp/pip-Q_XAxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:36 INFO - Running setup.py (path:/tmp/pip-kFr61v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:36 INFO - Running setup.py (path:/tmp/pip-PuPP0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:36 INFO - Running setup.py (path:/tmp/pip-BgG_Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:37 INFO - Running setup.py (path:/tmp/pip-DtB3b8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:37 INFO - Running setup.py (path:/tmp/pip-HX_TS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:37 INFO - Running setup.py (path:/tmp/pip-nnQRUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:37 INFO - Running setup.py (path:/tmp/pip-zDvF9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:37 INFO - Running setup.py (path:/tmp/pip-hwgYGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:37 INFO - Running setup.py (path:/tmp/pip-wHjm3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:37 INFO - Running setup.py (path:/tmp/pip-bdAkbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:37 INFO - Running setup.py (path:/tmp/pip-2pEMIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:37 INFO - Running setup.py (path:/tmp/pip-EN1en1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:37 INFO - Running setup.py (path:/tmp/pip-lntDNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:37 INFO - Running setup.py (path:/tmp/pip-tOVvgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:37 INFO - Running setup.py (path:/tmp/pip-24sXGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:37 INFO - Running setup.py install for manifestparser 08:09:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:09:37 INFO - Running setup.py install for mozcrash 08:09:38 INFO - Running setup.py install for mozdebug 08:09:38 INFO - Running setup.py install for mozdevice 08:09:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Running setup.py install for mozfile 08:09:38 INFO - Running setup.py install for mozhttpd 08:09:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Running setup.py install for mozinfo 08:09:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Running setup.py install for mozInstall 08:09:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Running setup.py install for mozleak 08:09:38 INFO - Running setup.py install for mozlog 08:09:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Running setup.py install for moznetwork 08:09:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:09:39 INFO - Running setup.py install for mozprocess 08:09:39 INFO - Running setup.py install for mozprofile 08:09:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:09:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:09:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:09:39 INFO - Running setup.py install for mozrunner 08:09:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:09:39 INFO - Running setup.py install for mozscreenshot 08:09:39 INFO - Running setup.py install for moztest 08:09:39 INFO - Running setup.py install for mozversion 08:09:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:09:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:39 INFO - Cleaning up... 08:09:39 INFO - Return code: 0 08:09:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f609040df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bde230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8090>, '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 0x2bdb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbe40>, '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': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', '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:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:39 INFO - Using env: {'DISPLAY': ':0', 08:09:39 INFO - 'HOME': '/home/cltbld', 08:09:39 INFO - 'LANG': 'en_US.UTF-8', 08:09:39 INFO - 'LANGUAGE': 'en_US:en', 08:09:39 INFO - 'LOGNAME': 'cltbld', 08:09:39 INFO - 'MAIL': '/var/mail/cltbld', 08:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:39 INFO - 'MOZ_NO_REMOTE': '1', 08:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:39 INFO - 'NO_EM_RESTART': '1', 08:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:39 INFO - 'PWD': '/builds/slave/test', 08:09:39 INFO - 'SHELL': '/bin/bash', 08:09:39 INFO - 'SHLVL': '1', 08:09:39 INFO - 'TERM': 'linux', 08:09:39 INFO - 'TMOUT': '86400', 08:09:39 INFO - 'USER': 'cltbld', 08:09:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', 08:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:39 INFO - '_': '/tools/buildbot/bin/python'} 08:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:39 INFO - Running setup.py (path:/tmp/pip-UGnJJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:39 INFO - Running setup.py (path:/tmp/pip-BokvYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:40 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:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:40 INFO - Running setup.py (path:/tmp/pip-ljtGar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:40 INFO - Running setup.py (path:/tmp/pip-NgJF2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:40 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:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:40 INFO - Running setup.py (path:/tmp/pip-XgybEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:40 INFO - Running setup.py (path:/tmp/pip-GeRcSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:40 INFO - Running setup.py (path:/tmp/pip-iCh6vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:40 INFO - Running setup.py (path:/tmp/pip-SI64_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:40 INFO - Running setup.py (path:/tmp/pip-ro_q7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:40 INFO - Running setup.py (path:/tmp/pip-xUTjxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:40 INFO - Running setup.py (path:/tmp/pip-804fW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:40 INFO - Running setup.py (path:/tmp/pip-HCRPB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:40 INFO - Running setup.py (path:/tmp/pip-zhfdZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:40 INFO - Running setup.py (path:/tmp/pip-7r0Cdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:40 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:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:40 INFO - Running setup.py (path:/tmp/pip-yUduTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:40 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:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:40 INFO - Running setup.py (path:/tmp/pip-_m89eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:41 INFO - Running setup.py (path:/tmp/pip-uI6dIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:42 INFO - Downloading blessings-1.6.tar.gz 08:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:43 INFO - Installing collected packages: blessings 08:09:43 INFO - Running setup.py install for blessings 08:09:43 INFO - Successfully installed blessings 08:09:43 INFO - Cleaning up... 08:09:43 INFO - Return code: 0 08:09:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:09:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:43 INFO - Reading from file tmpfile_stdout 08:09:43 INFO - Current package versions: 08:09:43 INFO - argparse == 1.2.1 08:09:43 INFO - blessings == 1.6 08:09:43 INFO - blobuploader == 1.2.4 08:09:43 INFO - docopt == 0.6.1 08:09:43 INFO - functools32 == 3.2.3-2 08:09:43 INFO - jsonschema == 2.5.1 08:09:43 INFO - manifestparser == 1.1 08:09:43 INFO - mozInstall == 1.12 08:09:43 INFO - mozcrash == 0.17 08:09:43 INFO - mozdebug == 0.1 08:09:43 INFO - mozdevice == 0.48 08:09:43 INFO - mozfile == 1.2 08:09:43 INFO - mozhttpd == 0.7 08:09:43 INFO - mozinfo == 0.9 08:09:43 INFO - mozleak == 0.1 08:09:43 INFO - mozlog == 3.3 08:09:43 INFO - moznetwork == 0.27 08:09:43 INFO - mozprocess == 0.23 08:09:43 INFO - mozprofile == 0.28 08:09:43 INFO - mozrunner == 6.12 08:09:43 INFO - mozscreenshot == 0.1 08:09:43 INFO - mozsystemmonitor == 0.3 08:09:43 INFO - moztest == 0.7 08:09:43 INFO - mozversion == 1.4 08:09:43 INFO - psutil == 3.1.1 08:09:43 INFO - requests == 1.2.3 08:09:43 INFO - wsgiref == 0.1.2 08:09:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f609040df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bde230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8090>, '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 0x2bdb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbe40>, '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': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', '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:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:43 INFO - Using env: {'DISPLAY': ':0', 08:09:43 INFO - 'HOME': '/home/cltbld', 08:09:43 INFO - 'LANG': 'en_US.UTF-8', 08:09:43 INFO - 'LANGUAGE': 'en_US:en', 08:09:43 INFO - 'LOGNAME': 'cltbld', 08:09:43 INFO - 'MAIL': '/var/mail/cltbld', 08:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:43 INFO - 'MOZ_NO_REMOTE': '1', 08:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:43 INFO - 'NO_EM_RESTART': '1', 08:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:43 INFO - 'PWD': '/builds/slave/test', 08:09:43 INFO - 'SHELL': '/bin/bash', 08:09:43 INFO - 'SHLVL': '1', 08:09:43 INFO - 'TERM': 'linux', 08:09:43 INFO - 'TMOUT': '86400', 08:09:43 INFO - 'USER': 'cltbld', 08:09:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', 08:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:43 INFO - '_': '/tools/buildbot/bin/python'} 08:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:09:43 INFO - Cleaning up... 08:09:43 INFO - Return code: 0 08:09:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f609040df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bde230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8090>, '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 0x2bdb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbe40>, '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': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', '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:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:09:43 INFO - Using env: {'DISPLAY': ':0', 08:09:43 INFO - 'HOME': '/home/cltbld', 08:09:43 INFO - 'LANG': 'en_US.UTF-8', 08:09:43 INFO - 'LANGUAGE': 'en_US:en', 08:09:43 INFO - 'LOGNAME': 'cltbld', 08:09:43 INFO - 'MAIL': '/var/mail/cltbld', 08:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:43 INFO - 'MOZ_NO_REMOTE': '1', 08:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:43 INFO - 'NO_EM_RESTART': '1', 08:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:43 INFO - 'PWD': '/builds/slave/test', 08:09:43 INFO - 'SHELL': '/bin/bash', 08:09:43 INFO - 'SHLVL': '1', 08:09:43 INFO - 'TERM': 'linux', 08:09:43 INFO - 'TMOUT': '86400', 08:09:43 INFO - 'USER': 'cltbld', 08:09:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', 08:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:43 INFO - '_': '/tools/buildbot/bin/python'} 08:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:09:43 INFO - Cleaning up... 08:09:43 INFO - Return code: 0 08:09:43 INFO - Running post-action listener: _resource_record_post_action 08:09:43 INFO - Running post-action listener: _start_resource_monitoring 08:09:43 INFO - Starting resource monitoring. 08:09:43 INFO - [mozharness: 2016-08-30 15:09:43.931084Z] Finished create-virtualenv step (success) 08:09:43 INFO - [mozharness: 2016-08-30 15:09:43.931555Z] Running install step. 08:09:43 INFO - Running pre-action listener: _resource_record_pre_action 08:09:43 INFO - Running main action method: install 08:09:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:44 INFO - Reading from file tmpfile_stdout 08:09:44 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:09:44 INFO - Reading from file tmpfile_stdout 08:09:44 INFO - Output received: 08:09:44 INFO - Usage: mozinstall [options] installer 08:09:44 INFO - Options: 08:09:44 INFO - -h, --help show this help message and exit 08:09:44 INFO - -d DEST, --destination=DEST 08:09:44 INFO - Directory to install application into. [default: 08:09:44 INFO - "/builds/slave/test"] 08:09:44 INFO - --app=APP Application being installed. [default: firefox] 08:09:44 INFO - mkdir: /builds/slave/test/build/application 08:09:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:10:00 INFO - Reading from file tmpfile_stdout 08:10:00 INFO - Output received: 08:10:00 INFO - /builds/slave/test/build/application/firefox/firefox 08:10:00 INFO - Running post-action listener: _resource_record_post_action 08:10:00 INFO - [mozharness: 2016-08-30 15:10:00.369598Z] Finished install step (success) 08:10:00 INFO - [mozharness: 2016-08-30 15:10:00.369878Z] Running run-tests step. 08:10:00 INFO - Running pre-action listener: _resource_record_pre_action 08:10:00 INFO - Running main action method: run_tests 08:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:10:00 INFO - Python 2.7.3 08:10:00 INFO - Return code: 0 08:10:00 INFO - grabbing minidump binary from tooltool 08:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:00 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8090>, '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 0x2bdb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdbe40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:10:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:10:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:10:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:10:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:10:00 INFO - Return code: 0 08:10:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:10:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:10:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:10:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:10:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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:10:00 INFO - Using env: {'DISPLAY': ':0', 08:10:00 INFO - 'HOME': '/home/cltbld', 08:10:00 INFO - 'LANG': 'en_US.UTF-8', 08:10:00 INFO - 'LANGUAGE': 'en_US:en', 08:10:00 INFO - 'LOGNAME': 'cltbld', 08:10:00 INFO - 'MAIL': '/var/mail/cltbld', 08:10:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:10:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:00 INFO - 'MOZ_NO_REMOTE': '1', 08:10:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:00 INFO - 'NO_EM_RESTART': '1', 08:10:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:00 INFO - 'PWD': '/builds/slave/test', 08:10:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:10:00 INFO - 'SHELL': '/bin/bash', 08:10:00 INFO - 'SHLVL': '1', 08:10:00 INFO - 'TERM': 'linux', 08:10:00 INFO - 'TMOUT': '86400', 08:10:00 INFO - 'USER': 'cltbld', 08:10:00 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715', 08:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:00 INFO - '_': '/tools/buildbot/bin/python'} 08:10:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:10:00 INFO - mozversion application_buildid: 20160830065222 08:10:00 INFO - mozversion application_changeset: cd0957de64a0186a148f5f781044456b94d231c6 08:10:00 INFO - mozversion application_display_name: Nightly 08:10:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:10:00 INFO - mozversion application_name: Firefox 08:10:00 INFO - mozversion application_remotingname: firefox 08:10:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:10:00 INFO - mozversion application_vendor: Mozilla 08:10:00 INFO - mozversion application_version: 51.0a1 08:10:00 INFO - mozversion platform_buildid: 20160830065222 08:10:00 INFO - mozversion platform_changeset: cd0957de64a0186a148f5f781044456b94d231c6 08:10:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:10:00 INFO - mozversion platform_version: 51.0a1 08:10:00 INFO - using testdate: 1472569800 08:10:00 INFO - actual date: 1472569800 08:10:00 INFO - starting webserver on 'localhost:39372' 08:10:00 INFO - SUITE-START | Running 2 tests 08:10:00 INFO - TEST-START | dromaeo_css 08:10:00 INFO - operating with platform_type : linux_ 08:10:00 INFO - Initialising browser for dromaeo_css test... 08:10:00 INFO - TEST-INFO | started process 4781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppqNYLk/profile http://localhost:39372/getInfo.html) 08:10:06 INFO - PROCESS | 4781 | __metrics Screen width/height:1600/1200 08:10:06 INFO - PROCESS | 4781 | colorDepth:24 08:10:06 INFO - PROCESS | 4781 | Browser inner width/height: 1024/697 08:10:06 INFO - PROCESS | 4781 | __metrics 08:10:07 INFO - PROCESS | 4781 | 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:10:07 INFO - PROCESS | 4781 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:10:07 INFO - PROCESS | 4781 | console.error: PushService: 08:10:07 INFO - PROCESS | 4781 | stateChangeProcessEnqueue: Error transitioning state 08:10:07 INFO - PROCESS | 4781 | UnknownError 08:10:08 INFO - TEST-INFO | 4781: exit 0 08:10:08 INFO - Browser initialized. 08:10:08 INFO - Running cycle 1/1 for dromaeo_css test... 08:10:08 INFO - TEST-INFO | started process 4862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppqNYLk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:20 INFO - PROCESS | 4862 | RSS: Main: 181596160 08:10:20 INFO - PROCESS | 4862 | 08:11:12 INFO - PROCESS | 4862 | 1472569872746 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:13:26 INFO - PROCESS | 4862 | Cycle 1(1): loaded http://localhost:39372/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39372/tests/dromaeo/cssquery-ext.html) 08:13:27 INFO - PROCESS | 4862 | RSS: Main: 297218048 08:13:27 INFO - PROCESS | 4862 | 08:16:30 INFO - PROCESS | 4862 | Cycle 1(1): loaded http://localhost:39372/tests/dromaeo/cssquery-ext.html (next: http://localhost:39372/tests/dromaeo/cssquery-jquery.html) 08:16:30 INFO - PROCESS | 4862 | RSS: Main: 270974976 08:16:30 INFO - PROCESS | 4862 | 08:19:33 INFO - PROCESS | 4862 | Cycle 1(1): loaded http://localhost:39372/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39372/tests/dromaeo/cssquery-mootools.html) 08:19:33 INFO - PROCESS | 4862 | RSS: Main: 219561984 08:19:33 INFO - PROCESS | 4862 | 08:22:36 INFO - PROCESS | 4862 | Cycle 1(1): loaded http://localhost:39372/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39372/tests/dromaeo/cssquery-prototype.html) 08:22:36 INFO - PROCESS | 4862 | RSS: Main: 219217920 08:22:36 INFO - PROCESS | 4862 | 08:25:39 INFO - PROCESS | 4862 | Cycle 1(1): loaded http://localhost:39372/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39372/tests/dromaeo/cssquery-yui.html) 08:25:40 INFO - PROCESS | 4862 | RSS: Main: 218841088 08:25:40 INFO - PROCESS | 4862 | 08:28:43 INFO - PROCESS | 4862 | Cycle 1(1): loaded http://localhost:39372/tests/dromaeo/cssquery-yui.html (next: http://localhost:39372/tests/dromaeo/cssquery-dojo.html) 08:28:43 INFO - PROCESS | 4862 | RSS: Main: 312664064 08:28:43 INFO - PROCESS | 4862 | 08:28:43 INFO - PROCESS | 4862 | __start_tp_report 08:28:43 INFO - PROCESS | 4862 | _x_x_mozilla_page_load 08:28:43 INFO - PROCESS | 4862 | _x_x_mozilla_page_load_details 08:28:43 INFO - PROCESS | 4862 | |i|pagename|runs| 08:28:43 INFO - PROCESS | 4862 | |0;dojo.html;2592.48150369926;2603.695729279587;2603.7135915049353;2648.311439025854;2659.853708046058;4667.229907065339;4708.36437080994;4726.33831263623;4818.927716084261;4880.097182021324;4681.485036645975;4722.669413141081;4735.526447355272;4759.3812804335475;4786.56920877121;4251.4685664291965;4291.141771645668;4312.913741725163;4384.473863136428;4544;4458.063806600618;4470.2400591899295;4518.728876267418;4543.772811359436;4546.772661366935;4276.935845962282;4317.7193482423545;4407;4412.470503539564;4485.865424037284;4355.477342718862;4373.628241599468;4380.978095109536;4384.188925048876;4387.319965405367;4300.462442194726;4331.025519258142;4336.891577710551;4336.891577710551;4341.131773645252;4702.4592171899985;4705.905881882378;4714.787834547419;4745.335653008581;4833.73414462208;5120.564751996048;5121.641485096045;5122.667026643257;5134.101532231882;5190.818321358772;4986.376702912136;5065.11360511909;5154.123798954187;5157.58739300855;5160.535551800356;4751.216049351819;4780.043991201774;4781.354517140142;4785.282207668877;4841.8547443576745;5188.429272779991;5213.348331458567;5223.347081614798;5228.163493841043;5306.230596563477;4857.198562237191;4961.305417241589;4993.5256150666355;5009.0482808266315;5059.898802024012;5101.158308879068;5124.333836601218;5125.026245013435;5141.9742901286;5188.870278243074;5070.315507406527;5077.796888124433;5078.339815823993;5080.364954380702;5139.177731562932;4900.093482705711;4944.233643785219;4996.925046124311;5056.696598204119;5057.620678449131;4296.2911119664905;4297.312430011246;4303.978480107579;4361.629261512807;4362.672799539983;3740.4202348636004;3742.2702572998546;3743.7005039596766;3779.7921114338974;3784.7918364489665;4305.182015417061;4386;4423.137488189772;4425.690201685851;4467.01725620363;5101.107306221396;5125.333706618116;5135.948640513622;5199.090159222196;5202.843914682566;4416.138852923713;4418.138462999685;4418.337249412614;4422.226110430726;4477.417935668343;4464.4865840428765;4548.044910568818;4601.148787474328;4603.010352774169;4646.442426908792;4754.120487709784;4860.343853579721;4864.562189402971;4870.512948705101;4870.805167793249;5075.898482030265;5083.898322033612;5089.821856235014;5095.541401273903;5157.123289040797;4816.975915120402;4849.830255941025;4855.053264613366;4862.294967229803;4883.145449546386;4952.4057113146655;4960.280759289955;4977.178765503651;5004.749762511933;5064.215046667772;5071.77177027042;5085.593152547861;5089.745512724423;5093.821716239914;5124.590032797441;4932.186189278872;4939.086269040239;4951.133551628523;4952.727599982036;4961.553906331226;4857.708537487762;4912.45962944083;4931.2849636803185;4963.5780958618925;5009.924851127309;4881.90236195267;4887.951120488749;4891.437484689306;4896.730679812502;4943.159662857251;4777.856664300077;4847.878803029953;4976.825811096594;4977.651564390458;4985.875353116056;4715.457722361973;4881.096997055556;4916.459189489082;4948.158813001726;4994.925076123934 08:28:43 INFO - PROCESS | 4862 | |1;ext.html;554.7060058169167;559.4573263933983;561.200289587338;577.1256546332307;579.1573260905383;26741.33146671334;36626.63373366269;37771.81114094432;37846;41427.58572414275;37992.62007379932;38104;38285;38494.230115397746;38504.61495385052;7592.354649854755;7745.767626971172;7749.263819937097;7755.689772409125;7757.844843103135;7564;7653;7653.234676532358;7655.311022008018;7658.042744656918;7651.1583725790115;7720.845583088335;7721.227877212262;7732.652030658605;7769.106552746422;7664.923350766477;7688.500247483896;7707.730229441999;7710.267524585155;7710.807229819271;7693.115291741409;7744.2642948919765;7760.767176984643;7763.922360776376;7790.415718821055;34615.82692086549;34746.478802817976;34886;34929.650703492895;34950.47574286388;2913.606663100497;2976.389840082778;3215.4855223164413;3252.495863141217;3578.8031658258788;27175.45649087027;27532.311692207655;27740.583891241648;27856;27921.162365128876;3426.417509023472;3520.6479352064844;3538.3630946429635;3593.1017245688577;3607.5310209672575;236855;236859;237312;237705;237846.8107659468;48476.7576162117;49058.75470622624;49149.50850491521;49161.75419122953;49192.50807491951;51406.74296628493;51417.485825142016;51469.227961580604;51512.742436287575;51583.48416515862;13049.673758156123;13371.665708357368;13384;13385.598432047054;13397.598072057854;10239.232057595711;10256.12822910061;10272.743181420525;10298.021687939783;10300.072993430627;13925.721485570435;14523.854761452461;14540.709185816224;14586.562403127924;14733.968622196558;5887.2052272943465;5924.400411888852;6102.9694851525455;6189.84525386869;6309.148264984168;641.3394203969918;689.3375525545646;813.3046245460165;833.5998720614018;909.7088931541844;26473.602895956577;26981.325466863487;27408.314792129957;27673.861630691717;27922;673.4174938678107;877.8332116897769;906.4878343735768;976.9120779129912;989.0999190736395;13231.206127632373;13741.656458588615;13982.650433739034;14046.1572305662;14098.436062557588;363320;366269;366802;367883;370332;46456.7677161612;46537.53462465332;46542.767286163355;46636;46655;1035.5133087448887;1124.0614087237086;1125.2573301621055;1145.507431804332;1149.5631659969326;26206.737932621192;27576.724232757417;27744.722552774212;27925.581116282865;28978.855105724335;38669.806650966566;39030.80484597672;39052.80473597614;39173.2165356697;39189.80405097956;224135;224865;224931;225525;323055.46389897563;23189.188378406674;24485.26544203677;24492.14277500279;24860;24870;39883.80058099691;40209.1958160841;40301.1939761209;40327.39508907427;41212.38181427341;34624.82687586546;34766.82616586901;34846;34962.125946851535;34969.125771855906;34519.65480345265;34738.30523389467;34864.128396790285;34949.30101397907;35208.29583408266;33934.32131357408;34004;34493.48259776055;34703;34985.65014349824;29992.25019374533;32109.839450802596;32407.51388729124;32549.34901302008;32713.18217044593;24570.63144052805;24663.136790212255;24808.379790505383;25293.494130116927;25543 08:28:43 INFO - PROCESS | 4862 | |2;jquery.html;343.1575482191221;359.4195374470231;360.61594401961906;361.29006502223143;386.8009171568139;12508.124431289802;15632.452864149756;16073.919630401846;17839.64320713585;17994.280228790867;15349.232538373093;15362.69274614507;17073.57316067099;17182.226799794007;17208.483745487654;5024.974875125628;5129.2306154077;5262.131748261532;5475.6440831346035;5512.310961129859;3392.3215356928713;5523.751431185607;5553.666779993213;5567.610267281292;5610.438956104377;5862.179294898718;5920.703964801764;5925.644461332334;5931.436513531207;5935.9406405935815;5737.19679244904;5903.114532820068;6043.546733994968;6048.667323297217;6054.69726513677;5339.119045357511;5345.064613692588;5346;5348.491893270133;5349.43830897754;11832.881671183264;12079.154459187861;12189.146759726822;12280.263184208976;12392.132550721453;1729.2909906938096;1733.5926057376507;2045.836333093349;2228.19784877444;2320.083566991046;8788.64845406183;8873.51195684237;9175.908240917639;9377.296702747253;12805.48778048877;1705.7953045634479;1750.649870026;1753.2548666816551;1783.9018853963028;1791.1760590128556;63715.362846371405;66849.99999999952;70585.64707176482;72078.63960680216;73263;10008.899911000943;10096.646617368357;10170.288079834341;10194.796104077877;10334.741631459274;12849.10056296069;13656.795148072786;13778.724425511433;13791.586252412444;13829.723405531833;6909.170899492093;6986.196587392515;7224;7231.4214862811905;7290.45321600882;6720.630365329856;6723.294054124344;6782.966085169642;6929.203141638675;6972;3825.5218097737784;4060.411240370189;4278.358246263023;4308.590683885026;4350.608445239944;1824.2122719734734;1827.6527459782599;1829.9725504117448;1839.4324605143536;1866.6640004798994;348.1487762420907;354.9503069570262;355.3036049343316;358.65927368999036;707.2397173039004;10112.747181320527;10113.544890479947;10403.219758518142;10470.947645261725;10544.261901666963;379.179077297653;380.581360503444;382.844947796143;402.5531659857556;424.51817187491804;5349.973250133725;5374.704391258519;5464.890702186013;5467.371252305956;5502.614816962854;366282;367289;367965;379944;382237;74927;76402.23597763952;76947.61526192445;78656.60671696605;79666;411.467150040698;413.5182512373112;420.77067997941197;421.69848558280364;423.2719722078021;9319.673811416838;9590;9590.136887680143;9722.611095556382;9820.165285950774;35761;35789.82105089458;36040.098997525274;36270.63729362673;37326.6267337334;49572;52003.73998129985;52892.20661690001;52892.53729857179;53527.46472535225;7249.492535522674;7435.888461672971;7666.961665191861;7745.186755390828;8081.393895457747;9663.806723865624;11720.355380454157;11893.702657433634;12241.632751017483;12528.874711253135;9759.219262458844;9934.652287169914;10119.291649584458;10233.079022887976;10731.463426828472;9597.280203984868;10169.542370593488;10351.43067131315;10418.218633602359;10726.356418614909;10162.39025658463;10582.682519524427;10704.625338113128;10881.238313318308;11269.267497612629;7276.672549735381;7585.127710313384;7632.580208088609;7746.651400687096;7873.881891771743;9142.451452912846;10023.548940297558;10260.538275777459;10344.482775861328;10541.420221887563 08:28:43 INFO - PROCESS | 4862 | |3;mootools.html;1370.3696299702133;1395.5185461015951;1498.8950773445856;1694.339207708993;1711.0247159119308;7387.852242955138;7960.164182760814;7967.60161991901;7970.601469926502;7973.681052757897;6771.3228677132265;6975.895361569568;6987.0567473391075;7140.75007374742;7824.608769561513;2092.9267475638317;2172.196287373666;2173.076442511926;2186.4971056656977;2192.1012384922187;2189.4854709143337;2194.122351059573;2216.9556608867815;2217.1131547381096;2218.6006518826603;2193.144673577306;2203.8787866667326;2206.172685243034;2208.624533829253;2209.0501084533644;2119.9788002119935;2132.3922682035623;2140.2402147237663;2142.6036183306137;2142.646463333548;2037.5517386175018;2044.0699481735774;2044.356027851222;2085.7497100348055;2160.5678864227216;7927.603619818986;7955.4828936118965;8024.15746346631;8040.839183216303;8043.55760433176;4501.144782491317;4625.398698169217;4636.420447444069;4642.3500709900645;4645.88385290367;2755.669319681631;2880.5967164596973;2911.956320655192;2922.444735500248;2983.0454254638526;895.2748273898098;924.2375040591471;940.7177846646048;951.5575257505293;952.9618815247381;10664.253502254845;10690.893091069067;10704.357738535713;10714.892851071467;10741.946290268577;3961.74248673841;4217.873463796091;4239.745615263094;4259.850905218303;4267.103908179255;9225.584848681825;9250.167484926389;9252.8612070819;9274;9289.256859451363;4698.201305778026;4700;4701.7414042228;4704.858854234379;4709.788059537261;4193.433886425354;4238.830446782094;4256.787160641956;4262.42457268271;4263.275243208662;3317.336532693471;3442.1738782691973;3446.758726889094;3450.2236996675547;3537.7169826413824;1185.6146752305535;1198.1912209258714;1203.4163430736087;1207.0946789907568;1207.5592408770735;758.624480881967;770.8072981754561;770.938324934004;780.9570473624005;795.8766391209256;4624;4714.4106986626675;4735.976320118378;4841.636877234221;4883.804647814119;804.74650485097;821.3716506872247;826.1573195340719;843.1189407069504;845.4124383553494;3162.683731626819;3175.777695561335;3180.061881744891;3196.2968147007623;3298.175456135966;8124;8662;9081.863772043425;9081.909180908238;9106.681266155652;8568.35737319691;8704.433202023696;8877.644894204288;9046;9063.41087829289;6807.829804254834;6899.344562266677;6973.372396484341;6982.79051628452;6984.092068031124;4803.903921921612;4831.734254615889;4891.144049791344;4904.779284932115;5050.191969284897;8239.217274358927;8364.832703346021;8424.115467875785;8440.467859642205;8512.276456501018;8385.245327920517;8532.957335213285;8600.956995214983;8682.175193356621;8683.348748843988;6273.905891411541;6276.403741644719;6316.873662526816;6435.03474478832;6482.57863238888;6402.071699603438;7140.178879428724;7186.38915692172;7190.496665233383;7193.208747037717;6003.90994135097;6438.259600146043;6457.671481947811;6457.773977910751;6681.532292739462;6393.424591786761;6395.136656551306;6402;6467.482601391784;6491.675416229265;5756.597038207286;5798.10129429939;5816.47651711348;5818.069108942549;5871.911921321269;4244.91510169801;4248.426462427533;4249.46881639795;4310.1810655976515;4500.189965806056;4197.622214000755;4222.619964203236;4250.06498570314;4322.524522302481;4464.55354464551 08:28:43 INFO - PROCESS | 4862 | |4;prototype.html;295.1897042618013;297.6606668398025;299.9025316772049;304.64356702657886;305.93728285701434;4806.71159730416;4844.927326090112;4864.854054378366;4878.268259761037;4899.363082799236;4753.833615823447;4756.429228492577;4757.215059515184;4784.880377990552;4852.975735121328;3620.8913732588067;3672.5225720656276;3813.218290250506;3837.769733815973;3859.4982652255167;3799.202167544805;3804.9809750951345;3815.2560250751117;3822.5412950445984;3828.8659896903614;3789.5263092113487;3789.919872836242;3793.696504279651;3797.1076796952834;3798.2783271178528;3588.6052534221476;3639.490471334015;3774.1319496515816;3783.9810800945957;3807.695384369244;3312;3356.7650264481254;3359.639346064848;3364.9327013459592;3400.7109395701395;4650.813967441332;4682;4723.645726570487;4726.834560790356;4741.668083234175;4174.3112386456505;4307.396964424952;4321.913561728779;4325.675574331906;4344;5003.099442100421;5040.445550989388;5048.7980480780725;5056.292119103328;5059.544640982329;3660.652238037382;3688.391415416453;3694.2426802505693;3702.0564203792956;3704.0369503928905;5273.209018647195;5290.788368465295;5296.92054619181;5297.6821390716295;5308.230306605559;3596.964030359663;3727.347714150067;3744.85020599173;3755.962440375616;3767.6813115409386;3765.491658626105;3767.4348847672522;3797.088698712289;3797.7531460454984;3800.524934383202;4232.375926925264;4248.702590818675;4261.701680882308;4280.828766849291;4319.589638984291;4775.641826863;4956.975215123901;4975.577075948512;4988.925166122511;4992.851644121873;1299.5061876487064;1315.81578578999;1317;1319.8020296955533;1323.5169163255343;828.772087675894;856.3277826905849;867.8134201146784;869.4609342207872;875.6059773102002;4069.369247766601;4315.3742707307265;4374.950011997098;4484.843030493982;4491.652504248712;5118.334616499831;5159.922601160985;5162.45794191612;5185.740712964337;5192.637350005738;4506.459224892968;4509.624564507857;4510.797014134372;4515.7967891444305;4525.932111018272;2645.6242753767933;2741.739534744196;2745.876435560365;2750.4499100180046;2761.8066735328334;4922.655414121049;4925.827596034122;4931.495893752368;4939.407271127416;4946.332245146931;5351.60858176869;5359.356877174764;5368.651037682538;5380.166074258496;5380.251418289072;4722.031983443386;4889.706617602955;4897.461279259279;4899.853004409802;4914.901701966012;5170.121079416433;5176.792928282826;5178.611604129781;5184.377874655065;5209.635325527328;4952.7771250294545;5103.923441148311;5116.28372027909;5127.897442051213;5130.48695130484;4888.682235654671;4894.853154405374;4903.803847846046;4906.386701662293;4934.605231581537;3781.4516895049514;3785.9745036406493;3792.5828158901945;3796.3546197145997;3814.8664796731982;5178.404483484447;5192.688438693691;5195.11683013881;5246.737663116753;5274.736263186902;4813.350197723263;5090.923636145535;5105.923411148761;5112.948870511247;5129.2306154075695;5053.787091098184;5055.570276526537;5068.771905264198;5084.567811736044;5085.262636917701;4924.606031517542;5001.099802035668;5009.597312752435;5030;5085.669431486942;4931.457539670561;5037.647364684437;5108.61685373591;5180.171172612364;5185.314772698813;4956.578690811321;4976.825811096594;4997.925031124609;5008.373953255843;5013.771625951519 08:28:43 INFO - PROCESS | 4862 | |5;yui.html;580.8199458167967;624.3537938233927;635.1933045032812;667.4827009067972;727.8398752274504;12002.579909703161;13868.237246951414;13917.09538879972;14028.859711402909;14039.36822842972;12784.93607531961;12991.610251692464;12999;13023.674408139801;13199.868001319985;603.0652488642609;737.0676094740159;738.5605564689015;767.3745897093878;776.1733753552448;754.8905408715733;760.7869796456973;763.8510490454336;764.487793178569;765.3647472597759;807.2049031703797;807.2694211738386;808.6967387229789;809.2878267124922;809.8542262392767;623.1711823275078;758.4804408979867;803.1085495100434;803.2650125135494;803.6022169026311;569.866081470854;572.894014607299;573.0744847071949;573.23473163327;573.435166361134;13620.931895340558;13713.45146194151;13743.312834358341;13748.862511374859;13757.931210343984;11894.82157767634;12421.503139874394;12525.248485090833;12650.746985060247;12916.677083072904;10052.899471005343;10124.949375253076;11591.47838347268;11609.361485118316;11966.162368634199;3998.3602623580086;4128.1330920506725;4195.937060944088;4237.4915010198665;4364.803583838703;56413.43586564164;59886.40113598852;59933.10100348498;60015.69992150055;60041.39958600445;9756.975337645352;9930.602775889029;9962.501874906226;9970.40177589347;10027.749306267402;16261.349546018264;16283.430079947146;16331.510054698378;16345.509634710977;16349.754753678704;6610.669466526654;6653.900191497131;6668.599884006878;6707.429868461236;6973.58158510491;3586.2468881534646;3669.6513831185994;3709.9258014840093;3744.7753134811996;3878.9224215515533;2770.4459108178444;2890.1762997545597;3287.4411350070545;3442.7934323940144;3453.7755045921936;542.3193891665934;544.7684733988118;546.1752753342481;562.4375624375624;574.6494638270651;436.9890752731207;487.07698910564284;504.07753810526646;510.7333812145825;532.5872448852093;7729.521333340007;7927.484713493604;8018.037835459782;8274.586270686563;8395.454295470774;468.37238100944217;521.4082016910834;537.1915267522431;547.1000204663306;552.3868505958383;3804.9809750951067;4000.439938408625;4086.959130408658;4193.6645068394455;4431.313146462304;100363.49818250861;105914;106754;109881.45059274652;112011;90447;92267;92979.53510232405;93888.53055734678;94277.5286123565;77511.61244193742;77889;77901.61049194718;78456;80099.59950200212;8401.23574049432;8688.174623410765;8735.69425070145;8753.737387878375;8804.779880502783;38554;38667.41998869963;39045.80477097596;44840.55159448364;46256.53743462657;58066.4193358061;58132.128018080606;58189.709051456164;58233.70883145557;58351.708241458524;11078.169137314895;11162.776744464903;11222.719432014264;11343.262687925258;11616.825747613962;12547.811782823448;12575.748485030064;12587.93706031464;12667.87332126667;12699.301538415475;11330.660080197607;11366.659000230007;12131.575394861138;12210.328431935974;12499.687507812378;11777.574479933353;11996.64010079699;12124.393780311126;12705.936470317589;12729.236245825281;11453.19827612059;11771.705707357041;11821.822672659744;12394.58854562172;12520.373981301082;10028.64899728506;10234.590616375262;10614.73463163427;10672.413017284123;10755.838662419914;9104.317176211678;9248.398854074463;9761.755956101155;9791.761407646874;10170.491475426346 08:28:43 INFO - PROCESS | 4862 | __end_tp_report 08:28:43 INFO - PROCESS | 4862 | __start_cc_report 08:28:43 INFO - PROCESS | 4862 | _x_x_mozilla_cycle_collect,1119 08:28:43 INFO - PROCESS | 4862 | __end_cc_report 08:28:43 INFO - PROCESS | 4862 | __startTimestamp1472570923603__endTimestamp 08:28:43 INFO - PROCESS | 4862 | 08:28:43 INFO - PROCESS | 4862 | ------- Summary: start ------- 08:28:43 INFO - PROCESS | 4862 | Number of tests: 6 08:28:43 INFO - PROCESS | 4862 | 08:28:43 INFO - PROCESS | 4862 | [#0] dojo.html Cycles:165 Average:4708.32 Median:4857.71 stddev:498.41 (10.3%) stddev-sans-first:471.50 08:28:43 INFO - PROCESS | 4862 | Values: 2592.5 2603.7 2603.7 2648.3 2659.9 4667.2 4708.4 4726.3 4818.9 4880.1 4681.5 4722.7 4735.5 4759.4 4786.6 4251.5 4291.1 4312.9 4384.5 4544.0 4458.1 4470.2 4518.7 4543.8 4546.8 4276.9 4317.7 4407.0 4412.5 4485.9 4355.5 4373.6 4381.0 4384.2 4387.3 4300.5 4331.0 4336.9 4336.9 4341.1 4702.5 4705.9 4714.8 4745.3 4833.7 5120.6 5121.6 5122.7 5134.1 5190.8 4986.4 5065.1 5154.1 5157.6 5160.5 4751.2 4780.0 4781.4 4785.3 4841.9 5188.4 5213.3 5223.3 5228.2 5306.2 4857.2 4961.3 4993.5 5009.0 5059.9 5101.2 5124.3 5125.0 5142.0 5188.9 5070.3 5077.8 5078.3 5080.4 5139.2 4900.1 4944.2 4996.9 5056.7 5057.6 4296.3 4297.3 4304.0 4361.6 4362.7 3740.4 3742.3 3743.7 3779.8 3784.8 4305.2 4386.0 4423.1 4425.7 4467.0 5101.1 5125.3 5135.9 5199.1 5202.8 4416.1 4418.1 4418.3 4422.2 4477.4 4464.5 4548.0 4601.1 4603.0 4646.4 4754.1 4860.3 4864.6 4870.5 4870.8 5075.9 5083.9 5089.8 5095.5 5157.1 4817.0 4849.8 4855.1 4862.3 4883.1 4952.4 4960.3 4977.2 5004.7 5064.2 5071.8 5085.6 5089.7 5093.8 5124.6 4932.2 4939.1 4951.1 4952.7 4961.6 4857.7 4912.5 4931.3 4963.6 5009.9 4881.9 4888.0 4891.4 4896.7 4943.2 4777.9 4847.9 4976.8 4977.7 4985.9 4715.5 4881.1 4916.5 4948.2 4994.9 08:28:43 INFO - PROCESS | 4862 | 08:28:43 INFO - PROCESS | 4862 | [#1] ext.html Cycles:180 Average:43304.99 Median:19364.47 stddev:76282.40 (393.9%) stddev-sans-first:76428.86 08:28:43 INFO - PROCESS | 4862 | Values: 554.7 559.5 561.2 577.1 579.2 26741.3 36626.6 37771.8 37846.0 41427.6 37992.6 38104.0 38285.0 38494.2 38504.6 7592.4 7745.8 7749.3 7755.7 7757.8 7564.0 7653.0 7653.2 7655.3 7658.0 7651.2 7720.8 7721.2 7732.7 7769.1 7664.9 7688.5 7707.7 7710.3 7710.8 7693.1 7744.3 7760.8 7763.9 7790.4 34615.8 34746.5 34886.0 34929.7 34950.5 2913.6 2976.4 3215.5 3252.5 3578.8 27175.5 27532.3 27740.6 27856.0 27921.2 3426.4 3520.6 3538.4 3593.1 3607.5 236855.0 236859.0 237312.0 237705.0 237846.8 48476.8 49058.8 49149.5 49161.8 49192.5 51406.7 51417.5 51469.2 51512.7 51583.5 13049.7 13371.7 13384.0 13385.6 13397.6 10239.2 10256.1 10272.7 10298.0 10300.1 13925.7 14523.9 14540.7 14586.6 14734.0 5887.2 5924.4 6103.0 6189.8 6309.1 641.3 689.3 813.3 833.6 909.7 26473.6 26981.3 27408.3 27673.9 27922.0 673.4 877.8 906.5 976.9 989.1 13231.2 13741.7 13982.7 14046.2 14098.4 363320.0 366269.0 366802.0 367883.0 370332.0 46456.8 46537.5 46542.8 46636.0 46655.0 1035.5 1124.1 1125.3 1145.5 1149.6 26206.7 27576.7 27744.7 27925.6 28978.9 38669.8 39030.8 39052.8 39173.2 39189.8 224135.0 224865.0 224931.0 225525.0 323055.5 23189.2 24485.3 24492.1 24860.0 24870.0 39883.8 40209.2 40301.2 40327.4 41212.4 34624.8 34766.8 34846.0 34962.1 34969.1 34519.7 34738.3 34864.1 34949.3 35208.3 33934.3 34004.0 34493.5 34703.0 34985.7 29992.3 32109.8 32407.5 32549.3 32713.2 24570.6 24663.1 24808.4 25293.5 25543.0 08:28:43 INFO - PROCESS | 4862 | 08:28:43 INFO - PROCESS | 4862 | [#2] jquery.html Cycles:180 Average:23119.55 Median:2231.48 stddev:61822.31 (2770.5%) stddev-sans-first:61972.08 08:28:43 INFO - PROCESS | 4862 | Values: 343.2 359.4 360.6 361.3 386.8 12508.1 15632.5 16073.9 17839.6 17994.3 15349.2 15362.7 17073.6 17182.2 17208.5 5025.0 5129.2 5262.1 5475.6 5512.3 3392.3 5523.8 5553.7 5567.6 5610.4 5862.2 5920.7 5925.6 5931.4 5935.9 5737.2 5903.1 6043.5 6048.7 6054.7 5339.1 5345.1 5346.0 5348.5 5349.4 11832.9 12079.2 12189.1 12280.3 12392.1 1729.3 1733.6 2045.8 2228.2 2320.1 8788.6 8873.5 9175.9 9377.3 12805.5 1705.8 1750.6 1753.3 1783.9 1791.2 63715.4 66850.0 70585.6 72078.6 73263.0 10008.9 10096.6 10170.3 10194.8 10334.7 12849.1 13656.8 13778.7 13791.6 13829.7 6909.2 6986.2 7224.0 7231.4 7290.5 6720.6 6723.3 6783.0 6929.2 6972.0 3825.5 4060.4 4278.4 4308.6 4350.6 1824.2 1827.7 1830.0 1839.4 1866.7 348.1 355.0 355.3 358.7 707.2 10112.7 10113.5 10403.2 10470.9 10544.3 379.2 380.6 382.8 402.6 424.5 5350.0 5374.7 5464.9 5467.4 5502.6 366282.0 367289.0 367965.0 379944.0 382237.0 74927.0 76402.2 76947.6 78656.6 79666.0 411.5 413.5 420.8 421.7 423.3 9319.7 9590.0 9590.1 9722.6 9820.2 35761.0 35789.8 36040.1 36270.6 37326.6 49572.0 52003.7 52892.2 52892.5 53527.5 7249.5 7435.9 7667.0 7745.2 8081.4 9663.8 11720.4 11893.7 12241.6 12528.9 9759.2 9934.7 10119.3 10233.1 10731.5 9597.3 10169.5 10351.4 10418.2 10726.4 10162.4 10582.7 10704.6 10881.2 11269.3 7276.7 7585.1 7632.6 7746.7 7873.9 9142.5 10023.5 10260.5 10344.5 10541.4 08:28:43 INFO - PROCESS | 4862 | 08:28:43 INFO - PROCESS | 4862 | [#3] mootools.html Cycles:180 Average:4948.30 Median:4862.72 stddev:2757.65 (56.7%) stddev-sans-first:2752.27 08:28:43 INFO - PROCESS | 4862 | Values: 1370.4 1395.5 1498.9 1694.3 1711.0 7387.9 7960.2 7967.6 7970.6 7973.7 6771.3 6975.9 6987.1 7140.8 7824.6 2092.9 2172.2 2173.1 2186.5 2192.1 2189.5 2194.1 2217.0 2217.1 2218.6 2193.1 2203.9 2206.2 2208.6 2209.1 2120.0 2132.4 2140.2 2142.6 2142.6 2037.6 2044.1 2044.4 2085.7 2160.6 7927.6 7955.5 8024.2 8040.8 8043.6 4501.1 4625.4 4636.4 4642.4 4645.9 2755.7 2880.6 2912.0 2922.4 2983.0 895.3 924.2 940.7 951.6 953.0 10664.3 10690.9 10704.4 10714.9 10741.9 3961.7 4217.9 4239.7 4259.9 4267.1 9225.6 9250.2 9252.9 9274.0 9289.3 4698.2 4700.0 4701.7 4704.9 4709.8 4193.4 4238.8 4256.8 4262.4 4263.3 3317.3 3442.2 3446.8 3450.2 3537.7 1185.6 1198.2 1203.4 1207.1 1207.6 758.6 770.8 770.9 781.0 795.9 4624.0 4714.4 4736.0 4841.6 4883.8 804.7 821.4 826.2 843.1 845.4 3162.7 3175.8 3180.1 3196.3 3298.2 8124.0 8662.0 9081.9 9081.9 9106.7 8568.4 8704.4 8877.6 9046.0 9063.4 6807.8 6899.3 6973.4 6982.8 6984.1 4803.9 4831.7 4891.1 4904.8 5050.2 8239.2 8364.8 8424.1 8440.5 8512.3 8385.2 8533.0 8601.0 8682.2 8683.3 6273.9 6276.4 6316.9 6435.0 6482.6 6402.1 7140.2 7186.4 7190.5 7193.2 6003.9 6438.3 6457.7 6457.8 6681.5 6393.4 6395.1 6402.0 6467.5 6491.7 5756.6 5798.1 5816.5 5818.1 5871.9 4244.9 4248.4 4249.5 4310.2 4500.2 4197.6 4222.6 4250.1 4322.5 4464.6 08:28:43 INFO - PROCESS | 4862 | 08:28:43 INFO - PROCESS | 4862 | [#4] prototype.html Cycles:180 Average:4211.50 Median:4795.80 stddev:1216.06 (25.4%) stddev-sans-first:1183.41 08:28:43 INFO - PROCESS | 4862 | Values: 295.2 297.7 299.9 304.6 305.9 4806.7 4844.9 4864.9 4878.3 4899.4 4753.8 4756.4 4757.2 4784.9 4853.0 3620.9 3672.5 3813.2 3837.8 3859.5 3799.2 3805.0 3815.3 3822.5 3828.9 3789.5 3789.9 3793.7 3797.1 3798.3 3588.6 3639.5 3774.1 3784.0 3807.7 3312.0 3356.8 3359.6 3364.9 3400.7 4650.8 4682.0 4723.6 4726.8 4741.7 4174.3 4307.4 4321.9 4325.7 4344.0 5003.1 5040.4 5048.8 5056.3 5059.5 3660.7 3688.4 3694.2 3702.1 3704.0 5273.2 5290.8 5296.9 5297.7 5308.2 3597.0 3727.3 3744.9 3756.0 3767.7 3765.5 3767.4 3797.1 3797.8 3800.5 4232.4 4248.7 4261.7 4280.8 4319.6 4775.6 4957.0 4975.6 4988.9 4992.9 1299.5 1315.8 1317.0 1319.8 1323.5 828.8 856.3 867.8 869.5 875.6 4069.4 4315.4 4375.0 4484.8 4491.7 5118.3 5159.9 5162.5 5185.7 5192.6 4506.5 4509.6 4510.8 4515.8 4525.9 2645.6 2741.7 2745.9 2750.4 2761.8 4922.7 4925.8 4931.5 4939.4 4946.3 5351.6 5359.4 5368.7 5380.2 5380.3 4722.0 4889.7 4897.5 4899.9 4914.9 5170.1 5176.8 5178.6 5184.4 5209.6 4952.8 5103.9 5116.3 5127.9 5130.5 4888.7 4894.9 4903.8 4906.4 4934.6 3781.5 3786.0 3792.6 3796.4 3814.9 5178.4 5192.7 5195.1 5246.7 5274.7 4813.4 5090.9 5105.9 5112.9 5129.2 5053.8 5055.6 5068.8 5084.6 5085.3 4924.6 5001.1 5009.6 5030.0 5085.7 4931.5 5037.6 5108.6 5180.2 5185.3 4956.6 4976.8 4997.9 5008.4 5013.8 08:28:43 INFO - PROCESS | 4862 | 08:28:43 INFO - PROCESS | 4862 | [#5] yui.html Cycles:180 Average:18104.74 Median:24635.93 stddev:26638.12 (108.1%) stddev-sans-first:26680.35 08:28:43 INFO - PROCESS | 4862 | Values: 580.8 624.4 635.2 667.5 727.8 12002.6 13868.2 13917.1 14028.9 14039.4 12784.9 12991.6 12999.0 13023.7 13199.9 603.1 737.1 738.6 767.4 776.2 754.9 760.8 763.9 764.5 765.4 807.2 807.3 808.7 809.3 809.9 623.2 758.5 803.1 803.3 803.6 569.9 572.9 573.1 573.2 573.4 13620.9 13713.5 13743.3 13748.9 13757.9 11894.8 12421.5 12525.2 12650.7 12916.7 10052.9 10124.9 11591.5 11609.4 11966.2 3998.4 4128.1 4195.9 4237.5 4364.8 56413.4 59886.4 59933.1 60015.7 60041.4 9757.0 9930.6 9962.5 9970.4 10027.7 16261.3 16283.4 16331.5 16345.5 16349.8 6610.7 6653.9 6668.6 6707.4 6973.6 3586.2 3669.7 3709.9 3744.8 3878.9 2770.4 2890.2 3287.4 3442.8 3453.8 542.3 544.8 546.2 562.4 574.6 437.0 487.1 504.1 510.7 532.6 7729.5 7927.5 8018.0 8274.6 8395.5 468.4 521.4 537.2 547.1 552.4 3805.0 4000.4 4087.0 4193.7 4431.3 100363.5 105914.0 106754.0 109881.5 112011.0 90447.0 92267.0 92979.5 93888.5 94277.5 77511.6 77889.0 77901.6 78456.0 80099.6 8401.2 8688.2 8735.7 8753.7 8804.8 38554.0 38667.4 39045.8 44840.6 46256.5 58066.4 58132.1 58189.7 58233.7 58351.7 11078.2 11162.8 11222.7 11343.3 11616.8 12547.8 12575.7 12587.9 12667.9 12699.3 11330.7 11366.7 12131.6 12210.3 12499.7 11777.6 11996.6 12124.4 12705.9 12729.2 11453.2 11771.7 11821.8 12394.6 12520.4 10028.6 10234.6 10614.7 10672.4 10755.8 9104.3 9248.4 9761.8 9791.8 10170.5 08:28:43 INFO - PROCESS | 4862 | -------- Summary: end -------- 08:28:43 INFO - PROCESS | 4862 | 08:28:44 INFO - TEST-INFO | 4862: exit 0 08:28:44 INFO - TEST-OK | dromaeo_css | took 1123910ms 08:28:44 INFO - TEST-START | kraken 08:28:44 INFO - operating with platform_type : linux_ 08:28:44 INFO - Initialising browser for kraken test... 08:28:44 INFO - TEST-INFO | started process 5166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6C0LdW/profile http://localhost:39372/getInfo.html) 08:28:50 INFO - PROCESS | 5166 | __metrics Screen width/height:1600/1200 08:28:50 INFO - PROCESS | 5166 | colorDepth:24 08:28:50 INFO - PROCESS | 5166 | Browser inner width/height: 1024/697 08:28:50 INFO - PROCESS | 5166 | __metrics 08:28:51 INFO - PROCESS | 5166 | 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:28:51 INFO - PROCESS | 5166 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:28:52 INFO - PROCESS | 5166 | console.error: PushService: 08:28:52 INFO - PROCESS | 5166 | stateChangeProcessEnqueue: Error transitioning state 08:28:52 INFO - PROCESS | 5166 | UnknownError 08:28:52 INFO - TEST-INFO | 5166: exit 0 08:28:52 INFO - Browser initialized. 08:28:52 INFO - Running cycle 1/1 for kraken test... 08:28:52 INFO - TEST-INFO | started process 5244 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6C0LdW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:04 INFO - PROCESS | 5244 | RSS: Main: 182345728 08:29:04 INFO - PROCESS | 5244 | 08:29:07 INFO - PROCESS | 5244 | Cycle 1(1): loaded http://localhost:39372/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39372/tests/kraken/driver.html?testName=audio-beat-detection) 08:29:08 INFO - PROCESS | 5244 | RSS: Main: 235769856 08:29:08 INFO - PROCESS | 5244 | 08:29:11 INFO - PROCESS | 5244 | Cycle 1(1): loaded http://localhost:39372/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39372/tests/kraken/driver.html?testName=audio-dft) 08:29:11 INFO - PROCESS | 5244 | RSS: Main: 226439168 08:29:11 INFO - PROCESS | 5244 | 08:29:15 INFO - PROCESS | 5244 | Cycle 1(1): loaded http://localhost:39372/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39372/tests/kraken/driver.html?testName=audio-fft) 08:29:15 INFO - PROCESS | 5244 | RSS: Main: 303116288 08:29:15 INFO - PROCESS | 5244 | 08:29:17 INFO - PROCESS | 5244 | Cycle 1(1): loaded http://localhost:39372/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39372/tests/kraken/driver.html?testName=audio-oscillator) 08:29:18 INFO - PROCESS | 5244 | RSS: Main: 214097920 08:29:18 INFO - PROCESS | 5244 | 08:29:20 INFO - PROCESS | 5244 | Cycle 1(1): loaded http://localhost:39372/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39372/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:29:21 INFO - PROCESS | 5244 | RSS: Main: 215048192 08:29:21 INFO - PROCESS | 5244 | 08:29:24 INFO - PROCESS | 5244 | Cycle 1(1): loaded http://localhost:39372/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39372/tests/kraken/driver.html?testName=imaging-darkroom) 08:29:25 INFO - PROCESS | 5244 | RSS: Main: 253554688 08:29:25 INFO - PROCESS | 5244 | 08:29:28 INFO - PROCESS | 5244 | Cycle 1(1): loaded http://localhost:39372/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39372/tests/kraken/driver.html?testName=imaging-desaturate) 08:29:29 INFO - PROCESS | 5244 | RSS: Main: 247156736 08:29:29 INFO - PROCESS | 5244 | 08:29:32 INFO - PROCESS | 5244 | Cycle 1(1): loaded http://localhost:39372/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39372/tests/kraken/driver.html?testName=json-parse-financial) 08:29:32 INFO - PROCESS | 5244 | RSS: Main: 250769408 08:29:32 INFO - PROCESS | 5244 | 08:29:34 INFO - PROCESS | 5244 | Cycle 1(1): loaded http://localhost:39372/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39372/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:29:35 INFO - PROCESS | 5244 | RSS: Main: 214634496 08:29:35 INFO - PROCESS | 5244 | 08:29:36 INFO - PROCESS | 5244 | Cycle 1(1): loaded http://localhost:39372/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39372/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:29:37 INFO - PROCESS | 5244 | RSS: Main: 222158848 08:29:37 INFO - PROCESS | 5244 | 08:29:39 INFO - PROCESS | 5244 | Cycle 1(1): loaded http://localhost:39372/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39372/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:29:40 INFO - PROCESS | 5244 | RSS: Main: 222957568 08:29:40 INFO - PROCESS | 5244 | 08:29:43 INFO - PROCESS | 5244 | Cycle 1(1): loaded http://localhost:39372/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:29:43 INFO - PROCESS | 5244 | RSS: Main: 218030080 08:29:43 INFO - PROCESS | 5244 | 08:29:46 INFO - PROCESS | 5244 | Cycle 1(1): loaded http://localhost:39372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:29:47 INFO - PROCESS | 5244 | RSS: Main: 221855744 08:29:47 INFO - PROCESS | 5244 | 08:29:49 INFO - PROCESS | 5244 | Cycle 1(1): loaded http://localhost:39372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39372/tests/kraken/driver.html?testName=ai-astar) 08:29:49 INFO - PROCESS | 5244 | RSS: Main: 272683008 08:29:49 INFO - PROCESS | 5244 | 08:29:49 INFO - PROCESS | 5244 | __start_tp_report 08:29:49 INFO - PROCESS | 5244 | _x_x_mozilla_page_load 08:29:49 INFO - PROCESS | 5244 | _x_x_mozilla_page_load_details 08:29:49 INFO - PROCESS | 5244 | |i|pagename|runs| 08:29:49 INFO - PROCESS | 5244 | |0;ai-astar;114;114;133;115;114;115;115;114;113;115 08:29:49 INFO - PROCESS | 5244 | |1;audio-beat-detection;152;127;155;185;122;151;149;122;192;121 08:29:49 INFO - PROCESS | 5244 | |2;audio-dft;161;162;162;162;161;160;160;162;159;160 08:29:49 INFO - PROCESS | 5244 | |3;audio-fft;76;76;76;166;78;75;76;77;157;77 08:29:49 INFO - PROCESS | 5244 | |4;audio-oscillator;83;85;146;84;83;83;139;84;84;139 08:29:49 INFO - PROCESS | 5244 | |5;imaging-gaussian-blur;117;117;118;118;117;117;117;117;117;117 08:29:49 INFO - PROCESS | 5244 | |6;imaging-darkroom;147;147;148;148;148;147;146;146;147;146 08:29:49 INFO - PROCESS | 5244 | |7;imaging-desaturate;94;94;99;95;95;95;95;95;95;95 08:29:49 INFO - PROCESS | 5244 | |8;json-parse-financial;63;66;64;64;65;66;65;69;66;65 08:29:49 INFO - PROCESS | 5244 | |9;json-stringify-tinderbox;66;67;66;67;67;66;66;66;68;66 08:29:49 INFO - PROCESS | 5244 | |10;stanford-crypto-aes;83;83;88;82;83;83;81;87;85;82 08:29:49 INFO - PROCESS | 5244 | |11;stanford-crypto-ccm;135;131;131;140;130;132;132;138;176;131 08:29:49 INFO - PROCESS | 5244 | |12;stanford-crypto-pbkdf2;173;172;173;176;174;178;177;177;177;173 08:29:49 INFO - PROCESS | 5244 | |13;stanford-crypto-sha256-iterative;74;79;69;70;72;69;68;70;71;68 08:29:49 INFO - PROCESS | 5244 | __end_tp_report 08:29:49 INFO - PROCESS | 5244 | __start_cc_report 08:29:49 INFO - PROCESS | 5244 | _x_x_mozilla_cycle_collect,1950 08:29:49 INFO - PROCESS | 5244 | __end_cc_report 08:29:49 INFO - PROCESS | 5244 | __startTimestamp1472570989420__endTimestamp 08:29:49 INFO - PROCESS | 5244 | 08:29:49 INFO - PROCESS | 5244 | ------- Summary: start ------- 08:29:49 INFO - PROCESS | 5244 | Number of tests: 14 08:29:49 INFO - PROCESS | 5244 | 08:29:49 INFO - PROCESS | 5244 | [#0] ai-astar Cycles:10 Average:116.20 Median:115.00 stddev:5.94 (5.2%) stddev-sans-first:6.25 08:29:49 INFO - PROCESS | 5244 | Values: 114.0 114.0 133.0 115.0 114.0 115.0 115.0 114.0 113.0 115.0 08:29:49 INFO - PROCESS | 5244 | 08:29:49 INFO - PROCESS | 5244 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:151.50 stddev:25.60 (16.9%) stddev-sans-first:27.11 08:29:49 INFO - PROCESS | 5244 | Values: 152.0 127.0 155.0 185.0 122.0 151.0 149.0 122.0 192.0 121.0 08:29:49 INFO - PROCESS | 5244 | 08:29:49 INFO - PROCESS | 5244 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.17 08:29:49 INFO - PROCESS | 5244 | Values: 161.0 162.0 162.0 162.0 161.0 160.0 160.0 162.0 159.0 160.0 08:29:49 INFO - PROCESS | 5244 | 08:29:49 INFO - PROCESS | 5244 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:35.96 (47.3%) stddev-sans-first:37.59 08:29:49 INFO - PROCESS | 5244 | Values: 76.0 76.0 76.0 166.0 78.0 75.0 76.0 77.0 157.0 77.0 08:29:49 INFO - PROCESS | 5244 | 08:29:49 INFO - PROCESS | 5244 | [#4] audio-oscillator Cycles:10 Average:101.00 Median:83.50 stddev:27.90 (33.4%) stddev-sans-first:28.83 08:29:49 INFO - PROCESS | 5244 | Values: 83.0 85.0 146.0 84.0 83.0 83.0 139.0 84.0 84.0 139.0 08:29:49 INFO - PROCESS | 5244 | 08:29:49 INFO - PROCESS | 5244 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:29:49 INFO - PROCESS | 5244 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 08:29:49 INFO - PROCESS | 5244 | 08:29:49 INFO - PROCESS | 5244 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 08:29:49 INFO - PROCESS | 5244 | Values: 147.0 147.0 148.0 148.0 148.0 147.0 146.0 146.0 147.0 146.0 08:29:49 INFO - PROCESS | 5244 | 08:29:49 INFO - PROCESS | 5244 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.40 (1.5%) stddev-sans-first:1.41 08:29:49 INFO - PROCESS | 5244 | Values: 94.0 94.0 99.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 08:29:49 INFO - PROCESS | 5244 | 08:29:49 INFO - PROCESS | 5244 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.50 stddev:1.64 (2.5%) stddev-sans-first:1.51 08:29:49 INFO - PROCESS | 5244 | Values: 63.0 66.0 64.0 64.0 65.0 66.0 65.0 69.0 66.0 65.0 08:29:49 INFO - PROCESS | 5244 | 08:29:49 INFO - PROCESS | 5244 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 08:29:49 INFO - PROCESS | 5244 | Values: 66.0 67.0 66.0 67.0 67.0 66.0 66.0 66.0 68.0 66.0 08:29:49 INFO - PROCESS | 5244 | 08:29:49 INFO - PROCESS | 5244 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:2.26 (2.7%) stddev-sans-first:2.39 08:29:49 INFO - PROCESS | 5244 | Values: 83.0 83.0 88.0 82.0 83.0 83.0 81.0 87.0 85.0 82.0 08:29:49 INFO - PROCESS | 5244 | 08:29:49 INFO - PROCESS | 5244 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:133.50 stddev:13.90 (10.4%) stddev-sans-first:14.71 08:29:49 INFO - PROCESS | 5244 | Values: 135.0 131.0 131.0 140.0 130.0 132.0 132.0 138.0 176.0 131.0 08:29:49 INFO - PROCESS | 5244 | 08:29:49 INFO - PROCESS | 5244 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:176.50 stddev:2.21 (1.3%) stddev-sans-first:2.22 08:29:49 INFO - PROCESS | 5244 | Values: 173.0 172.0 173.0 176.0 174.0 178.0 177.0 177.0 177.0 173.0 08:29:49 INFO - PROCESS | 5244 | 08:29:49 INFO - PROCESS | 5244 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:70.50 stddev:3.37 (4.8%) stddev-sans-first:3.39 08:29:49 INFO - PROCESS | 5244 | Values: 74.0 79.0 69.0 70.0 72.0 69.0 68.0 70.0 71.0 68.0 08:29:49 INFO - PROCESS | 5244 | -------- Summary: end -------- 08:29:49 INFO - PROCESS | 5244 | 08:29:50 INFO - TEST-INFO | 5244: exit 0 08:29:50 INFO - TEST-OK | kraken | took 66241ms 08:29:50 INFO - SUITE-END | took 1190s 08:29:51 INFO - Completed test suite (00:19:50) 08:29:51 INFO - javascript benchmark 08:29:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2592.48150369926, 2603.695729279587, 2603.7135915049353, 2648.311439025854, 2659.853708046058, 4667.229907065339, 4708.36437080994, 4726.33831263623, 4818.927716084261, 4880.097182021324, 4681.485036645975, 4722.669413141081, 4735.526447355272, 4759.3812804335475, 4786.56920877121, 4251.4685664291965, 4291.141771645668, 4312.913741725163, 4384.473863136428, 4544.0, 4458.063806600618, 4470.2400591899295, 4518.728876267418, 4543.772811359436, 4546.772661366935, 4276.935845962282, 4317.7193482423545, 4407.0, 4412.470503539564, 4485.865424037284, 4355.477342718862, 4373.628241599468, 4380.978095109536, 4384.188925048876, 4387.319965405367, 4300.462442194726, 4331.025519258142, 4336.891577710551, 4336.891577710551, 4341.131773645252, 4702.4592171899985, 4705.905881882378, 4714.787834547419, 4745.335653008581, 4833.73414462208, 5120.564751996048, 5121.641485096045, 5122.667026643257, 5134.101532231882, 5190.818321358772, 4986.376702912136, 5065.11360511909, 5154.123798954187, 5157.58739300855, 5160.535551800356, 4751.216049351819, 4780.043991201774, 4781.354517140142, 4785.282207668877, 4841.8547443576745, 5188.429272779991, 5213.348331458567, 5223.347081614798, 5228.163493841043, 5306.230596563477, 4857.198562237191, 4961.305417241589, 4993.5256150666355, 5009.0482808266315, 5059.898802024012, 5101.158308879068, 5124.333836601218, 5125.026245013435, 5141.9742901286, 5188.870278243074, 5070.315507406527, 5077.796888124433, 5078.339815823993, 5080.364954380702, 5139.177731562932, 4900.093482705711, 4944.233643785219, 4996.925046124311, 5056.696598204119, 5057.620678449131, 4296.2911119664905, 4297.312430011246, 4303.978480107579, 4361.629261512807, 4362.672799539983, 3740.4202348636004, 3742.2702572998546, 3743.7005039596766, 3779.7921114338974, 3784.7918364489665, 4305.182015417061, 4386.0, 4423.137488189772, 4425.690201685851, 4467.01725620363, 5101.107306221396, 5125.333706618116, 5135.948640513622, 5199.090159222196, 5202.843914682566, 4416.138852923713, 4418.138462999685, 4418.337249412614, 4422.226110430726, 4477.417935668343, 4464.4865840428765, 4548.044910568818, 4601.148787474328, 4603.010352774169, 4646.442426908792, 4754.120487709784, 4860.343853579721, 4864.562189402971, 4870.512948705101, 4870.805167793249, 5075.898482030265, 5083.898322033612, 5089.821856235014, 5095.541401273903, 5157.123289040797, 4816.975915120402, 4849.830255941025, 4855.053264613366, 4862.294967229803, 4883.145449546386, 4952.4057113146655, 4960.280759289955, 4977.178765503651, 5004.749762511933, 5064.215046667772, 5071.77177027042, 5085.593152547861, 5089.745512724423, 5093.821716239914, 5124.590032797441, 4932.186189278872, 4939.086269040239, 4951.133551628523, 4952.727599982036, 4961.553906331226, 4857.708537487762, 4912.45962944083, 4931.2849636803185, 4963.5780958618925, 5009.924851127309, 4881.90236195267, 4887.951120488749, 4891.437484689306, 4896.730679812502, 4943.159662857251, 4777.856664300077, 4847.878803029953, 4976.825811096594, 4977.651564390458, 4985.875353116056, 4715.457722361973, 4881.096997055556, 4916.459189489082, 4948.158813001726, 4994.925076123934], "value": 4675.898248473456, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.7060058169167, 559.4573263933983, 561.200289587338, 577.1256546332307, 579.1573260905383, 26741.33146671334, 36626.63373366269, 37771.81114094432, 37846.0, 41427.58572414275, 37992.62007379932, 38104.0, 38285.0, 38494.230115397746, 38504.61495385052, 7592.354649854755, 7745.767626971172, 7749.263819937097, 7755.689772409125, 7757.844843103135, 7564.0, 7653.0, 7653.234676532358, 7655.311022008018, 7658.042744656918, 7651.1583725790115, 7720.845583088335, 7721.227877212262, 7732.652030658605, 7769.106552746422, 7664.923350766477, 7688.500247483896, 7707.730229441999, 7710.267524585155, 7710.807229819271, 7693.115291741409, 7744.2642948919765, 7760.767176984643, 7763.922360776376, 7790.415718821055, 34615.82692086549, 34746.478802817976, 34886.0, 34929.650703492895, 34950.47574286388, 2913.606663100497, 2976.389840082778, 3215.4855223164413, 3252.495863141217, 3578.8031658258788, 27175.45649087027, 27532.311692207655, 27740.583891241648, 27856.0, 27921.162365128876, 3426.417509023472, 3520.6479352064844, 3538.3630946429635, 3593.1017245688577, 3607.5310209672575, 236855.0, 236859.0, 237312.0, 237705.0, 237846.8107659468, 48476.7576162117, 49058.75470622624, 49149.50850491521, 49161.75419122953, 49192.50807491951, 51406.74296628493, 51417.485825142016, 51469.227961580604, 51512.742436287575, 51583.48416515862, 13049.673758156123, 13371.665708357368, 13384.0, 13385.598432047054, 13397.598072057854, 10239.232057595711, 10256.12822910061, 10272.743181420525, 10298.021687939783, 10300.072993430627, 13925.721485570435, 14523.854761452461, 14540.709185816224, 14586.562403127924, 14733.968622196558, 5887.2052272943465, 5924.400411888852, 6102.9694851525455, 6189.84525386869, 6309.148264984168, 641.3394203969918, 689.3375525545646, 813.3046245460165, 833.5998720614018, 909.7088931541844, 26473.602895956577, 26981.325466863487, 27408.314792129957, 27673.861630691717, 27922.0, 673.4174938678107, 877.8332116897769, 906.4878343735768, 976.9120779129912, 989.0999190736395, 13231.206127632373, 13741.656458588615, 13982.650433739034, 14046.1572305662, 14098.436062557588, 363320.0, 366269.0, 366802.0, 367883.0, 370332.0, 46456.7677161612, 46537.53462465332, 46542.767286163355, 46636.0, 46655.0, 1035.5133087448887, 1124.0614087237086, 1125.2573301621055, 1145.507431804332, 1149.5631659969326, 26206.737932621192, 27576.724232757417, 27744.722552774212, 27925.581116282865, 28978.855105724335, 38669.806650966566, 39030.80484597672, 39052.80473597614, 39173.2165356697, 39189.80405097956, 224135.0, 224865.0, 224931.0, 225525.0, 323055.46389897563, 23189.188378406674, 24485.26544203677, 24492.14277500279, 24860.0, 24870.0, 39883.80058099691, 40209.1958160841, 40301.1939761209, 40327.39508907427, 41212.38181427341, 34624.82687586546, 34766.82616586901, 34846.0, 34962.125946851535, 34969.125771855906, 34519.65480345265, 34738.30523389467, 34864.128396790285, 34949.30101397907, 35208.29583408266, 33934.32131357408, 34004.0, 34493.48259776055, 34703.0, 34985.65014349824, 29992.25019374533, 32109.839450802596, 32407.51388729124, 32549.34901302008, 32713.18217044593, 24570.63144052805, 24663.136790212255, 24808.379790505383, 25293.494130116927, 25543.0], "value": 16527.215491842548, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.1575482191221, 359.4195374470231, 360.61594401961906, 361.29006502223143, 386.8009171568139, 12508.124431289802, 15632.452864149756, 16073.919630401846, 17839.64320713585, 17994.280228790867, 15349.232538373093, 15362.69274614507, 17073.57316067099, 17182.226799794007, 17208.483745487654, 5024.974875125628, 5129.2306154077, 5262.131748261532, 5475.6440831346035, 5512.310961129859, 3392.3215356928713, 5523.751431185607, 5553.666779993213, 5567.610267281292, 5610.438956104377, 5862.179294898718, 5920.703964801764, 5925.644461332334, 5931.436513531207, 5935.9406405935815, 5737.19679244904, 5903.114532820068, 6043.546733994968, 6048.667323297217, 6054.69726513677, 5339.119045357511, 5345.064613692588, 5346.0, 5348.491893270133, 5349.43830897754, 11832.881671183264, 12079.154459187861, 12189.146759726822, 12280.263184208976, 12392.132550721453, 1729.2909906938096, 1733.5926057376507, 2045.836333093349, 2228.19784877444, 2320.083566991046, 8788.64845406183, 8873.51195684237, 9175.908240917639, 9377.296702747253, 12805.48778048877, 1705.7953045634479, 1750.649870026, 1753.2548666816551, 1783.9018853963028, 1791.1760590128556, 63715.362846371405, 66849.99999999952, 70585.64707176482, 72078.63960680216, 73263.0, 10008.899911000943, 10096.646617368357, 10170.288079834341, 10194.796104077877, 10334.741631459274, 12849.10056296069, 13656.795148072786, 13778.724425511433, 13791.586252412444, 13829.723405531833, 6909.170899492093, 6986.196587392515, 7224.0, 7231.4214862811905, 7290.45321600882, 6720.630365329856, 6723.294054124344, 6782.966085169642, 6929.203141638675, 6972.0, 3825.5218097737784, 4060.411240370189, 4278.358246263023, 4308.590683885026, 4350.608445239944, 1824.2122719734734, 1827.6527459782599, 1829.9725504117448, 1839.4324605143536, 1866.6640004798994, 348.1487762420907, 354.9503069570262, 355.3036049343316, 358.65927368999036, 707.2397173039004, 10112.747181320527, 10113.544890479947, 10403.219758518142, 10470.947645261725, 10544.261901666963, 379.179077297653, 380.581360503444, 382.844947796143, 402.5531659857556, 424.51817187491804, 5349.973250133725, 5374.704391258519, 5464.890702186013, 5467.371252305956, 5502.614816962854, 366282.0, 367289.0, 367965.0, 379944.0, 382237.0, 74927.0, 76402.23597763952, 76947.61526192445, 78656.60671696605, 79666.0, 411.467150040698, 413.5182512373112, 420.77067997941197, 421.69848558280364, 423.2719722078021, 9319.673811416838, 9590.0, 9590.136887680143, 9722.611095556382, 9820.165285950774, 35761.0, 35789.82105089458, 36040.098997525274, 36270.63729362673, 37326.6267337334, 49572.0, 52003.73998129985, 52892.20661690001, 52892.53729857179, 53527.46472535225, 7249.492535522674, 7435.888461672971, 7666.961665191861, 7745.186755390828, 8081.393895457747, 9663.806723865624, 11720.355380454157, 11893.702657433634, 12241.632751017483, 12528.874711253135, 9759.219262458844, 9934.652287169914, 10119.291649584458, 10233.079022887976, 10731.463426828472, 9597.280203984868, 10169.542370593488, 10351.43067131315, 10418.218633602359, 10726.356418614909, 10162.39025658463, 10582.682519524427, 10704.625338113128, 10881.238313318308, 11269.267497612629, 7276.672549735381, 7585.127710313384, 7632.580208088609, 7746.651400687096, 7873.881891771743, 9142.451452912846, 10023.548940297558, 10260.538275777459, 10344.482775861328, 10541.420221887563], "value": 7291.061340022129, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.3696299702133, 1395.5185461015951, 1498.8950773445856, 1694.339207708993, 1711.0247159119308, 7387.852242955138, 7960.164182760814, 7967.60161991901, 7970.601469926502, 7973.681052757897, 6771.3228677132265, 6975.895361569568, 6987.0567473391075, 7140.75007374742, 7824.608769561513, 2092.9267475638317, 2172.196287373666, 2173.076442511926, 2186.4971056656977, 2192.1012384922187, 2189.4854709143337, 2194.122351059573, 2216.9556608867815, 2217.1131547381096, 2218.6006518826603, 2193.144673577306, 2203.8787866667326, 2206.172685243034, 2208.624533829253, 2209.0501084533644, 2119.9788002119935, 2132.3922682035623, 2140.2402147237663, 2142.6036183306137, 2142.646463333548, 2037.5517386175018, 2044.0699481735774, 2044.356027851222, 2085.7497100348055, 2160.5678864227216, 7927.603619818986, 7955.4828936118965, 8024.15746346631, 8040.839183216303, 8043.55760433176, 4501.144782491317, 4625.398698169217, 4636.420447444069, 4642.3500709900645, 4645.88385290367, 2755.669319681631, 2880.5967164596973, 2911.956320655192, 2922.444735500248, 2983.0454254638526, 895.2748273898098, 924.2375040591471, 940.7177846646048, 951.5575257505293, 952.9618815247381, 10664.253502254845, 10690.893091069067, 10704.357738535713, 10714.892851071467, 10741.946290268577, 3961.74248673841, 4217.873463796091, 4239.745615263094, 4259.850905218303, 4267.103908179255, 9225.584848681825, 9250.167484926389, 9252.8612070819, 9274.0, 9289.256859451363, 4698.201305778026, 4700.0, 4701.7414042228, 4704.858854234379, 4709.788059537261, 4193.433886425354, 4238.830446782094, 4256.787160641956, 4262.42457268271, 4263.275243208662, 3317.336532693471, 3442.1738782691973, 3446.758726889094, 3450.2236996675547, 3537.7169826413824, 1185.6146752305535, 1198.1912209258714, 1203.4163430736087, 1207.0946789907568, 1207.5592408770735, 758.624480881967, 770.8072981754561, 770.938324934004, 780.9570473624005, 795.8766391209256, 4624.0, 4714.4106986626675, 4735.976320118378, 4841.636877234221, 4883.804647814119, 804.74650485097, 821.3716506872247, 826.1573195340719, 843.1189407069504, 845.4124383553494, 3162.683731626819, 3175.777695561335, 3180.061881744891, 3196.2968147007623, 3298.175456135966, 8124.0, 8662.0, 9081.863772043425, 9081.909180908238, 9106.681266155652, 8568.35737319691, 8704.433202023696, 8877.644894204288, 9046.0, 9063.41087829289, 6807.829804254834, 6899.344562266677, 6973.372396484341, 6982.79051628452, 6984.092068031124, 4803.903921921612, 4831.734254615889, 4891.144049791344, 4904.779284932115, 5050.191969284897, 8239.217274358927, 8364.832703346021, 8424.115467875785, 8440.467859642205, 8512.276456501018, 8385.245327920517, 8532.957335213285, 8600.956995214983, 8682.175193356621, 8683.348748843988, 6273.905891411541, 6276.403741644719, 6316.873662526816, 6435.03474478832, 6482.57863238888, 6402.071699603438, 7140.178879428724, 7186.38915692172, 7190.496665233383, 7193.208747037717, 6003.90994135097, 6438.259600146043, 6457.671481947811, 6457.773977910751, 6681.532292739462, 6393.424591786761, 6395.136656551306, 6402.0, 6467.482601391784, 6491.675416229265, 5756.597038207286, 5798.10129429939, 5816.47651711348, 5818.069108942549, 5871.911921321269, 4244.91510169801, 4248.426462427533, 4249.46881639795, 4310.1810655976515, 4500.189965806056, 4197.622214000755, 4222.619964203236, 4250.06498570314, 4322.524522302481, 4464.55354464551], "value": 4007.3930730502634, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.1897042618013, 297.6606668398025, 299.9025316772049, 304.64356702657886, 305.93728285701434, 4806.71159730416, 4844.927326090112, 4864.854054378366, 4878.268259761037, 4899.363082799236, 4753.833615823447, 4756.429228492577, 4757.215059515184, 4784.880377990552, 4852.975735121328, 3620.8913732588067, 3672.5225720656276, 3813.218290250506, 3837.769733815973, 3859.4982652255167, 3799.202167544805, 3804.9809750951345, 3815.2560250751117, 3822.5412950445984, 3828.8659896903614, 3789.5263092113487, 3789.919872836242, 3793.696504279651, 3797.1076796952834, 3798.2783271178528, 3588.6052534221476, 3639.490471334015, 3774.1319496515816, 3783.9810800945957, 3807.695384369244, 3312.0, 3356.7650264481254, 3359.639346064848, 3364.9327013459592, 3400.7109395701395, 4650.813967441332, 4682.0, 4723.645726570487, 4726.834560790356, 4741.668083234175, 4174.3112386456505, 4307.396964424952, 4321.913561728779, 4325.675574331906, 4344.0, 5003.099442100421, 5040.445550989388, 5048.7980480780725, 5056.292119103328, 5059.544640982329, 3660.652238037382, 3688.391415416453, 3694.2426802505693, 3702.0564203792956, 3704.0369503928905, 5273.209018647195, 5290.788368465295, 5296.92054619181, 5297.6821390716295, 5308.230306605559, 3596.964030359663, 3727.347714150067, 3744.85020599173, 3755.962440375616, 3767.6813115409386, 3765.491658626105, 3767.4348847672522, 3797.088698712289, 3797.7531460454984, 3800.524934383202, 4232.375926925264, 4248.702590818675, 4261.701680882308, 4280.828766849291, 4319.589638984291, 4775.641826863, 4956.975215123901, 4975.577075948512, 4988.925166122511, 4992.851644121873, 1299.5061876487064, 1315.81578578999, 1317.0, 1319.8020296955533, 1323.5169163255343, 828.772087675894, 856.3277826905849, 867.8134201146784, 869.4609342207872, 875.6059773102002, 4069.369247766601, 4315.3742707307265, 4374.950011997098, 4484.843030493982, 4491.652504248712, 5118.334616499831, 5159.922601160985, 5162.45794191612, 5185.740712964337, 5192.637350005738, 4506.459224892968, 4509.624564507857, 4510.797014134372, 4515.7967891444305, 4525.932111018272, 2645.6242753767933, 2741.739534744196, 2745.876435560365, 2750.4499100180046, 2761.8066735328334, 4922.655414121049, 4925.827596034122, 4931.495893752368, 4939.407271127416, 4946.332245146931, 5351.60858176869, 5359.356877174764, 5368.651037682538, 5380.166074258496, 5380.251418289072, 4722.031983443386, 4889.706617602955, 4897.461279259279, 4899.853004409802, 4914.901701966012, 5170.121079416433, 5176.792928282826, 5178.611604129781, 5184.377874655065, 5209.635325527328, 4952.7771250294545, 5103.923441148311, 5116.28372027909, 5127.897442051213, 5130.48695130484, 4888.682235654671, 4894.853154405374, 4903.803847846046, 4906.386701662293, 4934.605231581537, 3781.4516895049514, 3785.9745036406493, 3792.5828158901945, 3796.3546197145997, 3814.8664796731982, 5178.404483484447, 5192.688438693691, 5195.11683013881, 5246.737663116753, 5274.736263186902, 4813.350197723263, 5090.923636145535, 5105.923411148761, 5112.948870511247, 5129.2306154075695, 5053.787091098184, 5055.570276526537, 5068.771905264198, 5084.567811736044, 5085.262636917701, 4924.606031517542, 5001.099802035668, 5009.597312752435, 5030.0, 5085.669431486942, 4931.457539670561, 5037.647364684437, 5108.61685373591, 5180.171172612364, 5185.314772698813, 4956.578690811321, 4976.825811096594, 4997.925031124609, 5008.373953255843, 5013.771625951519], "value": 3825.14958902258, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.8199458167967, 624.3537938233927, 635.1933045032812, 667.4827009067972, 727.8398752274504, 12002.579909703161, 13868.237246951414, 13917.09538879972, 14028.859711402909, 14039.36822842972, 12784.93607531961, 12991.610251692464, 12999.0, 13023.674408139801, 13199.868001319985, 603.0652488642609, 737.0676094740159, 738.5605564689015, 767.3745897093878, 776.1733753552448, 754.8905408715733, 760.7869796456973, 763.8510490454336, 764.487793178569, 765.3647472597759, 807.2049031703797, 807.2694211738386, 808.6967387229789, 809.2878267124922, 809.8542262392767, 623.1711823275078, 758.4804408979867, 803.1085495100434, 803.2650125135494, 803.6022169026311, 569.866081470854, 572.894014607299, 573.0744847071949, 573.23473163327, 573.435166361134, 13620.931895340558, 13713.45146194151, 13743.312834358341, 13748.862511374859, 13757.931210343984, 11894.82157767634, 12421.503139874394, 12525.248485090833, 12650.746985060247, 12916.677083072904, 10052.899471005343, 10124.949375253076, 11591.47838347268, 11609.361485118316, 11966.162368634199, 3998.3602623580086, 4128.1330920506725, 4195.937060944088, 4237.4915010198665, 4364.803583838703, 56413.43586564164, 59886.40113598852, 59933.10100348498, 60015.69992150055, 60041.39958600445, 9756.975337645352, 9930.602775889029, 9962.501874906226, 9970.40177589347, 10027.749306267402, 16261.349546018264, 16283.430079947146, 16331.510054698378, 16345.509634710977, 16349.754753678704, 6610.669466526654, 6653.900191497131, 6668.599884006878, 6707.429868461236, 6973.58158510491, 3586.2468881534646, 3669.6513831185994, 3709.9258014840093, 3744.7753134811996, 3878.9224215515533, 2770.4459108178444, 2890.1762997545597, 3287.4411350070545, 3442.7934323940144, 3453.7755045921936, 542.3193891665934, 544.7684733988118, 546.1752753342481, 562.4375624375624, 574.6494638270651, 436.9890752731207, 487.07698910564284, 504.07753810526646, 510.7333812145825, 532.5872448852093, 7729.521333340007, 7927.484713493604, 8018.037835459782, 8274.586270686563, 8395.454295470774, 468.37238100944217, 521.4082016910834, 537.1915267522431, 547.1000204663306, 552.3868505958383, 3804.9809750951067, 4000.439938408625, 4086.959130408658, 4193.6645068394455, 4431.313146462304, 100363.49818250861, 105914.0, 106754.0, 109881.45059274652, 112011.0, 90447.0, 92267.0, 92979.53510232405, 93888.53055734678, 94277.5286123565, 77511.61244193742, 77889.0, 77901.61049194718, 78456.0, 80099.59950200212, 8401.23574049432, 8688.174623410765, 8735.69425070145, 8753.737387878375, 8804.779880502783, 38554.0, 38667.41998869963, 39045.80477097596, 44840.55159448364, 46256.53743462657, 58066.4193358061, 58132.128018080606, 58189.709051456164, 58233.70883145557, 58351.708241458524, 11078.169137314895, 11162.776744464903, 11222.719432014264, 11343.262687925258, 11616.825747613962, 12547.811782823448, 12575.748485030064, 12587.93706031464, 12667.87332126667, 12699.301538415475, 11330.660080197607, 11366.659000230007, 12131.575394861138, 12210.328431935974, 12499.687507812378, 11777.574479933353, 11996.64010079699, 12124.393780311126, 12705.936470317589, 12729.236245825281, 11453.19827612059, 11771.705707357041, 11821.822672659744, 12394.58854562172, 12520.373981301082, 10028.64899728506, 10234.590616375262, 10614.73463163427, 10672.413017284123, 10755.838662419914, 9104.317176211678, 9248.398854074463, 9761.755956101155, 9791.761407646874, 10170.491475426346], "value": 6564.521689491006, "unit": "score"}], "name": "dromaeo_css", "value": 6198.25186916056, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 133.0, 115.0, 114.0, 115.0, 115.0, 114.0, 113.0, 115.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 155.0, 185.0, 122.0, 151.0, 149.0, 122.0, 192.0, 121.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 161.0, 160.0, 160.0, 162.0, 159.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 166.0, 78.0, 75.0, 76.0, 77.0, 157.0, 77.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 146.0, 84.0, 83.0, 83.0, 139.0, 84.0, 84.0, 139.0], "value": 101.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 148.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 99.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 64.0, 64.0, 65.0, 66.0, 65.0, 69.0, 66.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 66.0, 68.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 88.0, 82.0, 83.0, 83.0, 81.0, 87.0, 85.0, 82.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 131.0, 140.0, 130.0, 132.0, 132.0, 138.0, 176.0, 131.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 173.0, 176.0, 174.0, 178.0, 177.0, 177.0, 177.0, 173.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 79.0, 69.0, 70.0, 72.0, 69.0, 68.0, 70.0, 71.0, 68.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1577.6000000000001, "alertThreshold": 2.0}]} 08:29:51 INFO - Return code: 0 08:29:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:29:51 INFO - # TBPL SUCCESS # 08:29:51 INFO - Running post-action listener: _resource_record_post_action 08:29:51 INFO - [mozharness: 2016-08-30 15:29:51.218673Z] Finished run-tests step (success) 08:29:51 INFO - Running post-run listener: _resource_record_post_run 08:29:51 INFO - Total resource usage - Wall time: 1207s; CPU: 13.0%; Read bytes: 12288; Write bytes: 417923072; Read time: 684; Write time: 1261264 08:29:51 INFO - TinderboxPrint: CPU usage
13.1% 08:29:51 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 684 08:29:51 INFO - TinderboxPrint: I/O write bytes / time
417,923,072 / 1,261,264 08:29:51 INFO - TinderboxPrint: CPU idle
8,365.9 (86.9%) 08:29:51 INFO - TinderboxPrint: CPU user
1,200.3 (12.5%) 08:29:51 INFO - TinderboxPrint: Swap in / out
0 / 0 08:29:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 126627840; Read time: 0; Write time: 320360 08:29:51 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290615296; Read time: 656; Write time: 940792 08:29:51 INFO - Running post-run listener: _upload_blobber_files 08:29:51 INFO - Blob upload gear active. 08:29:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:29:51 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:29:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:29:52 INFO - (blobuploader) - INFO - Open directory for files ... 08:29:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:29:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:29:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:55 INFO - (blobuploader) - INFO - Done attempting. 08:29:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:29:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:29:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:56 INFO - (blobuploader) - INFO - Done attempting. 08:29:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:29:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:29:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:57 INFO - (blobuploader) - INFO - Done attempting. 08:29:57 INFO - (blobuploader) - INFO - Iteration through files over. 08:29:57 INFO - Return code: 0 08:29:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:29:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:29:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/560156eba0990f6eb5883ea3e8b4aef3494dfdf7e9a5bec67a794a63ae2655026ffca74418028b0aecd705b7bb3e9a3919832ac53fa711a603370081c1c055e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/661ac7e3e37ba4ec52699a5347812e4f00278e489c3c842d906ef07cdbbe0719ec3080e91b6b78c64f8fdb293955f73deae51dedb12b6e2d3b8fd005daa5ca44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f720e1d2d0eabe106c5614e4f40a2fb045020e50131549620dc4cae298ae33b11f9011f6f0607b06f8a409b88e4aeb924c331f8777a226c6497ffb59c72d9b74"} 08:29:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:29:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:29:57 INFO - Contents: 08:29:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/560156eba0990f6eb5883ea3e8b4aef3494dfdf7e9a5bec67a794a63ae2655026ffca74418028b0aecd705b7bb3e9a3919832ac53fa711a603370081c1c055e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/661ac7e3e37ba4ec52699a5347812e4f00278e489c3c842d906ef07cdbbe0719ec3080e91b6b78c64f8fdb293955f73deae51dedb12b6e2d3b8fd005daa5ca44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f720e1d2d0eabe106c5614e4f40a2fb045020e50131549620dc4cae298ae33b11f9011f6f0607b06f8a409b88e4aeb924c331f8777a226c6497ffb59c72d9b74"} 08:29:57 INFO - Running post-run listener: copy_logs_to_upload_dir 08:29:57 INFO - Copying logs to upload dir... 08:29:57 INFO - mkdir: /builds/slave/test/build/upload/logs 08:29:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.505064 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-30 08:29:57.157595) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 08:29:57.161755) ========= 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=df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/560156eba0990f6eb5883ea3e8b4aef3494dfdf7e9a5bec67a794a63ae2655026ffca74418028b0aecd705b7bb3e9a3919832ac53fa711a603370081c1c055e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/661ac7e3e37ba4ec52699a5347812e4f00278e489c3c842d906ef07cdbbe0719ec3080e91b6b78c64f8fdb293955f73deae51dedb12b6e2d3b8fd005daa5ca44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f720e1d2d0eabe106c5614e4f40a2fb045020e50131549620dc4cae298ae33b11f9011f6f0607b06f8a409b88e4aeb924c331f8777a226c6497ffb59c72d9b74"} build_url:https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/FG3-oAu8RMSxIng8n5AJKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/560156eba0990f6eb5883ea3e8b4aef3494dfdf7e9a5bec67a794a63ae2655026ffca74418028b0aecd705b7bb3e9a3919832ac53fa711a603370081c1c055e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/661ac7e3e37ba4ec52699a5347812e4f00278e489c3c842d906ef07cdbbe0719ec3080e91b6b78c64f8fdb293955f73deae51dedb12b6e2d3b8fd005daa5ca44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f720e1d2d0eabe106c5614e4f40a2fb045020e50131549620dc4cae298ae33b11f9011f6f0607b06f8a409b88e4aeb924c331f8777a226c6497ffb59c72d9b74"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 08:29:57.194565) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:29:57.195137) ========= 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=df17445c3590ff7897617a0e00000225-1472569638.910396-1360633715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:29:57.278921) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 08:29:57.279503) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 08:29:57.280029) ========= ========= Total master_lag: 0.26 =========