builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1472130041.02 results: success (0) buildid: 20160825030226 builduid: 14c8039c1032484f999789cb8d50c55c revision: 01748a2b1a463f24efd9cd8abad9ccfd76b037b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 06:00:41.017658) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 06:00:41.018127) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 06:00:41.018406) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 06:00:41.049637) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 06:00:41.050035) ========= 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-1472129719.611276-2088958186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 06:00:41-- 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% 61.3K=0.2s 2016-08-25 06:00:41 (61.3 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.308888 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 06:00:41.373841) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 06:00:41.374203) ========= 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-1472129719.611276-2088958186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018852 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 06:00:41.425495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 06:00:41.426095) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 01748a2b1a463f24efd9cd8abad9ccfd76b037b8 --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 01748a2b1a463f24efd9cd8abad9ccfd76b037b8 --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-1472129719.611276-2088958186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 06:00:41,864 truncating revision to first 12 chars 2016-08-25 06:00:41,865 Setting DEBUG logging. 2016-08-25 06:00:41,865 attempt 1/10 2016-08-25 06:00:41,865 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/01748a2b1a46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 06:00:42,129 unpacking tar archive at: mozilla-central-01748a2b1a46/testing/mozharness/ program finished with exit code 0 elapsedTime=0.577448 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 06:00:42.017324) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 06:00:42.017680) ========= script_repo_revision: 01748a2b1a463f24efd9cd8abad9ccfd76b037b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 06:00:42.018073) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 06:00:42.018339) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 06:00:42.027244) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-25 06:00:42.027744) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1472129719.611276-2088958186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:00:42 INFO - MultiFileLogger online at 20160825 06:00:42 in /builds/slave/test 06:00:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:00:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:00:42 INFO - {'append_to_log': False, 06:00:42 INFO - 'base_work_dir': '/builds/slave/test', 06:00:42 INFO - 'blob_upload_branch': 'Firefox', 06:00:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:00:42 INFO - 'branch': 'Firefox', 06:00:42 INFO - 'buildbot_json_path': 'buildprops.json', 06:00:42 INFO - 'config_files': ('talos/linux_config.py',), 06:00:42 INFO - 'default_actions': ('clobber', 06:00:42 INFO - 'read-buildbot-config', 06:00:42 INFO - 'download-and-extract', 06:00:42 INFO - 'populate-webroot', 06:00:42 INFO - 'create-virtualenv', 06:00:42 INFO - 'install', 06:00:42 INFO - 'run-tests'), 06:00:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:00:42 INFO - 'download_minidump_stackwalk': True, 06:00:42 INFO - 'download_symbols': 'ondemand', 06:00:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:00:42 INFO - 'tooltool.py': '/tools/tooltool.py', 06:00:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:00:42 INFO - '/tools/misc-python/virtualenv.py')}, 06:00:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:00:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:00:42 INFO - 'installer_path': 'installer.exe', 06:00:42 INFO - 'log_level': 'info', 06:00:42 INFO - 'log_name': 'talos', 06:00:42 INFO - 'log_to_console': True, 06:00:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:00:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:00:42 INFO - 'opt_config_files': (), 06:00:42 INFO - 'pip_index': False, 06:00:42 INFO - 'sps_profile': False, 06:00:42 INFO - 'sps_profile_interval': 0, 06:00:42 INFO - 'suite': 'dromaeojs', 06:00:42 INFO - 'system_bits': '32', 06:00:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:00:42 INFO - 'title': 'talos-linux64-ix-021', 06:00:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:00:42 INFO - 'use_talos_json': True, 06:00:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:00:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:00:42 INFO - 'work_dir': 'build'} 06:00:42 INFO - [mozharness: 2016-08-25 13:00:42.561828Z] Running clobber step. 06:00:42 INFO - Running pre-action listener: _resource_record_pre_action 06:00:42 INFO - Running main action method: clobber 06:00:42 INFO - rmtree: /builds/slave/test/build 06:00:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:00:43 INFO - Running post-action listener: _resource_record_post_action 06:00:43 INFO - [mozharness: 2016-08-25 13:00:43.024853Z] Finished clobber step (success) 06:00:43 INFO - [mozharness: 2016-08-25 13:00:43.024952Z] Running read-buildbot-config step. 06:00:43 INFO - Running pre-action listener: _resource_record_pre_action 06:00:43 INFO - Running main action method: read_buildbot_config 06:00:43 INFO - Using buildbot properties: 06:00:43 INFO - { 06:00:43 INFO - "project": "", 06:00:43 INFO - "product": "firefox", 06:00:43 INFO - "script_repo_revision": "production", 06:00:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:00:43 INFO - "repository": "", 06:00:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:00:43 INFO - "buildid": "20160825030226", 06:00:43 INFO - "stage_platform": "linux64-pgo", 06:00:43 INFO - "basedir": "/builds/slave/test", 06:00:43 INFO - "nightly_build": "True", 06:00:43 INFO - "buildnumber": 427, 06:00:43 INFO - "slavename": "talos-linux64-ix-021", 06:00:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:00:43 INFO - "platform": "ubuntu64_hw", 06:00:43 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:00:43 INFO - "branch": "mozilla-central", 06:00:43 INFO - "repo_path": "mozilla-central", 06:00:43 INFO - "revision": "01748a2b1a463f24efd9cd8abad9ccfd76b037b8", 06:00:43 INFO - "pgo_build": "True", 06:00:43 INFO - "builduid": "14c8039c1032484f999789cb8d50c55c", 06:00:43 INFO - "slavebuilddir": "test" 06:00:43 INFO - } 06:00:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 06:00:43 INFO - Running post-action listener: _resource_record_post_action 06:00:43 INFO - [mozharness: 2016-08-25 13:00:43.027415Z] Finished read-buildbot-config step (success) 06:00:43 INFO - [mozharness: 2016-08-25 13:00:43.027500Z] Running download-and-extract step. 06:00:43 INFO - Running pre-action listener: _resource_record_pre_action 06:00:43 INFO - Running main action method: download_and_extract 06:00:43 INFO - mkdir: /builds/slave/test/build/tests 06:00: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')]} 06:00:43 INFO - trying https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:00:43 INFO - Downloading https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/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 06:00:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/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 06:00:43 INFO - Downloaded 1361 bytes. 06:00:43 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:00:43 INFO - Using the following test package requirements: 06:00:43 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:43 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:00:43 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:00:43 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:43 INFO - u'jsshell-linux-x86_64.zip'], 06:00:43 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:00:43 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:43 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:00:43 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:00:43 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:00:43 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:00:43 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:00: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')]} 06:00:43 INFO - trying https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:00:43 INFO - Downloading https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/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 06:00:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/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 06:00:44 INFO - Downloaded 21915056 bytes. 06:00:44 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 06:00:49 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 06:00:49 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')]} 06:00:49 INFO - trying https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:00:49 INFO - Downloading https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/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 06:00:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/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 06:00:50 INFO - Downloaded 21915056 bytes. 06:00:50 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 06:00:55 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')]} 06:00:55 INFO - trying https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:55 INFO - Downloading https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/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 06:00:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/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 06:00:56 INFO - Downloaded 14413981 bytes. 06:00:56 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 06:00:56 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')]} 06:00:56 INFO - trying https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:00:56 INFO - Downloading https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/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 06:00:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/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 06:00:58 INFO - Downloaded 59656559 bytes. 06:00:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:00:58 INFO - mkdir: /builds/slave/test/properties 06:00:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:00:58 INFO - Writing to file /builds/slave/test/properties/build_url 06:00:58 INFO - Contents: 06:00:58 INFO - build_url:https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:00:59 INFO - Running post-action listener: _resource_record_post_action 06:00:59 INFO - Running post-action listener: set_extra_try_arguments 06:00:59 INFO - [mozharness: 2016-08-25 13:00:59.329779Z] Finished download-and-extract step (success) 06:00:59 INFO - [mozharness: 2016-08-25 13:00:59.330002Z] Running populate-webroot step. 06:00:59 INFO - Running pre-action listener: _resource_record_pre_action 06:00:59 INFO - Running main action method: populate_webroot 06:00:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:00:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:00:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:00:59 INFO - '--tppagecycles', 06:00:59 INFO - '7'], 06:00:59 INFO - 'tests': ['tsvgm']}}, 06:00:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:00:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:00:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:00:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:00:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:59 INFO - 'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:59 INFO - 'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['damp', 'tps']}, 06:00:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:59 INFO - 'tests': ['damp', 'tps']}, 06:00:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['dromaeo_dom']}, 06:00:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:00:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['basic_compositor_video']}, 06:00:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:00:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['a11yr', 06:00:59 INFO - 'ts_paint', 06:00:59 INFO - 'tpaint', 06:00:59 INFO - 'sessionrestore', 06:00:59 INFO - 'sessionrestore_no_auto_restore', 06:00:59 INFO - 'tabpaint']}, 06:00:59 INFO - 'other-e10s': {'tests': ['a11yr', 06:00:59 INFO - 'ts_paint', 06:00:59 INFO - 'tpaint', 06:00:59 INFO - 'sessionrestore', 06:00:59 INFO - 'sessionrestore_no_auto_restore', 06:00:59 INFO - 'tabpaint']}, 06:00:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:00:59 INFO - 'ts_paint', 06:00:59 INFO - 'tpaint', 06:00:59 INFO - 'sessionrestore', 06:00:59 INFO - 'sessionrestore_no_auto_restore', 06:00:59 INFO - 'tabpaint']}, 06:00:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:00:59 INFO - 'ts_paint', 06:00:59 INFO - 'tpaint', 06:00:59 INFO - 'sessionrestore', 06:00:59 INFO - 'sessionrestore_no_auto_restore', 06:00:59 INFO - 'tabpaint']}, 06:00:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['a11yr', 06:00:59 INFO - 'ts_paint', 06:00:59 INFO - 'tpaint', 06:00:59 INFO - 'sessionrestore', 06:00:59 INFO - 'sessionrestore_no_auto_restore', 06:00:59 INFO - 'tabpaint']}, 06:00:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['a11yr', 06:00:59 INFO - 'ts_paint', 06:00:59 INFO - 'tpaint', 06:00:59 INFO - 'sessionrestore', 06:00:59 INFO - 'sessionrestore_no_auto_restore', 06:00:59 INFO - 'tabpaint']}, 06:00:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['tsvgx', 06:00:59 INFO - 'tsvgr_opacity', 06:00:59 INFO - 'tart', 06:00:59 INFO - 'tscrollx', 06:00:59 INFO - 'cart']}, 06:00:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:00:59 INFO - 'tsvgr_opacity', 06:00:59 INFO - 'tart', 06:00:59 INFO - 'tscrollx', 06:00:59 INFO - 'cart']}, 06:00:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:59 INFO - 'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['tp5o']}, 06:00:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:59 INFO - 'tests': ['tp5o']}, 06:00:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:59 INFO - 'talos_options': ['--disable-e10s', 06:00:59 INFO - '--xperf_path', 06:00:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:59 INFO - 'tests': ['tp5n']}, 06:00:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:59 INFO - 'talos_options': ['--xperf_path', 06:00:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:59 INFO - 'tests': ['tp5n']}}, 06:00:59 INFO - 'talos.zip': {'path': '', 06:00:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:00:59 INFO - Running post-action listener: _resource_record_post_action 06:00:59 INFO - [mozharness: 2016-08-25 13:00:59.346964Z] Finished populate-webroot step (success) 06:00:59 INFO - [mozharness: 2016-08-25 13:00:59.347051Z] Running create-virtualenv step. 06:00:59 INFO - Running pre-action listener: _resource_record_pre_action 06:00:59 INFO - Running main action method: create_virtualenv 06:00:59 INFO - Creating virtualenv /builds/slave/test/build/venv 06:00:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:00:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:00:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:00:59 INFO - Using real prefix '/usr' 06:00:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:00:59 INFO - Installing distribute.............................................................................................................................................................................................done. 06:01:01 INFO - Installing pip.................done. 06:01:01 INFO - Return code: 0 06:01:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:01:01 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')]} 06:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:01 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')]} 06:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:01 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 0x7fc63f56bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1628850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1623370>, '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 0x16268f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1626d80>, '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-1472129719.611276-2088958186', '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 06:01:01 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 06:01:01 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 06:01:01 INFO - Using env: {'DISPLAY': ':0', 06:01:01 INFO - 'HOME': '/home/cltbld', 06:01:01 INFO - 'LANG': 'en_US.UTF-8', 06:01:01 INFO - 'LANGUAGE': 'en_US:en', 06:01:01 INFO - 'LOGNAME': 'cltbld', 06:01:01 INFO - 'MAIL': '/var/mail/cltbld', 06:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:01 INFO - 'MOZ_NO_REMOTE': '1', 06:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:01 INFO - 'NO_EM_RESTART': '1', 06:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:01 INFO - 'PWD': '/builds/slave/test', 06:01:01 INFO - 'SHELL': '/bin/bash', 06:01:01 INFO - 'SHLVL': '1', 06:01:01 INFO - 'TERM': 'linux', 06:01:01 INFO - 'TMOUT': '86400', 06:01:01 INFO - 'USER': 'cltbld', 06:01:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472129719.611276-2088958186', 06:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:01 INFO - '_': '/tools/buildbot/bin/python'} 06:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:01:02 INFO - Cleaning up... 06:01:02 INFO - Return code: 0 06:01:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc63f56bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1628850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1623370>, '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 0x16268f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1626d80>, '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-1472129719.611276-2088958186', '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 06:01:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:01:02 INFO - Using env: {'DISPLAY': ':0', 06:01:02 INFO - 'HOME': '/home/cltbld', 06:01:02 INFO - 'LANG': 'en_US.UTF-8', 06:01:02 INFO - 'LANGUAGE': 'en_US:en', 06:01:02 INFO - 'LOGNAME': 'cltbld', 06:01:02 INFO - 'MAIL': '/var/mail/cltbld', 06:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:02 INFO - 'MOZ_NO_REMOTE': '1', 06:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:02 INFO - 'NO_EM_RESTART': '1', 06:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:02 INFO - 'PWD': '/builds/slave/test', 06:01:02 INFO - 'SHELL': '/bin/bash', 06:01:02 INFO - 'SHLVL': '1', 06:01:02 INFO - 'TERM': 'linux', 06:01:02 INFO - 'TMOUT': '86400', 06:01:02 INFO - 'USER': 'cltbld', 06:01:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472129719.611276-2088958186', 06:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:02 INFO - '_': '/tools/buildbot/bin/python'} 06:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:02 INFO - Downloading/unpacking psutil>=3.1.1 06:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:01:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:01:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:01:04 INFO - Installing collected packages: psutil 06:01:04 INFO - Running setup.py install for psutil 06:01:04 INFO - building 'psutil._psutil_linux' extension 06:01:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:01:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:01:04 INFO - building 'psutil._psutil_posix' extension 06:01:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:01:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:01:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:01:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:01:04 INFO - Successfully installed psutil 06:01:04 INFO - Cleaning up... 06:01:04 INFO - Return code: 0 06:01:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:01:04 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')]} 06:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:04 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')]} 06:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:04 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 0x7fc63f56bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1628850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1623370>, '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 0x16268f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1626d80>, '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-1472129719.611276-2088958186', '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 06:01:04 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 06:01:04 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 06:01:04 INFO - Using env: {'DISPLAY': ':0', 06:01:04 INFO - 'HOME': '/home/cltbld', 06:01:04 INFO - 'LANG': 'en_US.UTF-8', 06:01:04 INFO - 'LANGUAGE': 'en_US:en', 06:01:04 INFO - 'LOGNAME': 'cltbld', 06:01:04 INFO - 'MAIL': '/var/mail/cltbld', 06:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:04 INFO - 'MOZ_NO_REMOTE': '1', 06:01:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:04 INFO - 'NO_EM_RESTART': '1', 06:01:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:04 INFO - 'PWD': '/builds/slave/test', 06:01:04 INFO - 'SHELL': '/bin/bash', 06:01:04 INFO - 'SHLVL': '1', 06:01:04 INFO - 'TERM': 'linux', 06:01:04 INFO - 'TMOUT': '86400', 06:01:04 INFO - 'USER': 'cltbld', 06:01:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472129719.611276-2088958186', 06:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:04 INFO - '_': '/tools/buildbot/bin/python'} 06:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:01:07 INFO - Installing collected packages: mozsystemmonitor 06:01:07 INFO - Running setup.py install for mozsystemmonitor 06:01:07 INFO - Successfully installed mozsystemmonitor 06:01:07 INFO - Cleaning up... 06:01:07 INFO - Return code: 0 06:01:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:01: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')]} 06:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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')]} 06:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc63f56bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1628850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1623370>, '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 0x16268f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1626d80>, '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-1472129719.611276-2088958186', '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 06:01:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:01:07 INFO - Using env: {'DISPLAY': ':0', 06:01:07 INFO - 'HOME': '/home/cltbld', 06:01:07 INFO - 'LANG': 'en_US.UTF-8', 06:01:07 INFO - 'LANGUAGE': 'en_US:en', 06:01:07 INFO - 'LOGNAME': 'cltbld', 06:01:07 INFO - 'MAIL': '/var/mail/cltbld', 06:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:07 INFO - 'MOZ_NO_REMOTE': '1', 06:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:07 INFO - 'NO_EM_RESTART': '1', 06:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:07 INFO - 'PWD': '/builds/slave/test', 06:01:07 INFO - 'SHELL': '/bin/bash', 06:01:07 INFO - 'SHLVL': '1', 06:01:07 INFO - 'TERM': 'linux', 06:01:07 INFO - 'TMOUT': '86400', 06:01:07 INFO - 'USER': 'cltbld', 06:01:07 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472129719.611276-2088958186', 06:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:07 INFO - '_': '/tools/buildbot/bin/python'} 06:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:07 INFO - Downloading/unpacking jsonschema==2.5.1 06:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:01:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:09 INFO - Downloading functools32-3.2.3-2.tar.gz 06:01:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:01:09 INFO - warning: no files found matching '*.txt' 06:01:09 INFO - no previously-included directories found matching 'build' 06:01:09 INFO - no previously-included directories found matching 'dist' 06:01:09 INFO - no previously-included directories found matching '.git*' 06:01:09 INFO - Installing collected packages: jsonschema, functools32 06:01:09 INFO - Running setup.py install for functools32 06:01:09 INFO - warning: no files found matching '*.txt' 06:01:09 INFO - no previously-included directories found matching 'build' 06:01:09 INFO - no previously-included directories found matching 'dist' 06:01:09 INFO - no previously-included directories found matching '.git*' 06:01:09 INFO - Successfully installed jsonschema functools32 06:01:09 INFO - Cleaning up... 06:01:09 INFO - Return code: 0 06:01:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:01:09 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')]} 06:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:09 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')]} 06:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:09 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 0x7fc63f56bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1628850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1623370>, '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 0x16268f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1626d80>, '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-1472129719.611276-2088958186', '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 06:01:09 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 06:01:09 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 06:01:09 INFO - Using env: {'DISPLAY': ':0', 06:01:09 INFO - 'HOME': '/home/cltbld', 06:01:09 INFO - 'LANG': 'en_US.UTF-8', 06:01:09 INFO - 'LANGUAGE': 'en_US:en', 06:01:09 INFO - 'LOGNAME': 'cltbld', 06:01:09 INFO - 'MAIL': '/var/mail/cltbld', 06:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:09 INFO - 'MOZ_NO_REMOTE': '1', 06:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:09 INFO - 'NO_EM_RESTART': '1', 06:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:09 INFO - 'PWD': '/builds/slave/test', 06:01:09 INFO - 'SHELL': '/bin/bash', 06:01:09 INFO - 'SHLVL': '1', 06:01:09 INFO - 'TERM': 'linux', 06:01:09 INFO - 'TMOUT': '86400', 06:01:09 INFO - 'USER': 'cltbld', 06:01:09 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472129719.611276-2088958186', 06:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:09 INFO - '_': '/tools/buildbot/bin/python'} 06:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:01:10 INFO - Cleaning up... 06:01:10 INFO - Return code: 0 06:01:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc63f56bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1628850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1623370>, '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 0x16268f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1626d80>, '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-1472129719.611276-2088958186', '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 06:01:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:01:10 INFO - Using env: {'DISPLAY': ':0', 06:01:10 INFO - 'HOME': '/home/cltbld', 06:01:10 INFO - 'LANG': 'en_US.UTF-8', 06:01:10 INFO - 'LANGUAGE': 'en_US:en', 06:01:10 INFO - 'LOGNAME': 'cltbld', 06:01:10 INFO - 'MAIL': '/var/mail/cltbld', 06:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:10 INFO - 'MOZ_NO_REMOTE': '1', 06:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:10 INFO - 'NO_EM_RESTART': '1', 06:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:10 INFO - 'PWD': '/builds/slave/test', 06:01:10 INFO - 'SHELL': '/bin/bash', 06:01:10 INFO - 'SHLVL': '1', 06:01:10 INFO - 'TERM': 'linux', 06:01:10 INFO - 'TMOUT': '86400', 06:01:10 INFO - 'USER': 'cltbld', 06:01:10 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472129719.611276-2088958186', 06:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:10 INFO - '_': '/tools/buildbot/bin/python'} 06:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:10 INFO - Downloading/unpacking blobuploader==1.2.4 06:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:12 INFO - Downloading blobuploader-1.2.4.tar.gz 06:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:01:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:01:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:12 INFO - Downloading docopt-0.6.1.tar.gz 06:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:01:12 INFO - Installing collected packages: blobuploader, requests, docopt 06:01:12 INFO - Running setup.py install for blobuploader 06:01:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:01:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:01:13 INFO - Running setup.py install for requests 06:01:13 INFO - Running setup.py install for docopt 06:01:13 INFO - Successfully installed blobuploader requests docopt 06:01:13 INFO - Cleaning up... 06:01:13 INFO - Return code: 0 06:01:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01: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')]} 06:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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')]} 06:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc63f56bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1628850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1623370>, '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 0x16268f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1626d80>, '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-1472129719.611276-2088958186', '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 06:01:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:01:13 INFO - Using env: {'DISPLAY': ':0', 06:01:13 INFO - 'HOME': '/home/cltbld', 06:01:13 INFO - 'LANG': 'en_US.UTF-8', 06:01:13 INFO - 'LANGUAGE': 'en_US:en', 06:01:13 INFO - 'LOGNAME': 'cltbld', 06:01:13 INFO - 'MAIL': '/var/mail/cltbld', 06:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:13 INFO - 'MOZ_NO_REMOTE': '1', 06:01:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:13 INFO - 'NO_EM_RESTART': '1', 06:01:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:13 INFO - 'PWD': '/builds/slave/test', 06:01:13 INFO - 'SHELL': '/bin/bash', 06:01:13 INFO - 'SHLVL': '1', 06:01:13 INFO - 'TERM': 'linux', 06:01:13 INFO - 'TMOUT': '86400', 06:01:13 INFO - 'USER': 'cltbld', 06:01:13 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472129719.611276-2088958186', 06:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:13 INFO - '_': '/tools/buildbot/bin/python'} 06:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:01:13 INFO - Running setup.py (path:/tmp/pip-k97Yb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:01:13 INFO - Running setup.py (path:/tmp/pip-mx10oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:01:13 INFO - Running setup.py (path:/tmp/pip-N0QcAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:01:13 INFO - Running setup.py (path:/tmp/pip-7xCpsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:01:14 INFO - Running setup.py (path:/tmp/pip-X3Lwb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:01:14 INFO - Running setup.py (path:/tmp/pip-Uc8YtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:01:14 INFO - Running setup.py (path:/tmp/pip-rZ6JKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:01:14 INFO - Running setup.py (path:/tmp/pip-x0WmER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:01:14 INFO - Running setup.py (path:/tmp/pip-8od5y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:01:14 INFO - Running setup.py (path:/tmp/pip-LNlysN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:01:14 INFO - Running setup.py (path:/tmp/pip-QxnUft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:01:14 INFO - Running setup.py (path:/tmp/pip-nEMX_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:01:14 INFO - Running setup.py (path:/tmp/pip-oMckn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:01:14 INFO - Running setup.py (path:/tmp/pip-skDdQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:14 INFO - Running setup.py (path:/tmp/pip-vuawqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:01:14 INFO - Running setup.py (path:/tmp/pip-BRMFuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:01:14 INFO - Running setup.py (path:/tmp/pip-9auuiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:01:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:01:14 INFO - Running setup.py install for manifestparser 06:01:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:01:15 INFO - Running setup.py install for mozcrash 06:01:15 INFO - Running setup.py install for mozdebug 06:01:15 INFO - Running setup.py install for mozdevice 06:01:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:01:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:01:15 INFO - Running setup.py install for mozfile 06:01:15 INFO - Running setup.py install for mozhttpd 06:01:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:01:15 INFO - Running setup.py install for mozinfo 06:01:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:01:15 INFO - Running setup.py install for mozInstall 06:01:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:01:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:01:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:01:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:01:15 INFO - Running setup.py install for mozleak 06:01:15 INFO - Running setup.py install for mozlog 06:01:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Running setup.py install for moznetwork 06:01:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Running setup.py install for mozprocess 06:01:16 INFO - Running setup.py install for mozprofile 06:01:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Running setup.py install for mozrunner 06:01:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Running setup.py install for mozscreenshot 06:01:16 INFO - Running setup.py install for moztest 06:01:16 INFO - Running setup.py install for mozversion 06:01:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:01:16 INFO - Cleaning up... 06:01:16 INFO - Return code: 0 06:01:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:16 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')]} 06:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:16 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')]} 06:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:16 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 0x7fc63f56bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1628850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1623370>, '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 0x16268f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1626d80>, '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-1472129719.611276-2088958186', '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 06:01:16 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 06:01:16 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 06:01:16 INFO - Using env: {'DISPLAY': ':0', 06:01:16 INFO - 'HOME': '/home/cltbld', 06:01:16 INFO - 'LANG': 'en_US.UTF-8', 06:01:16 INFO - 'LANGUAGE': 'en_US:en', 06:01:16 INFO - 'LOGNAME': 'cltbld', 06:01:16 INFO - 'MAIL': '/var/mail/cltbld', 06:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:16 INFO - 'MOZ_NO_REMOTE': '1', 06:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:16 INFO - 'NO_EM_RESTART': '1', 06:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:16 INFO - 'PWD': '/builds/slave/test', 06:01:16 INFO - 'SHELL': '/bin/bash', 06:01:16 INFO - 'SHLVL': '1', 06:01:16 INFO - 'TERM': 'linux', 06:01:16 INFO - 'TMOUT': '86400', 06:01:16 INFO - 'USER': 'cltbld', 06:01:16 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472129719.611276-2088958186', 06:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:16 INFO - '_': '/tools/buildbot/bin/python'} 06:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:01:17 INFO - Running setup.py (path:/tmp/pip-ZVNL94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:01:17 INFO - Running setup.py (path:/tmp/pip-ebWsJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:01:17 INFO - Running setup.py (path:/tmp/pip-fEZAMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:01:17 INFO - Running setup.py (path:/tmp/pip-3NpYnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:01:17 INFO - Running setup.py (path:/tmp/pip-ElDnhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:01:17 INFO - Running setup.py (path:/tmp/pip-COnemj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:01:17 INFO - Running setup.py (path:/tmp/pip-niKCZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:01:17 INFO - Running setup.py (path:/tmp/pip-GSJmsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:01:17 INFO - Running setup.py (path:/tmp/pip-_s3tnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:01:17 INFO - Running setup.py (path:/tmp/pip-EpKBpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:01:17 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)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:01:17 INFO - Running setup.py (path:/tmp/pip-d3VYy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:01:17 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)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:01:17 INFO - Running setup.py (path:/tmp/pip-pBeBBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:01:17 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)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:01:17 INFO - Running setup.py (path:/tmp/pip-AnZbYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:01:17 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)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:01:17 INFO - Running setup.py (path:/tmp/pip-7yg_j2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:18 INFO - Running setup.py (path:/tmp/pip-BnEPrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:01:18 INFO - Running setup.py (path:/tmp/pip-EZ7wOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:01:18 INFO - Running setup.py (path:/tmp/pip-RX8uTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:01:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:20 INFO - Downloading blessings-1.6.tar.gz 06:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:01:20 INFO - Installing collected packages: blessings 06:01:20 INFO - Running setup.py install for blessings 06:01:20 INFO - Successfully installed blessings 06:01:20 INFO - Cleaning up... 06:01:20 INFO - Return code: 0 06:01:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:20 INFO - Reading from file tmpfile_stdout 06:01:20 INFO - Current package versions: 06:01:20 INFO - argparse == 1.2.1 06:01:20 INFO - blessings == 1.6 06:01:20 INFO - blobuploader == 1.2.4 06:01:20 INFO - docopt == 0.6.1 06:01:20 INFO - functools32 == 3.2.3-2 06:01:20 INFO - jsonschema == 2.5.1 06:01:20 INFO - manifestparser == 1.1 06:01:20 INFO - mozInstall == 1.12 06:01:20 INFO - mozcrash == 0.17 06:01:20 INFO - mozdebug == 0.1 06:01:20 INFO - mozdevice == 0.48 06:01:20 INFO - mozfile == 1.2 06:01:20 INFO - mozhttpd == 0.7 06:01:20 INFO - mozinfo == 0.9 06:01:20 INFO - mozleak == 0.1 06:01:20 INFO - mozlog == 3.3 06:01:20 INFO - moznetwork == 0.27 06:01:20 INFO - mozprocess == 0.23 06:01:20 INFO - mozprofile == 0.28 06:01:20 INFO - mozrunner == 6.12 06:01:20 INFO - mozscreenshot == 0.1 06:01:20 INFO - mozsystemmonitor == 0.3 06:01:20 INFO - moztest == 0.7 06:01:20 INFO - mozversion == 1.4 06:01:20 INFO - psutil == 3.1.1 06:01:20 INFO - requests == 1.2.3 06:01:20 INFO - wsgiref == 0.1.2 06:01:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc63f56bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1628850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1623370>, '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 0x16268f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1626d80>, '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-1472129719.611276-2088958186', '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 06:01:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:01:20 INFO - Using env: {'DISPLAY': ':0', 06:01:20 INFO - 'HOME': '/home/cltbld', 06:01:20 INFO - 'LANG': 'en_US.UTF-8', 06:01:20 INFO - 'LANGUAGE': 'en_US:en', 06:01:20 INFO - 'LOGNAME': 'cltbld', 06:01:20 INFO - 'MAIL': '/var/mail/cltbld', 06:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:20 INFO - 'MOZ_NO_REMOTE': '1', 06:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:20 INFO - 'NO_EM_RESTART': '1', 06:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:20 INFO - 'PWD': '/builds/slave/test', 06:01:20 INFO - 'SHELL': '/bin/bash', 06:01:20 INFO - 'SHLVL': '1', 06:01:20 INFO - 'TERM': 'linux', 06:01:20 INFO - 'TMOUT': '86400', 06:01:20 INFO - 'USER': 'cltbld', 06:01:20 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472129719.611276-2088958186', 06:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:20 INFO - '_': '/tools/buildbot/bin/python'} 06:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:20 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)) 06:01:20 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)) 06:01:20 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)) 06:01:20 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)) 06:01:20 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)) 06:01:20 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)) 06:01:20 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)) 06:01:20 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)) 06:01:20 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)) 06:01:20 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)) 06:01:20 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)) 06:01:20 INFO - Cleaning up... 06:01:20 INFO - Return code: 0 06:01:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:20 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 0x7fc63f56bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1628850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1623370>, '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 0x16268f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1626d80>, '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-1472129719.611276-2088958186', '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 06:01:20 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 06:01:20 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 06:01:20 INFO - Using env: {'DISPLAY': ':0', 06:01:20 INFO - 'HOME': '/home/cltbld', 06:01:20 INFO - 'LANG': 'en_US.UTF-8', 06:01:20 INFO - 'LANGUAGE': 'en_US:en', 06:01:20 INFO - 'LOGNAME': 'cltbld', 06:01:20 INFO - 'MAIL': '/var/mail/cltbld', 06:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:20 INFO - 'MOZ_NO_REMOTE': '1', 06:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:20 INFO - 'NO_EM_RESTART': '1', 06:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:20 INFO - 'PWD': '/builds/slave/test', 06:01:20 INFO - 'SHELL': '/bin/bash', 06:01:20 INFO - 'SHLVL': '1', 06:01:20 INFO - 'TERM': 'linux', 06:01:20 INFO - 'TMOUT': '86400', 06:01:20 INFO - 'USER': 'cltbld', 06:01:20 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472129719.611276-2088958186', 06:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:20 INFO - '_': '/tools/buildbot/bin/python'} 06:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:01:21 INFO - Cleaning up... 06:01:21 INFO - Return code: 0 06:01:21 INFO - Running post-action listener: _resource_record_post_action 06:01:21 INFO - Running post-action listener: _start_resource_monitoring 06:01:21 INFO - Starting resource monitoring. 06:01:21 INFO - [mozharness: 2016-08-25 13:01:21.069898Z] Finished create-virtualenv step (success) 06:01:21 INFO - [mozharness: 2016-08-25 13:01:21.070405Z] Running install step. 06:01:21 INFO - Running pre-action listener: _resource_record_pre_action 06:01:21 INFO - Running main action method: install 06:01:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:21 INFO - Reading from file tmpfile_stdout 06:01:21 INFO - Detecting whether we're running mozinstall >=1.0... 06:01:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:01:21 INFO - Reading from file tmpfile_stdout 06:01:21 INFO - Output received: 06:01:21 INFO - Usage: mozinstall [options] installer 06:01:21 INFO - Options: 06:01:21 INFO - -h, --help show this help message and exit 06:01:21 INFO - -d DEST, --destination=DEST 06:01:21 INFO - Directory to install application into. [default: 06:01:21 INFO - "/builds/slave/test"] 06:01:21 INFO - --app=APP Application being installed. [default: firefox] 06:01:21 INFO - mkdir: /builds/slave/test/build/application 06:01:21 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'] 06:01:21 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 06:01:38 INFO - Reading from file tmpfile_stdout 06:01:38 INFO - Output received: 06:01:38 INFO - /builds/slave/test/build/application/firefox/firefox 06:01:38 INFO - Running post-action listener: _resource_record_post_action 06:01:38 INFO - [mozharness: 2016-08-25 13:01:38.339028Z] Finished install step (success) 06:01:38 INFO - [mozharness: 2016-08-25 13:01:38.339361Z] Running run-tests step. 06:01:38 INFO - Running pre-action listener: _resource_record_pre_action 06:01:38 INFO - Running main action method: run_tests 06:01:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:01:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:01:38 INFO - Python 2.7.3 06:01:38 INFO - Return code: 0 06:01:38 INFO - grabbing minidump binary from tooltool 06:01:38 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')]} 06:01:38 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 0x1623370>, '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 0x16268f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1626d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:01:38 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 06:01:38 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 06:01:38 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 06:01:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:01:38 INFO - Return code: 0 06:01:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:01:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:01:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:01:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:01:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:01:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/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 06:01:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/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 06:01:38 INFO - Using env: {'DISPLAY': ':0', 06:01:38 INFO - 'HOME': '/home/cltbld', 06:01:38 INFO - 'LANG': 'en_US.UTF-8', 06:01:38 INFO - 'LANGUAGE': 'en_US:en', 06:01:38 INFO - 'LOGNAME': 'cltbld', 06:01:38 INFO - 'MAIL': '/var/mail/cltbld', 06:01:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:01:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:38 INFO - 'MOZ_NO_REMOTE': '1', 06:01:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:38 INFO - 'NO_EM_RESTART': '1', 06:01:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:38 INFO - 'PWD': '/builds/slave/test', 06:01:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:01:38 INFO - 'SHELL': '/bin/bash', 06:01:38 INFO - 'SHLVL': '1', 06:01:38 INFO - 'TERM': 'linux', 06:01:38 INFO - 'TMOUT': '86400', 06:01:38 INFO - 'USER': 'cltbld', 06:01:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1472129719.611276-2088958186', 06:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:38 INFO - '_': '/tools/buildbot/bin/python'} 06:01:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/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 06:01:38 INFO - mozversion application_buildid: 20160825030226 06:01:38 INFO - mozversion application_changeset: 01748a2b1a463f24efd9cd8abad9ccfd76b037b8 06:01:38 INFO - mozversion application_display_name: Nightly 06:01:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:01:38 INFO - mozversion application_name: Firefox 06:01:38 INFO - mozversion application_remotingname: firefox 06:01:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:01:38 INFO - mozversion application_vendor: Mozilla 06:01:38 INFO - mozversion application_version: 51.0a1 06:01:38 INFO - mozversion platform_buildid: 20160825030226 06:01:38 INFO - mozversion platform_changeset: 01748a2b1a463f24efd9cd8abad9ccfd76b037b8 06:01:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:01:38 INFO - mozversion platform_version: 51.0a1 06:01:38 INFO - using testdate: 1472130098 06:01:38 INFO - actual date: 1472130098 06:01:38 INFO - starting webserver on 'localhost:46114' 06:01:38 INFO - SUITE-START | Running 2 tests 06:01:38 INFO - TEST-START | dromaeo_css 06:01:38 INFO - operating with platform_type : linux_ 06:01:38 INFO - Initialising browser for dromaeo_css test... 06:01:38 INFO - TEST-INFO | started process 7549 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1JSmFE/profile http://localhost:46114/getInfo.html) 06:01:44 INFO - PROCESS | 7549 | __metrics Screen width/height:1600/1200 06:01:44 INFO - PROCESS | 7549 | colorDepth:24 06:01:44 INFO - PROCESS | 7549 | Browser inner width/height: 1024/697 06:01:44 INFO - PROCESS | 7549 | __metrics 06:01:45 INFO - PROCESS | 7549 | 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" 06:01:45 INFO - PROCESS | 7549 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:01:45 INFO - PROCESS | 7549 | console.error: PushService: 06:01:45 INFO - PROCESS | 7549 | stateChangeProcessEnqueue: Error transitioning state 06:01:45 INFO - PROCESS | 7549 | UnknownError 06:01:46 INFO - TEST-INFO | 7549: exit 0 06:01:46 INFO - Browser initialized. 06:01:46 INFO - Running cycle 1/1 for dromaeo_css test... 06:01:46 INFO - TEST-INFO | started process 7630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1JSmFE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:01:58 INFO - PROCESS | 7630 | RSS: Main: 179941376 06:01:58 INFO - PROCESS | 7630 | 06:02:50 INFO - PROCESS | 7630 | 1472130170338 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] 06:05:00 INFO - PROCESS | 7630 | Cycle 1(1): loaded http://localhost:46114/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46114/tests/dromaeo/cssquery-ext.html) 06:05:01 INFO - PROCESS | 7630 | RSS: Main: 287784960 06:05:01 INFO - PROCESS | 7630 | 06:08:03 INFO - PROCESS | 7630 | Cycle 1(1): loaded http://localhost:46114/tests/dromaeo/cssquery-ext.html (next: http://localhost:46114/tests/dromaeo/cssquery-jquery.html) 06:08:04 INFO - PROCESS | 7630 | RSS: Main: 270336000 06:08:04 INFO - PROCESS | 7630 | 06:11:06 INFO - PROCESS | 7630 | Cycle 1(1): loaded http://localhost:46114/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46114/tests/dromaeo/cssquery-mootools.html) 06:11:06 INFO - PROCESS | 7630 | RSS: Main: 214048768 06:11:06 INFO - PROCESS | 7630 | 06:14:08 INFO - PROCESS | 7630 | Cycle 1(1): loaded http://localhost:46114/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46114/tests/dromaeo/cssquery-prototype.html) 06:14:09 INFO - PROCESS | 7630 | RSS: Main: 246358016 06:14:09 INFO - PROCESS | 7630 | 06:17:12 INFO - PROCESS | 7630 | Cycle 1(1): loaded http://localhost:46114/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46114/tests/dromaeo/cssquery-yui.html) 06:17:12 INFO - PROCESS | 7630 | RSS: Main: 216227840 06:17:12 INFO - PROCESS | 7630 | 06:20:15 INFO - PROCESS | 7630 | Cycle 1(1): loaded http://localhost:46114/tests/dromaeo/cssquery-yui.html (next: http://localhost:46114/tests/dromaeo/cssquery-dojo.html) 06:20:15 INFO - PROCESS | 7630 | RSS: Main: 304410624 06:20:15 INFO - PROCESS | 7630 | 06:20:15 INFO - PROCESS | 7630 | __start_tp_report 06:20:15 INFO - PROCESS | 7630 | _x_x_mozilla_page_load 06:20:15 INFO - PROCESS | 7630 | _x_x_mozilla_page_load_details 06:20:15 INFO - PROCESS | 7630 | |i|pagename|runs| 06:20:15 INFO - PROCESS | 7630 | |0;dojo.html;3013.563033360163;3033.681463446338;3034.4841376965915;3074.446599612069;3095.9845200773993;5115.181570948649;5173.715445650488;5258.447862974385;5285.841424757254;5296.9735151324285;5245.370555533342;5265.289185959904;5266.131088370424;5315.548178404841;5322.654027488211;4686.297055441694;4761.119192949298;4783.545563171493;4791.520847915198;4964.925526117111;4777.689450185727;4811.230203167476;4828.420589529243;4843.951560484403;4845.733484658343;4730.716157030589;4749.430068391781;4764.166270902579;4782.497837727058;4783.210770222909;4719.952800471986;4731.077439899221;4745.454272758608;4826.155422800995;4864.659473836833;4734.715917044989;4768.499307572724;4776.379070720784;4789.832355867528;4835.758212089381;5229.137192363255;5243.423223445456;5285.973570132163;5358.624896257264;5365.597580181502;5646.520045796112;5655.915161272585;5664;5672.092465205588;5732.168835518826;5616.831495055155;5675.262215911946;5679.233303504016;5679.630823996427;5686.3744988051285;5159.17453207485;5261;5319.255304257407;5325.440828712968;5330.466953304638;5770.567207459458;5785.913211301834;5795.217645617788;5823.56323275756;5859.882802343929;5529.336479622471;5529.861753456195;5544.362398324244;5546.611737178358;5547.472990065938;5475.288212532425;5509.641873278224;5545.528630066489;5622.156676498558;5632.436756324335;5540.473655002768;5543.972280138573;5546;5594.468525490072;5618.634788738719;5527.668339899619;5562.694051827189;5566.332040155207;5567.3040869891265;5571.860703482364;4304.375865499485;4307.203167413976;4351.4995775485595;4371.868843934687;4406.1187762447635;3930.292547341506;3944.2703099926607;3980.960190398117;4008.1382502762044;4027.033511957168;5389.487998640123;5400.864978375494;5402.432744561843;5403.13549832025;5404.432534583891;5538.224648549206;5682;5685.374608793029;5690.886182276331;5719.399463056402;5411.242426060276;5415.566754659618;5450.073487507133;5476.726163691799;5476.945230547723;4907.901841963141;4924.778384972685;4931.334269873521;4936.308916751657;4989.725565093955;5588.217649529151;5807.303123625023;5913.763449461973;5925.674087925206;5928.3775203603;5655.971720141373;5729.3124825019595;5740;5763.567732420001;5770.422957704196;5836.708164591669;5874.148248504029;5879.5002424794375;5883.735231914488;5884.117382392504;5531.806386776604;5584.804531841366;5591.692456914746;5592.664440133605;5598.440155984369;5558.333000040021;5637.605367624227;5678.346990096192;5707.20099186106;5722.740996980658;5510.448955104457;5515.944840551543;5518.668879867221;5524.751386187711;5527.309086364205;5472.616916815944;5509.889802204014;5523.116301391919;5524.281843360337;5590.329160500766;5316.2823018893505;5462.235287059894;5468.070428027166;5488.4237155098135;5615.578831587729;5624.746886390204;5634.211210430461;5640.435956404327;5640.717964101696;5640.88718225625;5312.601554883477;5379.408265090915;5517.503424691797;5526.944730552643;5528.336599608073 06:20:15 INFO - PROCESS | 7630 | |1;ext.html;566.7902875935904;596.2933923300889;600.7747094839435;603.5051257968468;616.9475594574461;32628.510572341405;35454.468182977245;35784.99999999997;46771.766141169246;47508.76245618776;44305.77847110768;44973;45005;45264;45582.77208613961;8663.740087797376;8811.339149563777;8826.514541700204;8829.470231786081;8831.690890818823;8877.289816814638;8937.240334571537;8973.641054357819;8977.730668079968;8980.506072166028;8914.554272286392;8977.147171018743;8982.955085224565;8983.011868694439;8985.595648195847;8891;8942.55287235639;8959.552022398919;8977.865332019992;8988.865167022499;8786.56067196644;8851.424657397249;8852.645894164225;8854.645814167425;8854.822903541957;42802.35796463056;43196.568034319884;43204.35193472069;43251;43257.567424325985;3661.1945372018113;3814.389697648363;3826.34952058148;4042.6967977401814;4221.535631080578;32447;32486.751324867324;32957;34603.653963460296;34627.307453851034;4266.57334266574;4373.539537734095;4438.755868427267;4448.132614140244;4478.081993191388;334356;336235.99999999756;336259;336529;336589;58460.41539584635;58548.41451585515;58937;58971;59111.704441477516;36322.45516317258;37193.62806371956;37279;39022.80488597596;61124.69437652872;17180.312787488612;17341;17343.566410839576;17349.7397539037;17353.2191051403;13211.075224734368;13291.136076155019;13293.800592991112;13323;13329.466821327038;18993.95533245657;19012.809871901103;19156.521086972658;19175;19195;6829.965850170717;7053.929460705327;7107.680154393065;7155.89266161008;7395.26047395267;947.7204224753714;981.9803603927882;1010.242318261304;1017.2370721958531;1035.782485678001;32607.347853042807;32714.345713085604;32846.507302390484;33122.66877331244;33567;1085.8914108589236;1124.3534967393618;1135.4549816088324;1178.2105988987398;1194.9342786146844;16677.583060423345;17293.827061729222;17322.566935826704;17381.87126317275;17411.390601328894;516885;523945;526239;527011;527307;59022.40977590255;59719.402805972255;59730.70134649299;59743.40256597378;59813;1222.8349172861729;1303.328785675378;1335.1788649980192;1344.946202151903;1356.382845805176;31491.37017259596;33843;33858;33977;34260.314793704485;50978.49021509737;53814.73092634512;55046.44953550574;55246;60362.39637603568;471374;475152;478678;479056;479849;35424.645753542136;44009.55990440054;44226.778866105466;45188.092083884534;45432;46156;48743.51256487532;49132.26301605407;49138.262926055424;49588.50411495839;40838.387424189255;41631.58368416277;42216.78891605522;42959.48209063339;43768.56231437772;40722.38916416197;41267;42107.578924210364;42688.78655606702;43058.354124687525;40557.39163912485;42050.78974605107;43165.05757240869;43422.56577434185;43478.78260608677;33333.33333333271;36860.63139368572;37596;37823.70468134408;38237.808810955765;28079.43841123125;28328.43343133167;28334;28432.715672843005;28497.715022849505 06:20:15 INFO - PROCESS | 7630 | |2;jquery.html;393.1154901471689;400.3114642814358;402.1253773043629;405.3190639725261;418.9099343641117;13370.465181392732;18610.720839187423;20313.984300784956;20368.722568260666;21276.4680882978;16173.43392981246;19010.524736881584;19570.412887613358;19707.901460492678;19850.90074549629;5698.173764804101;5896.852578685524;5899.823005309848;5899.911501327483;5901;5625.071863142576;5757.913631295534;5807.854803629901;5827.912581311284;5834.708264586775;5824.097264923944;5824.883502329951;5844.473997340238;5848.4736373726355;5851.122331650244;5638.407967163471;5770.769169233267;5812;5852.619579727304;5856.619319744203;5184.403793563751;5188.377394712621;5191.6625419348;5195.896082078375;5198.116320225571;24010.159644412535;24418.755812441825;24428.267151985292;24490.63264051041;24611.38471538208;2350.3536527454917;2514.208024472285;2522.7225005249406;2546.974530254692;3078.507438809802;10450.320729152581;10790.136789056935;10856.67429977094;10939.890601093966;11070.501827417786;1940.5245714799964;1974.131382191831;2021.4238941901488;2038.4903774056486;2044.3049363216578;87517.56241218753;89653;89696;91214;94524.99999999932;11265.718357040976;11447.313161210353;11489.712757181138;11549.249298795552;11552.94223528877;15881.920590397205;15938.60153496172;15981.840181598267;16006.759898601531;16010.9199454002;8090.797730056678;8308.003039635161;8323.084460709317;8491.61787719554;8559.614817333235;7941.285284324323;8009.118996910335;8213.95893020531;8241.340692744567;8305.211004954519;4468.285074388083;4580.198465268565;4642.698224615389;4777.522247775195;4838.975805120952;2009.1360714892444;2035.8574899756875;2043.867148635334;2063.102550390585;2064.917403303851;941.355171707369;999.9250056245811;1029.696239609317;1107.2636696596835;1116.0736588631578;19846.20615175377;20170;20183.798162018193;20347.69478457824;20882.164713411294;965.6234068713208;992.4442312305132;998.6354980432235;1019.3119644240109;1079.8704155501391;10671.25301228922;11272.745450909686;11307.604233851776;11402.486888090056;11507.424628768527;518428;519572;521192.1258110656;523954;527089;60014;62446.37553624497;95538.5223073894;96864.51567742116;99021.50489247651;1006.1347241372561;1014.0771897573173;1028.6554004408606;1029.5469993203117;1049.5696764326742;17308.394206202724;17719.73420398721;17955.82044179594;18731.90634046821;18925.716114258023;32115.518267225543;33596;43560;44107.338389923534;45019.09961800811;57585;59108.40891591029;59435.40564594472;60853.69573152283;61380.386196137464;8625.827483450421;8891.73324800257;9192.816143677222;9274.582643781181;9401.153896149379;12970.156939798882;13254.734905302033;13643.317834108453;13731.519396821062;14267.286635668383;11807.350595717318;11995.460204290654;12092.45583948742;12101;12247.938760306142;11753.883381078784;12052.819207712068;12172.391380430767;12239.32683702405;12298.877011230132;11991.64025079249;12175.086868484723;12229.571964981184;12279.754404911673;12762.872371276168;7831.216878312123;8918.24194943437;8950.225026539707;9102.362834601514;9139.634414623606;11242.606508772154;11779.411029448322;11911.583094591648;11931.403429828648;12131.393430328271 06:20:15 INFO - PROCESS | 7630 | |3;mootools.html;1315.05316172356;1462.3931068606526;1484.814398200225;1605.1893793634213;1714.6313542588348;8288.502689838606;8624.13758624138;8648.30813534918;8875.467471951688;8895.644174233023;8749.825003499926;8830.381873268874;8856.335774816882;8859.734207973772;8862.955685221581;2371.7509661485556;2394.0423830467867;2397.700287464067;2399.4961058177805;2400.31590996566;2397.6283676030243;2424.830261881669;2471.3450935502105;2475.962860557093;2476.2942561370014;2387.462820865309;2396.604560247557;2421.4188594737225;2430.404550885036;2433.051110067075;2337.520808234308;2339.333290012347;2342.0280583557887;2355.7290911545133;2385.3440303916386;2323.268170526279;2342.976570234293;2345.906163753448;2346.5424242272766;2348.1077190667606;8768.605412756442;8849.336299777478;8895.822083558358;8909.732708018704;8955.507447090407;5281.313429254211;5555.611107222496;5564.387917329091;5568.3596386415675;5574.693391863446;3627.4740162676526;3644;3693.445983102556;3700.5744339401044;3709.3879509880835;1208.3897631696025;1231.6612931443835;1235.8269842222096;1256.3341429042623;1258.1130303136267;12551.623451296384;12637.873621263761;12660.746785064248;12694.619161425171;12700.682482937907;4422.204003279377;4536.092781443725;4715.151272770934;4716.95283047172;4718.764061796896;9969.451680157516;9982.05170508815;10000.3499772516;10005;10006.149477294366;5344.091504444254;5405.4324295949145;5414.810481633124;5415.079436495806;5416.241726158341;3982.2234664240195;4318.460192475941;4449.844255451108;5010.874728131753;5043.193089105725;3810.847566097325;3812.790296533717;3926.9018274542796;3926.960730392717;3937.940930886039;1146.6158836789768;1148.121686909515;1148.6955956671488;1151.2977083978767;1166.1545379599722;885.3404213860715;912.32943786317;955.2262667239559;997.6458357283205;1020.6835880876952;5759.971200143972;6092.634441933498;6195.566310358232;6403.519736019817;6408.807735767934;943.2783920300975;950.3964982236191;969.9515024248759;987.5457289646699;1017.7710015246511;3928.626780455852;4284.228838809045;4327.56724327571;4438.378626992224;4530.184566778012;10869.782604347869;11350.318980861175;11387.259828111146;11676.182667213214;11695.707607309716;11478.59824906141;11551.88448115508;11595.130365222474;11596.884031159749;11609.071274298036;8246.670133194724;8424.368172386972;8456;8456.534890580953;8461.407701460961;6093.2078829751845;6190.164327815687;6265.874682506415;6277.497800176066;6373.521985851173;10258.487075646337;10295.691129266133;10404.68785936423;10416.687499375032;10526.473676316307;8484.745457636282;10611.575536978435;10783.299085559414;10864.130869530576;10876.619318323821;7980.720674776355;8179.182081791773;8377.371697122862;8378.832423351621;8387.664493420194;8353;8672.523011234443;8735.694250701195;8908.643654253758;8966.86549701742;7705.483702802805;7706.152323244551;7765.301122898966;7801.9609901950125;8032.357411406956;7562.886556701764;7619.542827430372;7675.385969122569;7731.420143489148;7748.728794492165;7319.048523691886;7326.487145899736;7367.115946086504;7402.407807375289;7405.703771849281;5140.408852981955;5167.870803229949;5218.112920803396;5245.318108645852;5288.2860813791185;5164.1995490699;5251.711155886463;5358.223057656696;5403.945960540502;5426.186072089218 06:20:15 INFO - PROCESS | 7630 | |4;prototype.html;330.83164399766355;342.16341046142185;343.79200583646895;351.4991137628878;352.9911752206196;5033.9428719968755;5141.640085194038;5212.452692467293;5269.445513573495;5283.762230699618;5132.28148059272;5141.897162056756;5154.561862241714;5169.353830771153;5183.559397451212;4095.8361665533344;4101.323281658522;4105.384192371138;4109.773962432065;4119.361498967664;3925.862594809182;4056.574059723716;4107.363358679395;4115.8765237042935;4126.195391898581;4020.0753826619894;4026.1746341999965;4028.5769994150633;4031.0930040740745;4033.1731994940965;4030.7581545107387;4030.7706149624355;4047.4738284023183;4053.391991201314;4056.918861622751;3591.479235510836;3614.204874927512;3622.4023036198996;3629.1471504196493;3632.237230181665;4960;4967.031428871372;5012.423571289275;5018.222175562757;5048.268001139851;4594.701344412636;4602.217623004098;4616.607588354994;4618.861434156981;4619.74591397473;5354.500739792864;5370.785168593252;5371.92561487704;5393.1370980643305;5402.837914862561;3865.5168103987003;3898.142408670088;3924.1955399143108;3924.5682974872743;3929.764214147132;5532.040358408272;5553.029583847569;5568.777248910039;5584.0507113790345;5594.244776955059;4004.7196696230985;4016.4376987221813;4024.8390064397095;4026.4362989181536;4042.6159514846045;3921.509811273591;4040.3535434330365;4060.26915155269;4086.2236175127227;4103.845481122435;4575.428071491064;4580.106879158532;4584.908301833944;4593.724376537419;4640.9535904640525;5366.463353664602;5375.301210842644;5385.542228910586;5404.3784964728775;5459.153831156098;1294.5598496511232;1335.4524644895546;1361.4826365980864;1363.8840698540735;1366.2827015816777;874.2044739287218;891.3270480787094;910.1581037540249;916.1159481100769;922.7093465558328;4581.335706322565;4621.514740952219;4639.768011599406;4653.371794807726;4674.831292176956;4887.437944636341;4899;4899.476769463729;4906.852794416173;4930.457649658535;4530.705504142286;4554.476235232991;4580.267157254823;4597.241455159928;4600.366869761254;2720.4695084458735;2925.473414785359;2947.410517896429;2950.9376624415195;2952.6752057273684;5725.971370143123;5758.884822303614;5770.942290577041;5794.478496935296;5819.214406055213;5523.613347065667;5644.689542075225;5671.716414179357;5716.228309178291;5725.539987303211;5729.083346664514;5738.8278351649515;5741.282339707536;5745.724936786075;5757.740901659436;5524.861878453071;5536;5577.191307260344;5582.901489673271;5583.804566840141;5251.684898906078;5451.373092094302;5482.533984611353;5482.547125011795;5542.3349198094875;5719.199312096393;5750.281214848144;5762.876239133328;5773.026891151145;5802.50678692299;3933.370660694275;4109.363048727452;4131.215069136854;4149.771762552968;4170.979145104255;5282.207668849704;5526.50261476469;5538.584606154635;5553.6390134641115;5559.138333558305;5229.294045303987;5344.706041167773;5369.27514785499;5384.488473595002;5435.592330575144;5385.596080294072;5406.378266499246;5417.458254174551;5422.891542169055;5431.34823821144;5210.0722732587665;5281.815136470205;5339.279197308314;5361.892762144813;5367;5396.4333744957785;5407.648502847303;5415.783368665209;5431.83704488866;5433.483819037185;5319.308489896289;5327.573794096541;5341.41244463101;5354.464553544614;5384.407715151408 06:20:15 INFO - PROCESS | 7630 | |5;yui.html;763.6449051191197;785.7249962513117;822.0300045945785;852.5907564369105;862.8835107260518;15386;16857.578560535992;16876.324947002104;16891.746623800624;16988.235529401176;15280;15384.923075384635;15401.075935443881;15422.383104675799;15439.305231264592;641.9711112999926;787.9645415956267;789.6643926331301;802.077610747639;803.7026300268909;800.2077942836609;804.5816175588691;809.6275713171948;810.027966440271;810.2586133687698;859.8108416148438;861.0571424290392;861.6036623153357;862.65062649627;862.9395942284043;675.0818886314609;819.2299238715589;855.324293807891;856.1395797223781;857.4340934982913;620;625.0343219725535;625.5089754542662;626.1922120464595;627.9026750853625;15773.290201940825;15826.920865395714;15829.44596939113;15845.366185352572;15856.603584910354;14365.13809171453;14503.854961450355;14813.333399996918;14910.478133265284;15039;13158.736825263537;13169.275689837055;13207.88673812195;13554.93222533881;13719.588412347646;4410.4707435107675;4577.427821522309;4579.862604121881;4673.462551806551;4699.929501057487;83161;83503.5824820878;84507.5774621123;85348.57325713393;85452.57273713591;10768.515416806262;10805.945970270099;10886.29239099456;10987.945060274647;11060.059894908862;19240.807591924182;19396;19460.70808937867;19481.220751169796;19494.415167544998;8642.22220000203;8687.174718401742;8689.869651955225;8706.695265665798;9006.549672516348;4655.534446555317;4696.131215725101;4842.830500932521;4862.95137048632;4923.138450771173;3381.2223188666253;3575.3564358415733;3583.7312201584987;3586.497890295361;3592.5688917329567;630.1052505442283;634.0615888485067;634.8159033880215;636.1539152926597;638.7476946606157;654.2802916791492;656.6388486332498;666.1340257665016;678.4572342126279;693.4798900824381;8626.784330391665;9130.634774609074;9294.488803115759;9446.85829712555;9491.430514169171;613.2273335597091;642.7268410925432;649.9155109835785;664.7008846019311;681.6489507903434;4334.349847522897;4507.684462087688;4552.11233809404;4560.68075234737;4609.861704148881;127986.36006820093;128551;128554.35722821513;130312.3484382591;131352.3432382832;30864.228394289872;48018.75990620025;67174;86889;97213;55864.720676396355;57315.71342143263;61319;67074;72936.99999999894;8919.331050171133;9260.159295370891;9532.618695252113;9616.423014619146;9651.276154288316;50904.74547627238;50998.74500627473;51710.74144629253;52933.47066529439;53888;73728;75575.24424755682;76494.23505764871;78305.21694782979;79961.20038799537;13317.66705832362;13319.600411987656;13504.392302346221;13600.523981660594;13777.140086088652;14866.714268713331;14936.925315373353;15155.924220378827;15456.381744730084;15558.533244002698;13924.443022278996;13975.30123493801;14472;14588.781168282696;14925.850741492446;13572.592822215349;13999.16005039701;14132.445431002376;14596.270186490845;14703.92648036753;13658.863411365759;13753.449862005808;14037.438502459787;14488.710225795214;14776.926115369355;10062.446565438971;10821.513031913426;11442;11542.94228528852;11874.76250475003;11804.409779511161;12197.695057623276;12358.752824943631;12405.875941240472;12414.751704966031 06:20:15 INFO - PROCESS | 7630 | __end_tp_report 06:20:15 INFO - PROCESS | 7630 | __start_cc_report 06:20:15 INFO - PROCESS | 7630 | _x_x_mozilla_cycle_collect,949 06:20:15 INFO - PROCESS | 7630 | __end_cc_report 06:20:15 INFO - PROCESS | 7630 | __startTimestamp1472131215880__endTimestamp 06:20:15 INFO - PROCESS | 7630 | 06:20:15 INFO - PROCESS | 7630 | ------- Summary: start ------- 06:20:15 INFO - PROCESS | 7630 | Number of tests: 6 06:20:15 INFO - PROCESS | 7630 | 06:20:15 INFO - PROCESS | 7630 | [#0] dojo.html Cycles:165 Average:5257.60 Median:5488.42 stddev:590.02 (10.8%) stddev-sans-first:564.96 06:20:15 INFO - PROCESS | 7630 | Values: 3013.6 3033.7 3034.5 3074.4 3096.0 5115.2 5173.7 5258.4 5285.8 5297.0 5245.4 5265.3 5266.1 5315.5 5322.7 4686.3 4761.1 4783.5 4791.5 4964.9 4777.7 4811.2 4828.4 4844.0 4845.7 4730.7 4749.4 4764.2 4782.5 4783.2 4720.0 4731.1 4745.5 4826.2 4864.7 4734.7 4768.5 4776.4 4789.8 4835.8 5229.1 5243.4 5286.0 5358.6 5365.6 5646.5 5655.9 5664.0 5672.1 5732.2 5616.8 5675.3 5679.2 5679.6 5686.4 5159.2 5261.0 5319.3 5325.4 5330.5 5770.6 5785.9 5795.2 5823.6 5859.9 5529.3 5529.9 5544.4 5546.6 5547.5 5475.3 5509.6 5545.5 5622.2 5632.4 5540.5 5544.0 5546.0 5594.5 5618.6 5527.7 5562.7 5566.3 5567.3 5571.9 4304.4 4307.2 4351.5 4371.9 4406.1 3930.3 3944.3 3981.0 4008.1 4027.0 5389.5 5400.9 5402.4 5403.1 5404.4 5538.2 5682.0 5685.4 5690.9 5719.4 5411.2 5415.6 5450.1 5476.7 5476.9 4907.9 4924.8 4931.3 4936.3 4989.7 5588.2 5807.3 5913.8 5925.7 5928.4 5656.0 5729.3 5740.0 5763.6 5770.4 5836.7 5874.1 5879.5 5883.7 5884.1 5531.8 5584.8 5591.7 5592.7 5598.4 5558.3 5637.6 5678.3 5707.2 5722.7 5510.4 5515.9 5518.7 5524.8 5527.3 5472.6 5509.9 5523.1 5524.3 5590.3 5316.3 5462.2 5468.1 5488.4 5615.6 5624.7 5634.2 5640.4 5640.7 5640.9 5312.6 5379.4 5517.5 5526.9 5528.3 06:20:15 INFO - PROCESS | 7630 | 06:20:15 INFO - PROCESS | 7630 | [#1] ext.html Cycles:180 Average:60962.96 Median:43200.46 stddev:119992.36 (277.8%) stddev-sans-first:120243.29 06:20:15 INFO - PROCESS | 7630 | Values: 566.8 596.3 600.8 603.5 616.9 32628.5 35454.5 35785.0 46771.8 47508.8 44305.8 44973.0 45005.0 45264.0 45582.8 8663.7 8811.3 8826.5 8829.5 8831.7 8877.3 8937.2 8973.6 8977.7 8980.5 8914.6 8977.1 8983.0 8983.0 8985.6 8891.0 8942.6 8959.6 8977.9 8988.9 8786.6 8851.4 8852.6 8854.6 8854.8 42802.4 43196.6 43204.4 43251.0 43257.6 3661.2 3814.4 3826.3 4042.7 4221.5 32447.0 32486.8 32957.0 34603.7 34627.3 4266.6 4373.5 4438.8 4448.1 4478.1 334356.0 336236.0 336259.0 336529.0 336589.0 58460.4 58548.4 58937.0 58971.0 59111.7 36322.5 37193.6 37279.0 39022.8 61124.7 17180.3 17341.0 17343.6 17349.7 17353.2 13211.1 13291.1 13293.8 13323.0 13329.5 18994.0 19012.8 19156.5 19175.0 19195.0 6830.0 7053.9 7107.7 7155.9 7395.3 947.7 982.0 1010.2 1017.2 1035.8 32607.3 32714.3 32846.5 33122.7 33567.0 1085.9 1124.4 1135.5 1178.2 1194.9 16677.6 17293.8 17322.6 17381.9 17411.4 516885.0 523945.0 526239.0 527011.0 527307.0 59022.4 59719.4 59730.7 59743.4 59813.0 1222.8 1303.3 1335.2 1344.9 1356.4 31491.4 33843.0 33858.0 33977.0 34260.3 50978.5 53814.7 55046.4 55246.0 60362.4 471374.0 475152.0 478678.0 479056.0 479849.0 35424.6 44009.6 44226.8 45188.1 45432.0 46156.0 48743.5 49132.3 49138.3 49588.5 40838.4 41631.6 42216.8 42959.5 43768.6 40722.4 41267.0 42107.6 42688.8 43058.4 40557.4 42050.8 43165.1 43422.6 43478.8 33333.3 36860.6 37596.0 37823.7 38237.8 28079.4 28328.4 28334.0 28432.7 28497.7 06:20:15 INFO - PROCESS | 7630 | 06:20:15 INFO - PROCESS | 7630 | [#2] jquery.html Cycles:180 Average:30112.36 Median:13562.80 stddev:85935.54 (633.6%) stddev-sans-first:86147.64 06:20:15 INFO - PROCESS | 7630 | Values: 393.1 400.3 402.1 405.3 418.9 13370.5 18610.7 20314.0 20368.7 21276.5 16173.4 19010.5 19570.4 19707.9 19850.9 5698.2 5896.9 5899.8 5899.9 5901.0 5625.1 5757.9 5807.9 5827.9 5834.7 5824.1 5824.9 5844.5 5848.5 5851.1 5638.4 5770.8 5812.0 5852.6 5856.6 5184.4 5188.4 5191.7 5195.9 5198.1 24010.2 24418.8 24428.3 24490.6 24611.4 2350.4 2514.2 2522.7 2547.0 3078.5 10450.3 10790.1 10856.7 10939.9 11070.5 1940.5 1974.1 2021.4 2038.5 2044.3 87517.6 89653.0 89696.0 91214.0 94525.0 11265.7 11447.3 11489.7 11549.2 11552.9 15881.9 15938.6 15981.8 16006.8 16010.9 8090.8 8308.0 8323.1 8491.6 8559.6 7941.3 8009.1 8214.0 8241.3 8305.2 4468.3 4580.2 4642.7 4777.5 4839.0 2009.1 2035.9 2043.9 2063.1 2064.9 941.4 999.9 1029.7 1107.3 1116.1 19846.2 20170.0 20183.8 20347.7 20882.2 965.6 992.4 998.6 1019.3 1079.9 10671.3 11272.7 11307.6 11402.5 11507.4 518428.0 519572.0 521192.1 523954.0 527089.0 60014.0 62446.4 95538.5 96864.5 99021.5 1006.1 1014.1 1028.7 1029.5 1049.6 17308.4 17719.7 17955.8 18731.9 18925.7 32115.5 33596.0 43560.0 44107.3 45019.1 57585.0 59108.4 59435.4 60853.7 61380.4 8625.8 8891.7 9192.8 9274.6 9401.2 12970.2 13254.7 13643.3 13731.5 14267.3 11807.4 11995.5 12092.5 12101.0 12247.9 11753.9 12052.8 12172.4 12239.3 12298.9 11991.6 12175.1 12229.6 12279.8 12762.9 7831.2 8918.2 8950.2 9102.4 9139.6 11242.6 11779.4 11911.6 11931.4 12131.4 06:20:15 INFO - PROCESS | 7630 | 06:20:15 INFO - PROCESS | 7630 | [#3] mootools.html Cycles:180 Average:5933.13 Median:4717.86 stddev:3383.19 (71.7%) stddev-sans-first:3374.88 06:20:15 INFO - PROCESS | 7630 | Values: 1315.1 1462.4 1484.8 1605.2 1714.6 8288.5 8624.1 8648.3 8875.5 8895.6 8749.8 8830.4 8856.3 8859.7 8863.0 2371.8 2394.0 2397.7 2399.5 2400.3 2397.6 2424.8 2471.3 2476.0 2476.3 2387.5 2396.6 2421.4 2430.4 2433.1 2337.5 2339.3 2342.0 2355.7 2385.3 2323.3 2343.0 2345.9 2346.5 2348.1 8768.6 8849.3 8895.8 8909.7 8955.5 5281.3 5555.6 5564.4 5568.4 5574.7 3627.5 3644.0 3693.4 3700.6 3709.4 1208.4 1231.7 1235.8 1256.3 1258.1 12551.6 12637.9 12660.7 12694.6 12700.7 4422.2 4536.1 4715.2 4717.0 4718.8 9969.5 9982.1 10000.3 10005.0 10006.1 5344.1 5405.4 5414.8 5415.1 5416.2 3982.2 4318.5 4449.8 5010.9 5043.2 3810.8 3812.8 3926.9 3927.0 3937.9 1146.6 1148.1 1148.7 1151.3 1166.2 885.3 912.3 955.2 997.6 1020.7 5760.0 6092.6 6195.6 6403.5 6408.8 943.3 950.4 970.0 987.5 1017.8 3928.6 4284.2 4327.6 4438.4 4530.2 10869.8 11350.3 11387.3 11676.2 11695.7 11478.6 11551.9 11595.1 11596.9 11609.1 8246.7 8424.4 8456.0 8456.5 8461.4 6093.2 6190.2 6265.9 6277.5 6373.5 10258.5 10295.7 10404.7 10416.7 10526.5 8484.7 10611.6 10783.3 10864.1 10876.6 7980.7 8179.2 8377.4 8378.8 8387.7 8353.0 8672.5 8735.7 8908.6 8966.9 7705.5 7706.2 7765.3 7802.0 8032.4 7562.9 7619.5 7675.4 7731.4 7748.7 7319.0 7326.5 7367.1 7402.4 7405.7 5140.4 5167.9 5218.1 5245.3 5288.3 5164.2 5251.7 5358.2 5403.9 5426.2 06:20:15 INFO - PROCESS | 7630 | 06:20:15 INFO - PROCESS | 7630 | [#4] prototype.html Cycles:180 Average:4519.48 Median:5090.27 stddev:1318.57 (25.9%) stddev-sans-first:1284.24 06:20:15 INFO - PROCESS | 7630 | Values: 330.8 342.2 343.8 351.5 353.0 5033.9 5141.6 5212.5 5269.4 5283.8 5132.3 5141.9 5154.6 5169.4 5183.6 4095.8 4101.3 4105.4 4109.8 4119.4 3925.9 4056.6 4107.4 4115.9 4126.2 4020.1 4026.2 4028.6 4031.1 4033.2 4030.8 4030.8 4047.5 4053.4 4056.9 3591.5 3614.2 3622.4 3629.1 3632.2 4960.0 4967.0 5012.4 5018.2 5048.3 4594.7 4602.2 4616.6 4618.9 4619.7 5354.5 5370.8 5371.9 5393.1 5402.8 3865.5 3898.1 3924.2 3924.6 3929.8 5532.0 5553.0 5568.8 5584.1 5594.2 4004.7 4016.4 4024.8 4026.4 4042.6 3921.5 4040.4 4060.3 4086.2 4103.8 4575.4 4580.1 4584.9 4593.7 4641.0 5366.5 5375.3 5385.5 5404.4 5459.2 1294.6 1335.5 1361.5 1363.9 1366.3 874.2 891.3 910.2 916.1 922.7 4581.3 4621.5 4639.8 4653.4 4674.8 4887.4 4899.0 4899.5 4906.9 4930.5 4530.7 4554.5 4580.3 4597.2 4600.4 2720.5 2925.5 2947.4 2950.9 2952.7 5726.0 5758.9 5770.9 5794.5 5819.2 5523.6 5644.7 5671.7 5716.2 5725.5 5729.1 5738.8 5741.3 5745.7 5757.7 5524.9 5536.0 5577.2 5582.9 5583.8 5251.7 5451.4 5482.5 5482.5 5542.3 5719.2 5750.3 5762.9 5773.0 5802.5 3933.4 4109.4 4131.2 4149.8 4171.0 5282.2 5526.5 5538.6 5553.6 5559.1 5229.3 5344.7 5369.3 5384.5 5435.6 5385.6 5406.4 5417.5 5422.9 5431.3 5210.1 5281.8 5339.3 5361.9 5367.0 5396.4 5407.6 5415.8 5431.8 5433.5 5319.3 5327.6 5341.4 5354.5 5384.4 06:20:15 INFO - PROCESS | 7630 | 06:20:15 INFO - PROCESS | 7630 | [#5] yui.html Cycles:180 Average:20111.85 Median:4684.80 stddev:29019.50 (619.4%) stddev-sans-first:29064.54 06:20:15 INFO - PROCESS | 7630 | Values: 763.6 785.7 822.0 852.6 862.9 15386.0 16857.6 16876.3 16891.7 16988.2 15280.0 15384.9 15401.1 15422.4 15439.3 642.0 788.0 789.7 802.1 803.7 800.2 804.6 809.6 810.0 810.3 859.8 861.1 861.6 862.7 862.9 675.1 819.2 855.3 856.1 857.4 620.0 625.0 625.5 626.2 627.9 15773.3 15826.9 15829.4 15845.4 15856.6 14365.1 14503.9 14813.3 14910.5 15039.0 13158.7 13169.3 13207.9 13554.9 13719.6 4410.5 4577.4 4579.9 4673.5 4699.9 83161.0 83503.6 84507.6 85348.6 85452.6 10768.5 10805.9 10886.3 10987.9 11060.1 19240.8 19396.0 19460.7 19481.2 19494.4 8642.2 8687.2 8689.9 8706.7 9006.5 4655.5 4696.1 4842.8 4863.0 4923.1 3381.2 3575.4 3583.7 3586.5 3592.6 630.1 634.1 634.8 636.2 638.7 654.3 656.6 666.1 678.5 693.5 8626.8 9130.6 9294.5 9446.9 9491.4 613.2 642.7 649.9 664.7 681.6 4334.3 4507.7 4552.1 4560.7 4609.9 127986.4 128551.0 128554.4 130312.3 131352.3 30864.2 48018.8 67174.0 86889.0 97213.0 55864.7 57315.7 61319.0 67074.0 72937.0 8919.3 9260.2 9532.6 9616.4 9651.3 50904.7 50998.7 51710.7 52933.5 53888.0 73728.0 75575.2 76494.2 78305.2 79961.2 13317.7 13319.6 13504.4 13600.5 13777.1 14866.7 14936.9 15155.9 15456.4 15558.5 13924.4 13975.3 14472.0 14588.8 14925.9 13572.6 13999.2 14132.4 14596.3 14703.9 13658.9 13753.4 14037.4 14488.7 14776.9 10062.4 10821.5 11442.0 11542.9 11874.8 11804.4 12197.7 12358.8 12405.9 12414.8 06:20:15 INFO - PROCESS | 7630 | -------- Summary: end -------- 06:20:15 INFO - PROCESS | 7630 | 06:20:16 INFO - TEST-INFO | 7630: exit 0 06:20:16 INFO - TEST-OK | dromaeo_css | took 1118175ms 06:20:16 INFO - TEST-START | kraken 06:20:16 INFO - operating with platform_type : linux_ 06:20:16 INFO - Initialising browser for kraken test... 06:20:16 INFO - TEST-INFO | started process 7940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5oAimk/profile http://localhost:46114/getInfo.html) 06:20:22 INFO - PROCESS | 7940 | __metrics Screen width/height:1600/1200 06:20:22 INFO - PROCESS | 7940 | colorDepth:24 06:20:22 INFO - PROCESS | 7940 | Browser inner width/height: 1024/697 06:20:22 INFO - PROCESS | 7940 | __metrics 06:20:22 INFO - PROCESS | 7940 | 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" 06:20:22 INFO - PROCESS | 7940 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:20:23 INFO - PROCESS | 7940 | console.error: PushService: 06:20:23 INFO - PROCESS | 7940 | stateChangeProcessEnqueue: Error transitioning state 06:20:23 INFO - PROCESS | 7940 | UnknownError 06:20:24 INFO - TEST-INFO | 7940: exit 0 06:20:24 INFO - Browser initialized. 06:20:24 INFO - Running cycle 1/1 for kraken test... 06:20:24 INFO - TEST-INFO | started process 8021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5oAimk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:20:36 INFO - PROCESS | 8021 | RSS: Main: 180465664 06:20:36 INFO - PROCESS | 8021 | 06:20:38 INFO - PROCESS | 8021 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46114/tests/kraken/driver.html?testName=audio-beat-detection) 06:20:39 INFO - PROCESS | 8021 | RSS: Main: 242761728 06:20:39 INFO - PROCESS | 8021 | 06:20:42 INFO - PROCESS | 8021 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46114/tests/kraken/driver.html?testName=audio-dft) 06:20:42 INFO - PROCESS | 8021 | RSS: Main: 224354304 06:20:42 INFO - PROCESS | 8021 | 06:20:46 INFO - PROCESS | 8021 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46114/tests/kraken/driver.html?testName=audio-fft) 06:20:46 INFO - PROCESS | 8021 | RSS: Main: 301449216 06:20:46 INFO - PROCESS | 8021 | 06:20:48 INFO - PROCESS | 8021 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46114/tests/kraken/driver.html?testName=audio-oscillator) 06:20:49 INFO - PROCESS | 8021 | RSS: Main: 212193280 06:20:49 INFO - PROCESS | 8021 | 06:20:51 INFO - PROCESS | 8021 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46114/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:20:52 INFO - PROCESS | 8021 | RSS: Main: 214290432 06:20:52 INFO - PROCESS | 8021 | 06:20:55 INFO - PROCESS | 8021 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46114/tests/kraken/driver.html?testName=imaging-darkroom) 06:20:55 INFO - PROCESS | 8021 | RSS: Main: 252821504 06:20:55 INFO - PROCESS | 8021 | 06:20:59 INFO - PROCESS | 8021 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46114/tests/kraken/driver.html?testName=imaging-desaturate) 06:20:59 INFO - PROCESS | 8021 | RSS: Main: 251760640 06:20:59 INFO - PROCESS | 8021 | 06:21:02 INFO - PROCESS | 8021 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46114/tests/kraken/driver.html?testName=json-parse-financial) 06:21:03 INFO - PROCESS | 8021 | RSS: Main: 251961344 06:21:03 INFO - PROCESS | 8021 | 06:21:04 INFO - PROCESS | 8021 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46114/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:21:05 INFO - PROCESS | 8021 | RSS: Main: 214597632 06:21:05 INFO - PROCESS | 8021 | 06:21:06 INFO - PROCESS | 8021 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46114/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:21:07 INFO - PROCESS | 8021 | RSS: Main: 222195712 06:21:07 INFO - PROCESS | 8021 | 06:21:09 INFO - PROCESS | 8021 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46114/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:21:10 INFO - PROCESS | 8021 | RSS: Main: 222646272 06:21:10 INFO - PROCESS | 8021 | 06:21:12 INFO - PROCESS | 8021 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46114/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:21:13 INFO - PROCESS | 8021 | RSS: Main: 218349568 06:21:13 INFO - PROCESS | 8021 | 06:21:16 INFO - PROCESS | 8021 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46114/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:21:16 INFO - PROCESS | 8021 | RSS: Main: 221483008 06:21:16 INFO - PROCESS | 8021 | 06:21:18 INFO - PROCESS | 8021 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46114/tests/kraken/driver.html?testName=ai-astar) 06:21:18 INFO - PROCESS | 8021 | RSS: Main: 272277504 06:21:18 INFO - PROCESS | 8021 | 06:21:18 INFO - PROCESS | 8021 | __start_tp_report 06:21:18 INFO - PROCESS | 8021 | _x_x_mozilla_page_load 06:21:18 INFO - PROCESS | 8021 | _x_x_mozilla_page_load_details 06:21:18 INFO - PROCESS | 8021 | |i|pagename|runs| 06:21:18 INFO - PROCESS | 8021 | |0;ai-astar;114;113;129;113;112;113;112;115;113;114 06:21:18 INFO - PROCESS | 8021 | |1;audio-beat-detection;149;117;148;185;119;147;151;119;176;122 06:21:18 INFO - PROCESS | 8021 | |2;audio-dft;160;161;161;160;160;162;162;161;161;161 06:21:18 INFO - PROCESS | 8021 | |3;audio-fft;75;76;75;183;77;77;75;77;162;76 06:21:18 INFO - PROCESS | 8021 | |4;audio-oscillator;85;86;147;86;86;86;140;85;86;146 06:21:18 INFO - PROCESS | 8021 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 06:21:18 INFO - PROCESS | 8021 | |6;imaging-darkroom;146;156;146;147;145;147;145;147;146;146 06:21:18 INFO - PROCESS | 8021 | |7;imaging-desaturate;94;95;95;95;96;95;94;95;95;96 06:21:18 INFO - PROCESS | 8021 | |8;json-parse-financial;49;63;50;51;51;51;51;52;51;61 06:21:18 INFO - PROCESS | 8021 | |9;json-stringify-tinderbox;62;63;63;62;63;63;63;63;63;70 06:21:18 INFO - PROCESS | 8021 | |10;stanford-crypto-aes;79;81;79;80;85;79;78;79;82;79 06:21:18 INFO - PROCESS | 8021 | |11;stanford-crypto-ccm;127;124;130;135;133;125;127;123;144;125 06:21:18 INFO - PROCESS | 8021 | |12;stanford-crypto-pbkdf2;163;163;166;162;162;166;166;161;163;162 06:21:18 INFO - PROCESS | 8021 | |13;stanford-crypto-sha256-iterative;65;64;65;64;65;65;64;63;64;63 06:21:18 INFO - PROCESS | 8021 | __end_tp_report 06:21:18 INFO - PROCESS | 8021 | __start_cc_report 06:21:18 INFO - PROCESS | 8021 | _x_x_mozilla_cycle_collect,1725 06:21:18 INFO - PROCESS | 8021 | __end_cc_report 06:21:18 INFO - PROCESS | 8021 | __startTimestamp1472131278753__endTimestamp 06:21:18 INFO - PROCESS | 8021 | 06:21:18 INFO - PROCESS | 8021 | ------- Summary: start ------- 06:21:18 INFO - PROCESS | 8021 | Number of tests: 14 06:21:18 INFO - PROCESS | 8021 | 06:21:18 INFO - PROCESS | 8021 | [#0] ai-astar Cycles:10 Average:114.80 Median:113.50 stddev:5.07 (4.5%) stddev-sans-first:5.37 06:21:18 INFO - PROCESS | 8021 | Values: 114.0 113.0 129.0 113.0 112.0 113.0 112.0 115.0 113.0 114.0 06:21:18 INFO - PROCESS | 8021 | 06:21:18 INFO - PROCESS | 8021 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:148.50 stddev:24.18 (16.3%) stddev-sans-first:25.56 06:21:18 INFO - PROCESS | 8021 | Values: 149.0 117.0 148.0 185.0 119.0 147.0 151.0 119.0 176.0 122.0 06:21:18 INFO - PROCESS | 8021 | 06:21:18 INFO - PROCESS | 8021 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 06:21:18 INFO - PROCESS | 8021 | Values: 160.0 161.0 161.0 160.0 160.0 162.0 162.0 161.0 161.0 161.0 06:21:18 INFO - PROCESS | 8021 | 06:21:18 INFO - PROCESS | 8021 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.00 stddev:41.00 (53.9%) stddev-sans-first:42.82 06:21:18 INFO - PROCESS | 8021 | Values: 75.0 76.0 75.0 183.0 77.0 77.0 75.0 77.0 162.0 76.0 06:21:18 INFO - PROCESS | 8021 | 06:21:18 INFO - PROCESS | 8021 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:86.00 stddev:28.37 (33.0%) stddev-sans-first:29.31 06:21:18 INFO - PROCESS | 8021 | Values: 85.0 86.0 147.0 86.0 86.0 86.0 140.0 85.0 86.0 146.0 06:21:18 INFO - PROCESS | 8021 | 06:21:18 INFO - PROCESS | 8021 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 06:21:18 INFO - PROCESS | 8021 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 06:21:18 INFO - PROCESS | 8021 | 06:21:18 INFO - PROCESS | 8021 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:146.50 stddev:3.21 (2.2%) stddev-sans-first:3.38 06:21:18 INFO - PROCESS | 8021 | Values: 146.0 156.0 146.0 147.0 145.0 147.0 145.0 147.0 146.0 146.0 06:21:18 INFO - PROCESS | 8021 | 06:21:18 INFO - PROCESS | 8021 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 06:21:18 INFO - PROCESS | 8021 | Values: 94.0 95.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 96.0 06:21:18 INFO - PROCESS | 8021 | 06:21:18 INFO - PROCESS | 8021 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:51.00 stddev:4.83 (9.5%) stddev-sans-first:4.90 06:21:18 INFO - PROCESS | 8021 | Values: 49.0 63.0 50.0 51.0 51.0 51.0 51.0 52.0 51.0 61.0 06:21:18 INFO - PROCESS | 8021 | 06:21:18 INFO - PROCESS | 8021 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.00 stddev:2.32 (3.7%) stddev-sans-first:2.40 06:21:18 INFO - PROCESS | 8021 | Values: 62.0 63.0 63.0 62.0 63.0 63.0 63.0 63.0 63.0 70.0 06:21:18 INFO - PROCESS | 8021 | 06:21:18 INFO - PROCESS | 8021 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.50 stddev:2.08 (2.6%) stddev-sans-first:2.17 06:21:18 INFO - PROCESS | 8021 | Values: 79.0 81.0 79.0 80.0 85.0 79.0 78.0 79.0 82.0 79.0 06:21:18 INFO - PROCESS | 8021 | 06:21:18 INFO - PROCESS | 8021 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:128.50 stddev:6.48 (5.0%) stddev-sans-first:6.82 06:21:18 INFO - PROCESS | 8021 | Values: 127.0 124.0 130.0 135.0 133.0 125.0 127.0 123.0 144.0 125.0 06:21:18 INFO - PROCESS | 8021 | 06:21:18 INFO - PROCESS | 8021 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:163.00 stddev:1.90 (1.2%) stddev-sans-first:2.01 06:21:18 INFO - PROCESS | 8021 | Values: 163.0 163.0 166.0 162.0 162.0 166.0 166.0 161.0 163.0 162.0 06:21:18 INFO - PROCESS | 8021 | 06:21:18 INFO - PROCESS | 8021 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 06:21:18 INFO - PROCESS | 8021 | Values: 65.0 64.0 65.0 64.0 65.0 65.0 64.0 63.0 64.0 63.0 06:21:18 INFO - PROCESS | 8021 | -------- Summary: end -------- 06:21:18 INFO - PROCESS | 8021 | 06:21:19 INFO - TEST-INFO | 8021: exit 0 06:21:19 INFO - TEST-OK | kraken | took 63174ms 06:21:19 INFO - SUITE-END | took 1181s 06:21:20 INFO - Completed test suite (00:19:41) 06:21:20 INFO - javascript benchmark 06:21:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3013.563033360163, 3033.681463446338, 3034.4841376965915, 3074.446599612069, 3095.9845200773993, 5115.181570948649, 5173.715445650488, 5258.447862974385, 5285.841424757254, 5296.9735151324285, 5245.370555533342, 5265.289185959904, 5266.131088370424, 5315.548178404841, 5322.654027488211, 4686.297055441694, 4761.119192949298, 4783.545563171493, 4791.520847915198, 4964.925526117111, 4777.689450185727, 4811.230203167476, 4828.420589529243, 4843.951560484403, 4845.733484658343, 4730.716157030589, 4749.430068391781, 4764.166270902579, 4782.497837727058, 4783.210770222909, 4719.952800471986, 4731.077439899221, 4745.454272758608, 4826.155422800995, 4864.659473836833, 4734.715917044989, 4768.499307572724, 4776.379070720784, 4789.832355867528, 4835.758212089381, 5229.137192363255, 5243.423223445456, 5285.973570132163, 5358.624896257264, 5365.597580181502, 5646.520045796112, 5655.915161272585, 5664.0, 5672.092465205588, 5732.168835518826, 5616.831495055155, 5675.262215911946, 5679.233303504016, 5679.630823996427, 5686.3744988051285, 5159.17453207485, 5261.0, 5319.255304257407, 5325.440828712968, 5330.466953304638, 5770.567207459458, 5785.913211301834, 5795.217645617788, 5823.56323275756, 5859.882802343929, 5529.336479622471, 5529.861753456195, 5544.362398324244, 5546.611737178358, 5547.472990065938, 5475.288212532425, 5509.641873278224, 5545.528630066489, 5622.156676498558, 5632.436756324335, 5540.473655002768, 5543.972280138573, 5546.0, 5594.468525490072, 5618.634788738719, 5527.668339899619, 5562.694051827189, 5566.332040155207, 5567.3040869891265, 5571.860703482364, 4304.375865499485, 4307.203167413976, 4351.4995775485595, 4371.868843934687, 4406.1187762447635, 3930.292547341506, 3944.2703099926607, 3980.960190398117, 4008.1382502762044, 4027.033511957168, 5389.487998640123, 5400.864978375494, 5402.432744561843, 5403.13549832025, 5404.432534583891, 5538.224648549206, 5682.0, 5685.374608793029, 5690.886182276331, 5719.399463056402, 5411.242426060276, 5415.566754659618, 5450.073487507133, 5476.726163691799, 5476.945230547723, 4907.901841963141, 4924.778384972685, 4931.334269873521, 4936.308916751657, 4989.725565093955, 5588.217649529151, 5807.303123625023, 5913.763449461973, 5925.674087925206, 5928.3775203603, 5655.971720141373, 5729.3124825019595, 5740.0, 5763.567732420001, 5770.422957704196, 5836.708164591669, 5874.148248504029, 5879.5002424794375, 5883.735231914488, 5884.117382392504, 5531.806386776604, 5584.804531841366, 5591.692456914746, 5592.664440133605, 5598.440155984369, 5558.333000040021, 5637.605367624227, 5678.346990096192, 5707.20099186106, 5722.740996980658, 5510.448955104457, 5515.944840551543, 5518.668879867221, 5524.751386187711, 5527.309086364205, 5472.616916815944, 5509.889802204014, 5523.116301391919, 5524.281843360337, 5590.329160500766, 5316.2823018893505, 5462.235287059894, 5468.070428027166, 5488.4237155098135, 5615.578831587729, 5624.746886390204, 5634.211210430461, 5640.435956404327, 5640.717964101696, 5640.88718225625, 5312.601554883477, 5379.408265090915, 5517.503424691797, 5526.944730552643, 5528.336599608073], "value": 5218.239024454867, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.7902875935904, 596.2933923300889, 600.7747094839435, 603.5051257968468, 616.9475594574461, 32628.510572341405, 35454.468182977245, 35784.99999999997, 46771.766141169246, 47508.76245618776, 44305.77847110768, 44973.0, 45005.0, 45264.0, 45582.77208613961, 8663.740087797376, 8811.339149563777, 8826.514541700204, 8829.470231786081, 8831.690890818823, 8877.289816814638, 8937.240334571537, 8973.641054357819, 8977.730668079968, 8980.506072166028, 8914.554272286392, 8977.147171018743, 8982.955085224565, 8983.011868694439, 8985.595648195847, 8891.0, 8942.55287235639, 8959.552022398919, 8977.865332019992, 8988.865167022499, 8786.56067196644, 8851.424657397249, 8852.645894164225, 8854.645814167425, 8854.822903541957, 42802.35796463056, 43196.568034319884, 43204.35193472069, 43251.0, 43257.567424325985, 3661.1945372018113, 3814.389697648363, 3826.34952058148, 4042.6967977401814, 4221.535631080578, 32447.0, 32486.751324867324, 32957.0, 34603.653963460296, 34627.307453851034, 4266.57334266574, 4373.539537734095, 4438.755868427267, 4448.132614140244, 4478.081993191388, 334356.0, 336235.99999999756, 336259.0, 336529.0, 336589.0, 58460.41539584635, 58548.41451585515, 58937.0, 58971.0, 59111.704441477516, 36322.45516317258, 37193.62806371956, 37279.0, 39022.80488597596, 61124.69437652872, 17180.312787488612, 17341.0, 17343.566410839576, 17349.7397539037, 17353.2191051403, 13211.075224734368, 13291.136076155019, 13293.800592991112, 13323.0, 13329.466821327038, 18993.95533245657, 19012.809871901103, 19156.521086972658, 19175.0, 19195.0, 6829.965850170717, 7053.929460705327, 7107.680154393065, 7155.89266161008, 7395.26047395267, 947.7204224753714, 981.9803603927882, 1010.242318261304, 1017.2370721958531, 1035.782485678001, 32607.347853042807, 32714.345713085604, 32846.507302390484, 33122.66877331244, 33567.0, 1085.8914108589236, 1124.3534967393618, 1135.4549816088324, 1178.2105988987398, 1194.9342786146844, 16677.583060423345, 17293.827061729222, 17322.566935826704, 17381.87126317275, 17411.390601328894, 516885.0, 523945.0, 526239.0, 527011.0, 527307.0, 59022.40977590255, 59719.402805972255, 59730.70134649299, 59743.40256597378, 59813.0, 1222.8349172861729, 1303.328785675378, 1335.1788649980192, 1344.946202151903, 1356.382845805176, 31491.37017259596, 33843.0, 33858.0, 33977.0, 34260.314793704485, 50978.49021509737, 53814.73092634512, 55046.44953550574, 55246.0, 60362.39637603568, 471374.0, 475152.0, 478678.0, 479056.0, 479849.0, 35424.645753542136, 44009.55990440054, 44226.778866105466, 45188.092083884534, 45432.0, 46156.0, 48743.51256487532, 49132.26301605407, 49138.262926055424, 49588.50411495839, 40838.387424189255, 41631.58368416277, 42216.78891605522, 42959.48209063339, 43768.56231437772, 40722.38916416197, 41267.0, 42107.578924210364, 42688.78655606702, 43058.354124687525, 40557.39163912485, 42050.78974605107, 43165.05757240869, 43422.56577434185, 43478.78260608677, 33333.33333333271, 36860.63139368572, 37596.0, 37823.70468134408, 38237.808810955765, 28079.43841123125, 28328.43343133167, 28334.0, 28432.715672843005, 28497.715022849505], "value": 20430.56116688915, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.1154901471689, 400.3114642814358, 402.1253773043629, 405.3190639725261, 418.9099343641117, 13370.465181392732, 18610.720839187423, 20313.984300784956, 20368.722568260666, 21276.4680882978, 16173.43392981246, 19010.524736881584, 19570.412887613358, 19707.901460492678, 19850.90074549629, 5698.173764804101, 5896.852578685524, 5899.823005309848, 5899.911501327483, 5901.0, 5625.071863142576, 5757.913631295534, 5807.854803629901, 5827.912581311284, 5834.708264586775, 5824.097264923944, 5824.883502329951, 5844.473997340238, 5848.4736373726355, 5851.122331650244, 5638.407967163471, 5770.769169233267, 5812.0, 5852.619579727304, 5856.619319744203, 5184.403793563751, 5188.377394712621, 5191.6625419348, 5195.896082078375, 5198.116320225571, 24010.159644412535, 24418.755812441825, 24428.267151985292, 24490.63264051041, 24611.38471538208, 2350.3536527454917, 2514.208024472285, 2522.7225005249406, 2546.974530254692, 3078.507438809802, 10450.320729152581, 10790.136789056935, 10856.67429977094, 10939.890601093966, 11070.501827417786, 1940.5245714799964, 1974.131382191831, 2021.4238941901488, 2038.4903774056486, 2044.3049363216578, 87517.56241218753, 89653.0, 89696.0, 91214.0, 94524.99999999932, 11265.718357040976, 11447.313161210353, 11489.712757181138, 11549.249298795552, 11552.94223528877, 15881.920590397205, 15938.60153496172, 15981.840181598267, 16006.759898601531, 16010.9199454002, 8090.797730056678, 8308.003039635161, 8323.084460709317, 8491.61787719554, 8559.614817333235, 7941.285284324323, 8009.118996910335, 8213.95893020531, 8241.340692744567, 8305.211004954519, 4468.285074388083, 4580.198465268565, 4642.698224615389, 4777.522247775195, 4838.975805120952, 2009.1360714892444, 2035.8574899756875, 2043.867148635334, 2063.102550390585, 2064.917403303851, 941.355171707369, 999.9250056245811, 1029.696239609317, 1107.2636696596835, 1116.0736588631578, 19846.20615175377, 20170.0, 20183.798162018193, 20347.69478457824, 20882.164713411294, 965.6234068713208, 992.4442312305132, 998.6354980432235, 1019.3119644240109, 1079.8704155501391, 10671.25301228922, 11272.745450909686, 11307.604233851776, 11402.486888090056, 11507.424628768527, 518428.0, 519572.0, 521192.1258110656, 523954.0, 527089.0, 60014.0, 62446.37553624497, 95538.5223073894, 96864.51567742116, 99021.50489247651, 1006.1347241372561, 1014.0771897573173, 1028.6554004408606, 1029.5469993203117, 1049.5696764326742, 17308.394206202724, 17719.73420398721, 17955.82044179594, 18731.90634046821, 18925.716114258023, 32115.518267225543, 33596.0, 43560.0, 44107.338389923534, 45019.09961800811, 57585.0, 59108.40891591029, 59435.40564594472, 60853.69573152283, 61380.386196137464, 8625.827483450421, 8891.73324800257, 9192.816143677222, 9274.582643781181, 9401.153896149379, 12970.156939798882, 13254.734905302033, 13643.317834108453, 13731.519396821062, 14267.286635668383, 11807.350595717318, 11995.460204290654, 12092.45583948742, 12101.0, 12247.938760306142, 11753.883381078784, 12052.819207712068, 12172.391380430767, 12239.32683702405, 12298.877011230132, 11991.64025079249, 12175.086868484723, 12229.571964981184, 12279.754404911673, 12762.872371276168, 7831.216878312123, 8918.24194943437, 8950.225026539707, 9102.362834601514, 9139.634414623606, 11242.606508772154, 11779.411029448322, 11911.583094591648, 11931.403429828648, 12131.393430328271], "value": 9451.982485674056, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.05316172356, 1462.3931068606526, 1484.814398200225, 1605.1893793634213, 1714.6313542588348, 8288.502689838606, 8624.13758624138, 8648.30813534918, 8875.467471951688, 8895.644174233023, 8749.825003499926, 8830.381873268874, 8856.335774816882, 8859.734207973772, 8862.955685221581, 2371.7509661485556, 2394.0423830467867, 2397.700287464067, 2399.4961058177805, 2400.31590996566, 2397.6283676030243, 2424.830261881669, 2471.3450935502105, 2475.962860557093, 2476.2942561370014, 2387.462820865309, 2396.604560247557, 2421.4188594737225, 2430.404550885036, 2433.051110067075, 2337.520808234308, 2339.333290012347, 2342.0280583557887, 2355.7290911545133, 2385.3440303916386, 2323.268170526279, 2342.976570234293, 2345.906163753448, 2346.5424242272766, 2348.1077190667606, 8768.605412756442, 8849.336299777478, 8895.822083558358, 8909.732708018704, 8955.507447090407, 5281.313429254211, 5555.611107222496, 5564.387917329091, 5568.3596386415675, 5574.693391863446, 3627.4740162676526, 3644.0, 3693.445983102556, 3700.5744339401044, 3709.3879509880835, 1208.3897631696025, 1231.6612931443835, 1235.8269842222096, 1256.3341429042623, 1258.1130303136267, 12551.623451296384, 12637.873621263761, 12660.746785064248, 12694.619161425171, 12700.682482937907, 4422.204003279377, 4536.092781443725, 4715.151272770934, 4716.95283047172, 4718.764061796896, 9969.451680157516, 9982.05170508815, 10000.3499772516, 10005.0, 10006.149477294366, 5344.091504444254, 5405.4324295949145, 5414.810481633124, 5415.079436495806, 5416.241726158341, 3982.2234664240195, 4318.460192475941, 4449.844255451108, 5010.874728131753, 5043.193089105725, 3810.847566097325, 3812.790296533717, 3926.9018274542796, 3926.960730392717, 3937.940930886039, 1146.6158836789768, 1148.121686909515, 1148.6955956671488, 1151.2977083978767, 1166.1545379599722, 885.3404213860715, 912.32943786317, 955.2262667239559, 997.6458357283205, 1020.6835880876952, 5759.971200143972, 6092.634441933498, 6195.566310358232, 6403.519736019817, 6408.807735767934, 943.2783920300975, 950.3964982236191, 969.9515024248759, 987.5457289646699, 1017.7710015246511, 3928.626780455852, 4284.228838809045, 4327.56724327571, 4438.378626992224, 4530.184566778012, 10869.782604347869, 11350.318980861175, 11387.259828111146, 11676.182667213214, 11695.707607309716, 11478.59824906141, 11551.88448115508, 11595.130365222474, 11596.884031159749, 11609.071274298036, 8246.670133194724, 8424.368172386972, 8456.0, 8456.534890580953, 8461.407701460961, 6093.2078829751845, 6190.164327815687, 6265.874682506415, 6277.497800176066, 6373.521985851173, 10258.487075646337, 10295.691129266133, 10404.68785936423, 10416.687499375032, 10526.473676316307, 8484.745457636282, 10611.575536978435, 10783.299085559414, 10864.130869530576, 10876.619318323821, 7980.720674776355, 8179.182081791773, 8377.371697122862, 8378.832423351621, 8387.664493420194, 8353.0, 8672.523011234443, 8735.694250701195, 8908.643654253758, 8966.86549701742, 7705.483702802805, 7706.152323244551, 7765.301122898966, 7801.9609901950125, 8032.357411406956, 7562.886556701764, 7619.542827430372, 7675.385969122569, 7731.420143489148, 7748.728794492165, 7319.048523691886, 7326.487145899736, 7367.115946086504, 7402.407807375289, 7405.703771849281, 5140.408852981955, 5167.870803229949, 5218.112920803396, 5245.318108645852, 5288.2860813791185, 5164.1995490699, 5251.711155886463, 5358.223057656696, 5403.945960540502, 5426.186072089218], "value": 4737.680742902337, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.83164399766355, 342.16341046142185, 343.79200583646895, 351.4991137628878, 352.9911752206196, 5033.9428719968755, 5141.640085194038, 5212.452692467293, 5269.445513573495, 5283.762230699618, 5132.28148059272, 5141.897162056756, 5154.561862241714, 5169.353830771153, 5183.559397451212, 4095.8361665533344, 4101.323281658522, 4105.384192371138, 4109.773962432065, 4119.361498967664, 3925.862594809182, 4056.574059723716, 4107.363358679395, 4115.8765237042935, 4126.195391898581, 4020.0753826619894, 4026.1746341999965, 4028.5769994150633, 4031.0930040740745, 4033.1731994940965, 4030.7581545107387, 4030.7706149624355, 4047.4738284023183, 4053.391991201314, 4056.918861622751, 3591.479235510836, 3614.204874927512, 3622.4023036198996, 3629.1471504196493, 3632.237230181665, 4960.0, 4967.031428871372, 5012.423571289275, 5018.222175562757, 5048.268001139851, 4594.701344412636, 4602.217623004098, 4616.607588354994, 4618.861434156981, 4619.74591397473, 5354.500739792864, 5370.785168593252, 5371.92561487704, 5393.1370980643305, 5402.837914862561, 3865.5168103987003, 3898.142408670088, 3924.1955399143108, 3924.5682974872743, 3929.764214147132, 5532.040358408272, 5553.029583847569, 5568.777248910039, 5584.0507113790345, 5594.244776955059, 4004.7196696230985, 4016.4376987221813, 4024.8390064397095, 4026.4362989181536, 4042.6159514846045, 3921.509811273591, 4040.3535434330365, 4060.26915155269, 4086.2236175127227, 4103.845481122435, 4575.428071491064, 4580.106879158532, 4584.908301833944, 4593.724376537419, 4640.9535904640525, 5366.463353664602, 5375.301210842644, 5385.542228910586, 5404.3784964728775, 5459.153831156098, 1294.5598496511232, 1335.4524644895546, 1361.4826365980864, 1363.8840698540735, 1366.2827015816777, 874.2044739287218, 891.3270480787094, 910.1581037540249, 916.1159481100769, 922.7093465558328, 4581.335706322565, 4621.514740952219, 4639.768011599406, 4653.371794807726, 4674.831292176956, 4887.437944636341, 4899.0, 4899.476769463729, 4906.852794416173, 4930.457649658535, 4530.705504142286, 4554.476235232991, 4580.267157254823, 4597.241455159928, 4600.366869761254, 2720.4695084458735, 2925.473414785359, 2947.410517896429, 2950.9376624415195, 2952.6752057273684, 5725.971370143123, 5758.884822303614, 5770.942290577041, 5794.478496935296, 5819.214406055213, 5523.613347065667, 5644.689542075225, 5671.716414179357, 5716.228309178291, 5725.539987303211, 5729.083346664514, 5738.8278351649515, 5741.282339707536, 5745.724936786075, 5757.740901659436, 5524.861878453071, 5536.0, 5577.191307260344, 5582.901489673271, 5583.804566840141, 5251.684898906078, 5451.373092094302, 5482.533984611353, 5482.547125011795, 5542.3349198094875, 5719.199312096393, 5750.281214848144, 5762.876239133328, 5773.026891151145, 5802.50678692299, 3933.370660694275, 4109.363048727452, 4131.215069136854, 4149.771762552968, 4170.979145104255, 5282.207668849704, 5526.50261476469, 5538.584606154635, 5553.6390134641115, 5559.138333558305, 5229.294045303987, 5344.706041167773, 5369.27514785499, 5384.488473595002, 5435.592330575144, 5385.596080294072, 5406.378266499246, 5417.458254174551, 5422.891542169055, 5431.34823821144, 5210.0722732587665, 5281.815136470205, 5339.279197308314, 5361.892762144813, 5367.0, 5396.4333744957785, 5407.648502847303, 5415.783368665209, 5431.83704488866, 5433.483819037185, 5319.308489896289, 5327.573794096541, 5341.41244463101, 5354.464553544614, 5384.407715151408], "value": 4103.73851870014, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.6449051191197, 785.7249962513117, 822.0300045945785, 852.5907564369105, 862.8835107260518, 15386.0, 16857.578560535992, 16876.324947002104, 16891.746623800624, 16988.235529401176, 15280.0, 15384.923075384635, 15401.075935443881, 15422.383104675799, 15439.305231264592, 641.9711112999926, 787.9645415956267, 789.6643926331301, 802.077610747639, 803.7026300268909, 800.2077942836609, 804.5816175588691, 809.6275713171948, 810.027966440271, 810.2586133687698, 859.8108416148438, 861.0571424290392, 861.6036623153357, 862.65062649627, 862.9395942284043, 675.0818886314609, 819.2299238715589, 855.324293807891, 856.1395797223781, 857.4340934982913, 620.0, 625.0343219725535, 625.5089754542662, 626.1922120464595, 627.9026750853625, 15773.290201940825, 15826.920865395714, 15829.44596939113, 15845.366185352572, 15856.603584910354, 14365.13809171453, 14503.854961450355, 14813.333399996918, 14910.478133265284, 15039.0, 13158.736825263537, 13169.275689837055, 13207.88673812195, 13554.93222533881, 13719.588412347646, 4410.4707435107675, 4577.427821522309, 4579.862604121881, 4673.462551806551, 4699.929501057487, 83161.0, 83503.5824820878, 84507.5774621123, 85348.57325713393, 85452.57273713591, 10768.515416806262, 10805.945970270099, 10886.29239099456, 10987.945060274647, 11060.059894908862, 19240.807591924182, 19396.0, 19460.70808937867, 19481.220751169796, 19494.415167544998, 8642.22220000203, 8687.174718401742, 8689.869651955225, 8706.695265665798, 9006.549672516348, 4655.534446555317, 4696.131215725101, 4842.830500932521, 4862.95137048632, 4923.138450771173, 3381.2223188666253, 3575.3564358415733, 3583.7312201584987, 3586.497890295361, 3592.5688917329567, 630.1052505442283, 634.0615888485067, 634.8159033880215, 636.1539152926597, 638.7476946606157, 654.2802916791492, 656.6388486332498, 666.1340257665016, 678.4572342126279, 693.4798900824381, 8626.784330391665, 9130.634774609074, 9294.488803115759, 9446.85829712555, 9491.430514169171, 613.2273335597091, 642.7268410925432, 649.9155109835785, 664.7008846019311, 681.6489507903434, 4334.349847522897, 4507.684462087688, 4552.11233809404, 4560.68075234737, 4609.861704148881, 127986.36006820093, 128551.0, 128554.35722821513, 130312.3484382591, 131352.3432382832, 30864.228394289872, 48018.75990620025, 67174.0, 86889.0, 97213.0, 55864.720676396355, 57315.71342143263, 61319.0, 67074.0, 72936.99999999894, 8919.331050171133, 9260.159295370891, 9532.618695252113, 9616.423014619146, 9651.276154288316, 50904.74547627238, 50998.74500627473, 51710.74144629253, 52933.47066529439, 53888.0, 73728.0, 75575.24424755682, 76494.23505764871, 78305.21694782979, 79961.20038799537, 13317.66705832362, 13319.600411987656, 13504.392302346221, 13600.523981660594, 13777.140086088652, 14866.714268713331, 14936.925315373353, 15155.924220378827, 15456.381744730084, 15558.533244002698, 13924.443022278996, 13975.30123493801, 14472.0, 14588.781168282696, 14925.850741492446, 13572.592822215349, 13999.16005039701, 14132.445431002376, 14596.270186490845, 14703.92648036753, 13658.863411365759, 13753.449862005808, 14037.438502459787, 14488.710225795214, 14776.926115369355, 10062.446565438971, 10821.513031913426, 11442.0, 11542.94228528852, 11874.76250475003, 11804.409779511161, 12197.695057623276, 12358.752824943631, 12405.875941240472, 12414.751704966031], "value": 7550.666083020041, "unit": "score"}], "name": "dromaeo_css", "value": 7272.5074196856895, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 129.0, 113.0, 112.0, 113.0, 112.0, 115.0, 113.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 148.0, 185.0, 119.0, 147.0, 151.0, 119.0, 176.0, 122.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 160.0, 162.0, 162.0, 161.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 183.0, 77.0, 77.0, 75.0, 77.0, 162.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 147.0, 86.0, 86.0, 86.0, 140.0, 85.0, 86.0, 146.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 156.0, 146.0, 147.0, 145.0, 147.0, 145.0, 147.0, 146.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 96.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 63.0, 50.0, 51.0, 51.0, 51.0, 51.0, 52.0, 51.0, 61.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 70.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 79.0, 80.0, 85.0, 79.0, 78.0, 79.0, 82.0, 79.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 124.0, 130.0, 135.0, 133.0, 125.0, 127.0, 123.0, 144.0, 125.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 166.0, 162.0, 162.0, 166.0, 166.0, 161.0, 163.0, 162.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 63.0, 64.0, 63.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1530.1999999999998, "alertThreshold": 2.0}]} 06:21:20 INFO - Return code: 0 06:21:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:21:20 INFO - # TBPL SUCCESS # 06:21:20 INFO - Running post-action listener: _resource_record_post_action 06:21:20 INFO - [mozharness: 2016-08-25 13:21:20.582045Z] Finished run-tests step (success) 06:21:20 INFO - Running post-run listener: _resource_record_post_run 06:21:20 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 419405824; Read time: 8; Write time: 997488 06:21:20 INFO - TinderboxPrint: CPU usage
13.1% 06:21:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 06:21:20 INFO - TinderboxPrint: I/O write bytes / time
419,405,824 / 997,488 06:21:20 INFO - TinderboxPrint: CPU idle
8,307.4 (86.8%) 06:21:20 INFO - TinderboxPrint: CPU user
1,197.7 (12.5%) 06:21:20 INFO - TinderboxPrint: Swap in / out
0 / 0 06:21:20 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 118173696; Read time: 0; Write time: 383488 06:21:20 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288186368; Read time: 8; Write time: 600852 06:21:21 INFO - Running post-run listener: _upload_blobber_files 06:21:21 INFO - Blob upload gear active. 06:21:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:21:21 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 06:21:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:21:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:21:21 INFO - (blobuploader) - INFO - Open directory for files ... 06:21:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:21:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:21:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:25 INFO - (blobuploader) - INFO - Done attempting. 06:21:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:21:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:21:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:25 INFO - (blobuploader) - INFO - Done attempting. 06:21:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:21:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:21:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:26 INFO - (blobuploader) - INFO - Done attempting. 06:21:26 INFO - (blobuploader) - INFO - Iteration through files over. 06:21:26 INFO - Return code: 0 06:21:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:21:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:21:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1812c1b3d144b2ca60678e25cdbb1b05bd3b73b5da5ec2d25c45d92418fbb1a6d5608c996ea04b5310543c1fc2a8e4617bd1e975989ca730e83ca8ad242bd575", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e95df9438059d81b337f57186b9e9d5948f0766806ad03bf284cfd1545bf90d970dc217e9624d1aa475f881d6a738b581c0e025953628f25fb6885390451df8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07cb8c52099134cbc0b1297e96a52f1724762ac97521589f2dc9f3125f3460a0806d9096759b45a4aa48864f1db118791fbe703b150c0a6f04e912e5b3d5ee41"} 06:21:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:21:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:21:26 INFO - Contents: 06:21:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1812c1b3d144b2ca60678e25cdbb1b05bd3b73b5da5ec2d25c45d92418fbb1a6d5608c996ea04b5310543c1fc2a8e4617bd1e975989ca730e83ca8ad242bd575", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e95df9438059d81b337f57186b9e9d5948f0766806ad03bf284cfd1545bf90d970dc217e9624d1aa475f881d6a738b581c0e025953628f25fb6885390451df8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07cb8c52099134cbc0b1297e96a52f1724762ac97521589f2dc9f3125f3460a0806d9096759b45a4aa48864f1db118791fbe703b150c0a6f04e912e5b3d5ee41"} 06:21:26 INFO - Running post-run listener: copy_logs_to_upload_dir 06:21:26 INFO - Copying logs to upload dir... 06:21:26 INFO - mkdir: /builds/slave/test/build/upload/logs 06:21:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.206830 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-25 06:21:26.263682) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 06:21:26.270542) ========= 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-1472129719.611276-2088958186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1812c1b3d144b2ca60678e25cdbb1b05bd3b73b5da5ec2d25c45d92418fbb1a6d5608c996ea04b5310543c1fc2a8e4617bd1e975989ca730e83ca8ad242bd575", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e95df9438059d81b337f57186b9e9d5948f0766806ad03bf284cfd1545bf90d970dc217e9624d1aa475f881d6a738b581c0e025953628f25fb6885390451df8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07cb8c52099134cbc0b1297e96a52f1724762ac97521589f2dc9f3125f3460a0806d9096759b45a4aa48864f1db118791fbe703b150c0a6f04e912e5b3d5ee41"} build_url:https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/BVuYlShmRDquKwNK3CqArA/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/sha512/1812c1b3d144b2ca60678e25cdbb1b05bd3b73b5da5ec2d25c45d92418fbb1a6d5608c996ea04b5310543c1fc2a8e4617bd1e975989ca730e83ca8ad242bd575", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e95df9438059d81b337f57186b9e9d5948f0766806ad03bf284cfd1545bf90d970dc217e9624d1aa475f881d6a738b581c0e025953628f25fb6885390451df8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07cb8c52099134cbc0b1297e96a52f1724762ac97521589f2dc9f3125f3460a0806d9096759b45a4aa48864f1db118791fbe703b150c0a6f04e912e5b3d5ee41"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 06:21:26.295027) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 06:21:26.295367) ========= 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-1472129719.611276-2088958186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 06:21:26.381372) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 06:21:26.381683) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 06:21:26.381982) ========= ========= Total master_lag: 0.19 =========