builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1472596764.44 results: success (0) buildid: 20160830142820 builduid: 37cdf555d4314cac82640a5f5a9c5051 revision: fa6f91ffb4965302f316635e91d456c8103e08c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 15:39:24.444244) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 15:39:24.444663) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 15:39:24.444956) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 15:39:24.481209) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 15:39:24.481457) ========= 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=31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 15:39:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.2M=0s 2016-08-30 15:39:24 (70.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118620 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 15:39:24.617454) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 15:39:24.617743) ========= 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=31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016060 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 15:39:24.675554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 15:39:24.675875) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fa6f91ffb4965302f316635e91d456c8103e08c2 --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 fa6f91ffb4965302f316635e91d456c8103e08c2 --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=31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 15:39:24,899 truncating revision to first 12 chars 2016-08-30 15:39:24,899 Setting DEBUG logging. 2016-08-30 15:39:24,899 attempt 1/10 2016-08-30 15:39:24,899 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fa6f91ffb496?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 15:39:25,186 unpacking tar archive at: mozilla-central-fa6f91ffb496/testing/mozharness/ program finished with exit code 0 elapsedTime=0.623516 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 15:39:25.316607) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 15:39:25.316875) ========= script_repo_revision: fa6f91ffb4965302f316635e91d456c8103e08c2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 15:39:25.317253) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 15:39:25.317528) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 15:39:25.328196) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-30 15:39:25.328474) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:39:25 INFO - MultiFileLogger online at 20160830 15:39:25 in /builds/slave/test 15:39:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:39:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:39:25 INFO - {'append_to_log': False, 15:39:25 INFO - 'base_work_dir': '/builds/slave/test', 15:39:25 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:39:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:39:25 INFO - 'branch': 'Firefox-Non-PGO', 15:39:25 INFO - 'buildbot_json_path': 'buildprops.json', 15:39:25 INFO - 'config_files': ('talos/linux_config.py',), 15:39:25 INFO - 'default_actions': ('clobber', 15:39:25 INFO - 'read-buildbot-config', 15:39:25 INFO - 'download-and-extract', 15:39:25 INFO - 'populate-webroot', 15:39:25 INFO - 'create-virtualenv', 15:39:25 INFO - 'install', 15:39:25 INFO - 'run-tests'), 15:39:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:39:25 INFO - 'download_minidump_stackwalk': True, 15:39:25 INFO - 'download_symbols': 'ondemand', 15:39:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:39:25 INFO - 'tooltool.py': '/tools/tooltool.py', 15:39:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:39:25 INFO - '/tools/misc-python/virtualenv.py')}, 15:39:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:39:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:39:25 INFO - 'installer_path': 'installer.exe', 15:39:25 INFO - 'log_level': 'info', 15:39:25 INFO - 'log_name': 'talos', 15:39:25 INFO - 'log_to_console': True, 15:39:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:39:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:39:25 INFO - 'opt_config_files': (), 15:39:25 INFO - 'pip_index': False, 15:39:25 INFO - 'sps_profile': False, 15:39:25 INFO - 'sps_profile_interval': 0, 15:39:25 INFO - 'suite': 'dromaeojs', 15:39:25 INFO - 'system_bits': '32', 15:39:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:39:25 INFO - 'title': 'talos-linux64-ix-014', 15:39:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:39:25 INFO - 'use_talos_json': True, 15:39:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:39:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:39:25 INFO - 'work_dir': 'build'} 15:39:25 INFO - [mozharness: 2016-08-30 22:39:25.647089Z] Running clobber step. 15:39:25 INFO - Running pre-action listener: _resource_record_pre_action 15:39:25 INFO - Running main action method: clobber 15:39:25 INFO - rmtree: /builds/slave/test/build 15:39:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:39:26 INFO - Running post-action listener: _resource_record_post_action 15:39:26 INFO - [mozharness: 2016-08-30 22:39:26.616545Z] Finished clobber step (success) 15:39:26 INFO - [mozharness: 2016-08-30 22:39:26.616647Z] Running read-buildbot-config step. 15:39:26 INFO - Running pre-action listener: _resource_record_pre_action 15:39:26 INFO - Running main action method: read_buildbot_config 15:39:26 INFO - Using buildbot properties: 15:39:26 INFO - { 15:39:26 INFO - "project": "", 15:39:26 INFO - "product": "firefox", 15:39:26 INFO - "script_repo_revision": "production", 15:39:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:39:26 INFO - "repository": "", 15:39:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:39:26 INFO - "buildid": "20160830142820", 15:39:26 INFO - "pgo_build": "False", 15:39:26 INFO - "basedir": "/builds/slave/test", 15:39:26 INFO - "buildnumber": 195, 15:39:26 INFO - "slavename": "talos-linux64-ix-014", 15:39:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:39:26 INFO - "platform": "ubuntu64_hw", 15:39:26 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:39:26 INFO - "branch": "mozilla-central", 15:39:26 INFO - "repo_path": "mozilla-central", 15:39:26 INFO - "revision": "fa6f91ffb4965302f316635e91d456c8103e08c2", 15:39:26 INFO - "stage_platform": "linux64", 15:39:26 INFO - "builduid": "37cdf555d4314cac82640a5f5a9c5051", 15:39:26 INFO - "slavebuilddir": "test" 15:39:26 INFO - } 15:39:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:39:26 INFO - Running post-action listener: _resource_record_post_action 15:39:26 INFO - [mozharness: 2016-08-30 22:39:26.619736Z] Finished read-buildbot-config step (success) 15:39:26 INFO - [mozharness: 2016-08-30 22:39:26.619827Z] Running download-and-extract step. 15:39:26 INFO - Running pre-action listener: _resource_record_pre_action 15:39:26 INFO - Running main action method: download_and_extract 15:39:26 INFO - mkdir: /builds/slave/test/build/tests 15:39:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:26 INFO - trying https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:39:26 INFO - Downloading https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/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 15:39:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/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 15:39:27 INFO - Downloaded 1361 bytes. 15:39:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:39:27 INFO - Using the following test package requirements: 15:39:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:39:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:39:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:39:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:27 INFO - u'jsshell-linux-x86_64.zip'], 15:39:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:39:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:39:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:39:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:39:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:39:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:39:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:27 INFO - trying https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:39:27 INFO - Downloading https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/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 15:39:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/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 15:39:28 INFO - Downloaded 20315391 bytes. 15:39:28 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 15:39:32 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 15:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:32 INFO - trying https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:39:32 INFO - Downloading https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/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 15:39:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/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 15:39:33 INFO - Downloaded 20315391 bytes. 15:39:33 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 15:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:37 INFO - trying https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:39:37 INFO - Downloading https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/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 15:39:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/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 15:39:38 INFO - Downloaded 14413998 bytes. 15:39:38 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 15:39: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')]} 15:39:38 INFO - trying https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:39:38 INFO - Downloading https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/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 15:39:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/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 15:39:40 INFO - Downloaded 55852782 bytes. 15:39:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:39:40 INFO - mkdir: /builds/slave/test/properties 15:39:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:39:40 INFO - Writing to file /builds/slave/test/properties/build_url 15:39:40 INFO - Contents: 15:39:40 INFO - build_url:https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:39:40 INFO - Running post-action listener: _resource_record_post_action 15:39:40 INFO - Running post-action listener: set_extra_try_arguments 15:39:40 INFO - [mozharness: 2016-08-30 22:39:40.762545Z] Finished download-and-extract step (success) 15:39:40 INFO - [mozharness: 2016-08-30 22:39:40.762771Z] Running populate-webroot step. 15:39:40 INFO - Running pre-action listener: _resource_record_pre_action 15:39:40 INFO - Running main action method: populate_webroot 15:39:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:39:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:39:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:39:40 INFO - '--tppagecycles', 15:39:40 INFO - '7'], 15:39:40 INFO - 'tests': ['tsvgm']}}, 15:39:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:39:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:39:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:39:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:39:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:39:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:39:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:40 INFO - 'talos_options': ['--disable-e10s'], 15:39:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:40 INFO - 'talos_options': ['--disable-e10s'], 15:39:40 INFO - 'tests': ['damp', 'tps']}, 15:39:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:40 INFO - 'tests': ['damp', 'tps']}, 15:39:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:39:40 INFO - 'tests': ['dromaeo_dom']}, 15:39:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:39:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:39:40 INFO - 'tests': ['basic_compositor_video']}, 15:39:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:39:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:39:40 INFO - 'tests': ['a11yr', 15:39:40 INFO - 'ts_paint', 15:39:40 INFO - 'tpaint', 15:39:40 INFO - 'sessionrestore', 15:39:40 INFO - 'sessionrestore_no_auto_restore', 15:39:40 INFO - 'tabpaint']}, 15:39:40 INFO - 'other-e10s': {'tests': ['a11yr', 15:39:40 INFO - 'ts_paint', 15:39:40 INFO - 'tpaint', 15:39:40 INFO - 'sessionrestore', 15:39:40 INFO - 'sessionrestore_no_auto_restore', 15:39:40 INFO - 'tabpaint']}, 15:39:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:39:40 INFO - 'ts_paint', 15:39:40 INFO - 'tpaint', 15:39:40 INFO - 'sessionrestore', 15:39:40 INFO - 'sessionrestore_no_auto_restore', 15:39:40 INFO - 'tabpaint']}, 15:39:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:39:40 INFO - 'ts_paint', 15:39:40 INFO - 'tpaint', 15:39:40 INFO - 'sessionrestore', 15:39:40 INFO - 'sessionrestore_no_auto_restore', 15:39:40 INFO - 'tabpaint']}, 15:39:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:39:40 INFO - 'tests': ['a11yr', 15:39:40 INFO - 'ts_paint', 15:39:40 INFO - 'tpaint', 15:39:40 INFO - 'sessionrestore', 15:39:40 INFO - 'sessionrestore_no_auto_restore', 15:39:40 INFO - 'tabpaint']}, 15:39:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:39:40 INFO - 'tests': ['a11yr', 15:39:40 INFO - 'ts_paint', 15:39:40 INFO - 'tpaint', 15:39:40 INFO - 'sessionrestore', 15:39:40 INFO - 'sessionrestore_no_auto_restore', 15:39:40 INFO - 'tabpaint']}, 15:39:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:39:40 INFO - 'tests': ['tsvgx', 15:39:40 INFO - 'tsvgr_opacity', 15:39:40 INFO - 'tart', 15:39:40 INFO - 'tscrollx', 15:39:40 INFO - 'cart']}, 15:39:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:39:40 INFO - 'tsvgr_opacity', 15:39:40 INFO - 'tart', 15:39:40 INFO - 'tscrollx', 15:39:40 INFO - 'cart']}, 15:39:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:40 INFO - 'talos_options': ['--disable-e10s'], 15:39:40 INFO - 'tests': ['tp5o']}, 15:39:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:40 INFO - 'tests': ['tp5o']}, 15:39:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:40 INFO - 'talos_options': ['--disable-e10s', 15:39:40 INFO - '--xperf_path', 15:39:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:40 INFO - 'tests': ['tp5n']}, 15:39:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:40 INFO - 'talos_options': ['--xperf_path', 15:39:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:40 INFO - 'tests': ['tp5n']}}, 15:39:40 INFO - 'talos.zip': {'path': '', 15:39:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:39:40 INFO - Running post-action listener: _resource_record_post_action 15:39:40 INFO - [mozharness: 2016-08-30 22:39:40.785178Z] Finished populate-webroot step (success) 15:39:40 INFO - [mozharness: 2016-08-30 22:39:40.785268Z] Running create-virtualenv step. 15:39:40 INFO - Running pre-action listener: _resource_record_pre_action 15:39:40 INFO - Running main action method: create_virtualenv 15:39:40 INFO - Creating virtualenv /builds/slave/test/build/venv 15:39:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:39:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:39:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:39:40 INFO - Using real prefix '/usr' 15:39:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:39:41 INFO - Installing distribute.............................................................................................................................................................................................done. 15:39:43 INFO - Installing pip.................done. 15:39:43 INFO - Return code: 0 15:39:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:39: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')]} 15:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39: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')]} 15:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7b8d88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef090>, '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 0x28f29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:39:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:39:43 INFO - Using env: {'DISPLAY': ':0', 15:39:43 INFO - 'HOME': '/home/cltbld', 15:39:43 INFO - 'LANG': 'en_US.UTF-8', 15:39:43 INFO - 'LANGUAGE': 'en_US:en', 15:39:43 INFO - 'LOGNAME': 'cltbld', 15:39:43 INFO - 'MAIL': '/var/mail/cltbld', 15:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:43 INFO - 'MOZ_NO_REMOTE': '1', 15:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:43 INFO - 'NO_EM_RESTART': '1', 15:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:43 INFO - 'PWD': '/builds/slave/test', 15:39:43 INFO - 'SHELL': '/bin/bash', 15:39:43 INFO - 'SHLVL': '1', 15:39:43 INFO - 'TERM': 'linux', 15:39:43 INFO - 'TMOUT': '86400', 15:39:43 INFO - 'USER': 'cltbld', 15:39:43 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 15:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:43 INFO - '_': '/tools/buildbot/bin/python'} 15:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:39:43 INFO - Cleaning up... 15:39:43 INFO - Return code: 0 15:39:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:39: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')]} 15:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39: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')]} 15:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7b8d88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef090>, '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 0x28f29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:39:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:39:43 INFO - Using env: {'DISPLAY': ':0', 15:39:43 INFO - 'HOME': '/home/cltbld', 15:39:43 INFO - 'LANG': 'en_US.UTF-8', 15:39:43 INFO - 'LANGUAGE': 'en_US:en', 15:39:43 INFO - 'LOGNAME': 'cltbld', 15:39:43 INFO - 'MAIL': '/var/mail/cltbld', 15:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:43 INFO - 'MOZ_NO_REMOTE': '1', 15:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:43 INFO - 'NO_EM_RESTART': '1', 15:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:43 INFO - 'PWD': '/builds/slave/test', 15:39:43 INFO - 'SHELL': '/bin/bash', 15:39:43 INFO - 'SHLVL': '1', 15:39:43 INFO - 'TERM': 'linux', 15:39:43 INFO - 'TMOUT': '86400', 15:39:43 INFO - 'USER': 'cltbld', 15:39:43 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 15:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:43 INFO - '_': '/tools/buildbot/bin/python'} 15:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:43 INFO - Downloading/unpacking psutil>=3.1.1 15:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:39:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:39:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:45 INFO - Installing collected packages: psutil 15:39:45 INFO - Running setup.py install for psutil 15:39:45 INFO - building 'psutil._psutil_linux' extension 15:39:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:39:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:39:46 INFO - building 'psutil._psutil_posix' extension 15:39:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:39:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:39:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:39:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:46 INFO - Successfully installed psutil 15:39:46 INFO - Cleaning up... 15:39:46 INFO - Return code: 0 15:39:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:46 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 0x7f7b8d88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef090>, '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 0x28f29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:39:46 INFO - Using env: {'DISPLAY': ':0', 15:39:46 INFO - 'HOME': '/home/cltbld', 15:39:46 INFO - 'LANG': 'en_US.UTF-8', 15:39:46 INFO - 'LANGUAGE': 'en_US:en', 15:39:46 INFO - 'LOGNAME': 'cltbld', 15:39:46 INFO - 'MAIL': '/var/mail/cltbld', 15:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:46 INFO - 'MOZ_NO_REMOTE': '1', 15:39:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:46 INFO - 'NO_EM_RESTART': '1', 15:39:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:46 INFO - 'PWD': '/builds/slave/test', 15:39:46 INFO - 'SHELL': '/bin/bash', 15:39:46 INFO - 'SHLVL': '1', 15:39:46 INFO - 'TERM': 'linux', 15:39:46 INFO - 'TMOUT': '86400', 15:39:46 INFO - 'USER': 'cltbld', 15:39:46 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 15:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:46 INFO - '_': '/tools/buildbot/bin/python'} 15:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:39:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:39:48 INFO - Installing collected packages: mozsystemmonitor 15:39:48 INFO - Running setup.py install for mozsystemmonitor 15:39:48 INFO - Successfully installed mozsystemmonitor 15:39:48 INFO - Cleaning up... 15:39:48 INFO - Return code: 0 15:39:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:48 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 0x7f7b8d88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef090>, '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 0x28f29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:39:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:39:48 INFO - Using env: {'DISPLAY': ':0', 15:39:48 INFO - 'HOME': '/home/cltbld', 15:39:48 INFO - 'LANG': 'en_US.UTF-8', 15:39:48 INFO - 'LANGUAGE': 'en_US:en', 15:39:48 INFO - 'LOGNAME': 'cltbld', 15:39:48 INFO - 'MAIL': '/var/mail/cltbld', 15:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:48 INFO - 'MOZ_NO_REMOTE': '1', 15:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:48 INFO - 'NO_EM_RESTART': '1', 15:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:48 INFO - 'PWD': '/builds/slave/test', 15:39:48 INFO - 'SHELL': '/bin/bash', 15:39:48 INFO - 'SHLVL': '1', 15:39:48 INFO - 'TERM': 'linux', 15:39:48 INFO - 'TMOUT': '86400', 15:39:48 INFO - 'USER': 'cltbld', 15:39:48 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 15:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:48 INFO - '_': '/tools/buildbot/bin/python'} 15:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:48 INFO - Downloading/unpacking jsonschema==2.5.1 15:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:39:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:50 INFO - Downloading functools32-3.2.3-2.tar.gz 15:39:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:39:50 INFO - warning: no files found matching '*.txt' 15:39:50 INFO - no previously-included directories found matching 'build' 15:39:50 INFO - no previously-included directories found matching 'dist' 15:39:50 INFO - no previously-included directories found matching '.git*' 15:39:50 INFO - Installing collected packages: jsonschema, functools32 15:39:51 INFO - Running setup.py install for functools32 15:39:51 INFO - warning: no files found matching '*.txt' 15:39:51 INFO - no previously-included directories found matching 'build' 15:39:51 INFO - no previously-included directories found matching 'dist' 15:39:51 INFO - no previously-included directories found matching '.git*' 15:39:51 INFO - Successfully installed jsonschema functools32 15:39:51 INFO - Cleaning up... 15:39:51 INFO - Return code: 0 15:39:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7b8d88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef090>, '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 0x28f29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:39:51 INFO - Using env: {'DISPLAY': ':0', 15:39:51 INFO - 'HOME': '/home/cltbld', 15:39:51 INFO - 'LANG': 'en_US.UTF-8', 15:39:51 INFO - 'LANGUAGE': 'en_US:en', 15:39:51 INFO - 'LOGNAME': 'cltbld', 15:39:51 INFO - 'MAIL': '/var/mail/cltbld', 15:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:51 INFO - 'MOZ_NO_REMOTE': '1', 15:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:51 INFO - 'NO_EM_RESTART': '1', 15:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:51 INFO - 'PWD': '/builds/slave/test', 15:39:51 INFO - 'SHELL': '/bin/bash', 15:39:51 INFO - 'SHLVL': '1', 15:39:51 INFO - 'TERM': 'linux', 15:39:51 INFO - 'TMOUT': '86400', 15:39:51 INFO - 'USER': 'cltbld', 15:39:51 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 15:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:51 INFO - '_': '/tools/buildbot/bin/python'} 15:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:39:51 INFO - Cleaning up... 15:39:51 INFO - Return code: 0 15:39:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7b8d88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef090>, '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 0x28f29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:39:51 INFO - Using env: {'DISPLAY': ':0', 15:39:51 INFO - 'HOME': '/home/cltbld', 15:39:51 INFO - 'LANG': 'en_US.UTF-8', 15:39:51 INFO - 'LANGUAGE': 'en_US:en', 15:39:51 INFO - 'LOGNAME': 'cltbld', 15:39:51 INFO - 'MAIL': '/var/mail/cltbld', 15:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:51 INFO - 'MOZ_NO_REMOTE': '1', 15:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:51 INFO - 'NO_EM_RESTART': '1', 15:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:51 INFO - 'PWD': '/builds/slave/test', 15:39:51 INFO - 'SHELL': '/bin/bash', 15:39:51 INFO - 'SHLVL': '1', 15:39:51 INFO - 'TERM': 'linux', 15:39:51 INFO - 'TMOUT': '86400', 15:39:51 INFO - 'USER': 'cltbld', 15:39:51 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 15:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:51 INFO - '_': '/tools/buildbot/bin/python'} 15:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:51 INFO - Downloading/unpacking blobuploader==1.2.4 15:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:53 INFO - Downloading blobuploader-1.2.4.tar.gz 15:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:39:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:39:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:54 INFO - Downloading docopt-0.6.1.tar.gz 15:39:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:39:54 INFO - Installing collected packages: blobuploader, requests, docopt 15:39:54 INFO - Running setup.py install for blobuploader 15:39:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:39:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:39:54 INFO - Running setup.py install for requests 15:39:54 INFO - Running setup.py install for docopt 15:39:54 INFO - Successfully installed blobuploader requests docopt 15:39:54 INFO - Cleaning up... 15:39:54 INFO - Return code: 0 15:39:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:54 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 0x7f7b8d88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef090>, '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 0x28f29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:39:54 INFO - Using env: {'DISPLAY': ':0', 15:39:54 INFO - 'HOME': '/home/cltbld', 15:39:54 INFO - 'LANG': 'en_US.UTF-8', 15:39:54 INFO - 'LANGUAGE': 'en_US:en', 15:39:54 INFO - 'LOGNAME': 'cltbld', 15:39:54 INFO - 'MAIL': '/var/mail/cltbld', 15:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:54 INFO - 'MOZ_NO_REMOTE': '1', 15:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:54 INFO - 'NO_EM_RESTART': '1', 15:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:54 INFO - 'PWD': '/builds/slave/test', 15:39:54 INFO - 'SHELL': '/bin/bash', 15:39:54 INFO - 'SHLVL': '1', 15:39:54 INFO - 'TERM': 'linux', 15:39:54 INFO - 'TMOUT': '86400', 15:39:54 INFO - 'USER': 'cltbld', 15:39:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 15:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:54 INFO - '_': '/tools/buildbot/bin/python'} 15:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:39:55 INFO - Running setup.py (path:/tmp/pip-0xkJPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:39:55 INFO - Running setup.py (path:/tmp/pip-ezCbyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:39:55 INFO - Running setup.py (path:/tmp/pip-i97bHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:39:55 INFO - Running setup.py (path:/tmp/pip-f1GSCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:39:55 INFO - Running setup.py (path:/tmp/pip-FFfJWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:39:55 INFO - Running setup.py (path:/tmp/pip-WQ0Je2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:39:55 INFO - Running setup.py (path:/tmp/pip-DXL3bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:39:55 INFO - Running setup.py (path:/tmp/pip-0C85Wi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:39:55 INFO - Running setup.py (path:/tmp/pip-o6MFqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:39:55 INFO - Running setup.py (path:/tmp/pip-MwEmxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:39:55 INFO - Running setup.py (path:/tmp/pip-4kA25s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:39:55 INFO - Running setup.py (path:/tmp/pip-0Njd8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:39:55 INFO - Running setup.py (path:/tmp/pip-UWe6pM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:39:56 INFO - Running setup.py (path:/tmp/pip-qw02Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:56 INFO - Running setup.py (path:/tmp/pip-9oHWGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:39:56 INFO - Running setup.py (path:/tmp/pip-YNf4xJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:39:56 INFO - Running setup.py (path:/tmp/pip-Ye8_U9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:39:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:39:56 INFO - Running setup.py install for manifestparser 15:39:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:39:56 INFO - Running setup.py install for mozcrash 15:39:56 INFO - Running setup.py install for mozdebug 15:39:56 INFO - Running setup.py install for mozdevice 15:39:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:39:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:39:56 INFO - Running setup.py install for mozfile 15:39:56 INFO - Running setup.py install for mozhttpd 15:39:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:39:56 INFO - Running setup.py install for mozinfo 15:39:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:39:57 INFO - Running setup.py install for mozInstall 15:39:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:39:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:39:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:39:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:39:57 INFO - Running setup.py install for mozleak 15:39:57 INFO - Running setup.py install for mozlog 15:39:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:39:57 INFO - Running setup.py install for moznetwork 15:39:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:39:57 INFO - Running setup.py install for mozprocess 15:39:57 INFO - Running setup.py install for mozprofile 15:39:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:39:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:39:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:39:57 INFO - Running setup.py install for mozrunner 15:39:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:39:57 INFO - Running setup.py install for mozscreenshot 15:39:57 INFO - Running setup.py install for moztest 15:39:57 INFO - Running setup.py install for mozversion 15:39:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:39:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:39:58 INFO - Cleaning up... 15:39:58 INFO - Return code: 0 15:39:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:58 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 0x7f7b8d88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef090>, '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 0x28f29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:39:58 INFO - Using env: {'DISPLAY': ':0', 15:39:58 INFO - 'HOME': '/home/cltbld', 15:39:58 INFO - 'LANG': 'en_US.UTF-8', 15:39:58 INFO - 'LANGUAGE': 'en_US:en', 15:39:58 INFO - 'LOGNAME': 'cltbld', 15:39:58 INFO - 'MAIL': '/var/mail/cltbld', 15:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:58 INFO - 'MOZ_NO_REMOTE': '1', 15:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:58 INFO - 'NO_EM_RESTART': '1', 15:39:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:58 INFO - 'PWD': '/builds/slave/test', 15:39:58 INFO - 'SHELL': '/bin/bash', 15:39:58 INFO - 'SHLVL': '1', 15:39:58 INFO - 'TERM': 'linux', 15:39:58 INFO - 'TMOUT': '86400', 15:39:58 INFO - 'USER': 'cltbld', 15:39:58 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 15:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:58 INFO - '_': '/tools/buildbot/bin/python'} 15:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:39:58 INFO - Running setup.py (path:/tmp/pip-VKxU_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:39:58 INFO - Running setup.py (path:/tmp/pip-is8SAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:39:58 INFO - Running setup.py (path:/tmp/pip-ew2HCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:39:58 INFO - Running setup.py (path:/tmp/pip-Ohe3XU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:39:58 INFO - Running setup.py (path:/tmp/pip-YGn5Nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:39:58 INFO - Running setup.py (path:/tmp/pip-IQReGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:39:58 INFO - Running setup.py (path:/tmp/pip-M_QQou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:39:58 INFO - Running setup.py (path:/tmp/pip-by3lft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:39:58 INFO - Running setup.py (path:/tmp/pip-5S9Q4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:39:58 INFO - Running setup.py (path:/tmp/pip-T8lAjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:39:59 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)) 15:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:39:59 INFO - Running setup.py (path:/tmp/pip-2hF_8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:39:59 INFO - Running setup.py (path:/tmp/pip-1slmah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:39:59 INFO - Running setup.py (path:/tmp/pip-4rW69o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:39:59 INFO - Running setup.py (path:/tmp/pip-EcVPWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:59 INFO - Running setup.py (path:/tmp/pip-nk5i7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:39:59 INFO - Running setup.py (path:/tmp/pip-4_Gvu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:39:59 INFO - Running setup.py (path:/tmp/pip-a1PVKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:39:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:01 INFO - Downloading blessings-1.6.tar.gz 15:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:40:01 INFO - Installing collected packages: blessings 15:40:01 INFO - Running setup.py install for blessings 15:40:01 INFO - Successfully installed blessings 15:40:01 INFO - Cleaning up... 15:40:01 INFO - Return code: 0 15:40:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:40:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:40:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:40:02 INFO - Reading from file tmpfile_stdout 15:40:02 INFO - Current package versions: 15:40:02 INFO - argparse == 1.2.1 15:40:02 INFO - blessings == 1.6 15:40:02 INFO - blobuploader == 1.2.4 15:40:02 INFO - docopt == 0.6.1 15:40:02 INFO - functools32 == 3.2.3-2 15:40:02 INFO - jsonschema == 2.5.1 15:40:02 INFO - manifestparser == 1.1 15:40:02 INFO - mozInstall == 1.12 15:40:02 INFO - mozcrash == 0.17 15:40:02 INFO - mozdebug == 0.1 15:40:02 INFO - mozdevice == 0.48 15:40:02 INFO - mozfile == 1.2 15:40:02 INFO - mozhttpd == 0.7 15:40:02 INFO - mozinfo == 0.9 15:40:02 INFO - mozleak == 0.1 15:40:02 INFO - mozlog == 3.3 15:40:02 INFO - moznetwork == 0.27 15:40:02 INFO - mozprocess == 0.23 15:40:02 INFO - mozprofile == 0.28 15:40:02 INFO - mozrunner == 6.12 15:40:02 INFO - mozscreenshot == 0.1 15:40:02 INFO - mozsystemmonitor == 0.3 15:40:02 INFO - moztest == 0.7 15:40:02 INFO - mozversion == 1.4 15:40:02 INFO - psutil == 3.1.1 15:40:02 INFO - requests == 1.2.3 15:40:02 INFO - wsgiref == 0.1.2 15:40:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40: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')]} 15:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:02 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 0x7f7b8d88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef090>, '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 0x28f29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:40:02 INFO - Using env: {'DISPLAY': ':0', 15:40:02 INFO - 'HOME': '/home/cltbld', 15:40:02 INFO - 'LANG': 'en_US.UTF-8', 15:40:02 INFO - 'LANGUAGE': 'en_US:en', 15:40:02 INFO - 'LOGNAME': 'cltbld', 15:40:02 INFO - 'MAIL': '/var/mail/cltbld', 15:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:02 INFO - 'MOZ_NO_REMOTE': '1', 15:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:02 INFO - 'NO_EM_RESTART': '1', 15:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:02 INFO - 'PWD': '/builds/slave/test', 15:40:02 INFO - 'SHELL': '/bin/bash', 15:40:02 INFO - 'SHLVL': '1', 15:40:02 INFO - 'TERM': 'linux', 15:40:02 INFO - 'TMOUT': '86400', 15:40:02 INFO - 'USER': 'cltbld', 15:40:02 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 15:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:02 INFO - '_': '/tools/buildbot/bin/python'} 15:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:40:02 INFO - Cleaning up... 15:40:02 INFO - Return code: 0 15:40:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40: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')]} 15:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7b8d88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef090>, '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 0x28f29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2e40>, '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': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40: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', 'jsonschema'] in /builds/slave/test/build 15:40: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 jsonschema 15:40:02 INFO - Using env: {'DISPLAY': ':0', 15:40:02 INFO - 'HOME': '/home/cltbld', 15:40:02 INFO - 'LANG': 'en_US.UTF-8', 15:40:02 INFO - 'LANGUAGE': 'en_US:en', 15:40:02 INFO - 'LOGNAME': 'cltbld', 15:40:02 INFO - 'MAIL': '/var/mail/cltbld', 15:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:02 INFO - 'MOZ_NO_REMOTE': '1', 15:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:02 INFO - 'NO_EM_RESTART': '1', 15:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:02 INFO - 'PWD': '/builds/slave/test', 15:40:02 INFO - 'SHELL': '/bin/bash', 15:40:02 INFO - 'SHLVL': '1', 15:40:02 INFO - 'TERM': 'linux', 15:40:02 INFO - 'TMOUT': '86400', 15:40:02 INFO - 'USER': 'cltbld', 15:40:02 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 15:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:02 INFO - '_': '/tools/buildbot/bin/python'} 15:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:40:02 INFO - Cleaning up... 15:40:02 INFO - Return code: 0 15:40:02 INFO - Running post-action listener: _resource_record_post_action 15:40:02 INFO - Running post-action listener: _start_resource_monitoring 15:40:02 INFO - Starting resource monitoring. 15:40:02 INFO - [mozharness: 2016-08-30 22:40:02.537768Z] Finished create-virtualenv step (success) 15:40:02 INFO - [mozharness: 2016-08-30 22:40:02.538273Z] Running install step. 15:40:02 INFO - Running pre-action listener: _resource_record_pre_action 15:40:02 INFO - Running main action method: install 15:40:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:40:02 INFO - Reading from file tmpfile_stdout 15:40:02 INFO - Detecting whether we're running mozinstall >=1.0... 15:40:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:40:02 INFO - Reading from file tmpfile_stdout 15:40:02 INFO - Output received: 15:40:02 INFO - Usage: mozinstall [options] installer 15:40:02 INFO - Options: 15:40:02 INFO - -h, --help show this help message and exit 15:40:02 INFO - -d DEST, --destination=DEST 15:40:02 INFO - Directory to install application into. [default: 15:40:02 INFO - "/builds/slave/test"] 15:40:02 INFO - --app=APP Application being installed. [default: firefox] 15:40:02 INFO - mkdir: /builds/slave/test/build/application 15:40:02 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'] 15:40:02 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 15:40:18 INFO - Reading from file tmpfile_stdout 15:40:18 INFO - Output received: 15:40:18 INFO - /builds/slave/test/build/application/firefox/firefox 15:40:18 INFO - Running post-action listener: _resource_record_post_action 15:40:18 INFO - [mozharness: 2016-08-30 22:40:18.946864Z] Finished install step (success) 15:40:18 INFO - [mozharness: 2016-08-30 22:40:18.947147Z] Running run-tests step. 15:40:18 INFO - Running pre-action listener: _resource_record_pre_action 15:40:18 INFO - Running main action method: run_tests 15:40:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:40:18 INFO - Python 2.7.3 15:40:18 INFO - Return code: 0 15:40:18 INFO - grabbing minidump binary from tooltool 15:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:18 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 0x28ef090>, '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 0x28f29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:40:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:40:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:40:18 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:40:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:40:19 INFO - Return code: 0 15:40:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:40:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:40:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:40:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:40:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:40:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:40:19 INFO - Using env: {'DISPLAY': ':0', 15:40:19 INFO - 'HOME': '/home/cltbld', 15:40:19 INFO - 'LANG': 'en_US.UTF-8', 15:40:19 INFO - 'LANGUAGE': 'en_US:en', 15:40:19 INFO - 'LOGNAME': 'cltbld', 15:40:19 INFO - 'MAIL': '/var/mail/cltbld', 15:40:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:40:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:19 INFO - 'MOZ_NO_REMOTE': '1', 15:40:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:40:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:19 INFO - 'NO_EM_RESTART': '1', 15:40:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:19 INFO - 'PWD': '/builds/slave/test', 15:40:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:40:19 INFO - 'SHELL': '/bin/bash', 15:40:19 INFO - 'SHLVL': '1', 15:40:19 INFO - 'TERM': 'linux', 15:40:19 INFO - 'TMOUT': '86400', 15:40:19 INFO - 'USER': 'cltbld', 15:40:19 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006', 15:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:19 INFO - '_': '/tools/buildbot/bin/python'} 15:40:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:40:19 INFO - mozversion application_buildid: 20160830142820 15:40:19 INFO - mozversion application_changeset: fa6f91ffb4965302f316635e91d456c8103e08c2 15:40:19 INFO - mozversion application_display_name: Nightly 15:40:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:40:19 INFO - mozversion application_name: Firefox 15:40:19 INFO - mozversion application_remotingname: firefox 15:40:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:40:19 INFO - mozversion application_vendor: Mozilla 15:40:19 INFO - mozversion application_version: 51.0a1 15:40:19 INFO - mozversion platform_buildid: 20160830142820 15:40:19 INFO - mozversion platform_changeset: fa6f91ffb4965302f316635e91d456c8103e08c2 15:40:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:40:19 INFO - mozversion platform_version: 51.0a1 15:40:19 INFO - using testdate: 1472596819 15:40:19 INFO - actual date: 1472596819 15:40:19 INFO - starting webserver on 'localhost:51502' 15:40:19 INFO - SUITE-START | Running 2 tests 15:40:19 INFO - TEST-START | dromaeo_css 15:40:19 INFO - operating with platform_type : linux_ 15:40:19 INFO - Initialising browser for dromaeo_css test... 15:40:19 INFO - TEST-INFO | started process 11789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZxbVXP/profile http://localhost:51502/getInfo.html) 15:40:23 INFO - PROCESS | 11789 | __metrics Screen width/height:1600/1200 15:40:23 INFO - PROCESS | 11789 | colorDepth:24 15:40:23 INFO - PROCESS | 11789 | Browser inner width/height: 1024/697 15:40:23 INFO - PROCESS | 11789 | __metrics 15:40:24 INFO - PROCESS | 11789 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:40:24 INFO - PROCESS | 11789 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:40:24 INFO - PROCESS | 11789 | console.error: PushService: 15:40:24 INFO - PROCESS | 11789 | stateChangeProcessEnqueue: Error transitioning state 15:40:24 INFO - PROCESS | 11789 | UnknownError 15:40:25 INFO - TEST-INFO | 11789: exit 0 15:40:25 INFO - Browser initialized. 15:40:25 INFO - Running cycle 1/1 for dromaeo_css test... 15:40:25 INFO - TEST-INFO | started process 11872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZxbVXP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:40:37 INFO - PROCESS | 11872 | RSS: Main: 182104064 15:40:37 INFO - PROCESS | 11872 | 15:41:28 INFO - PROCESS | 11872 | 1472596888966 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:43:42 INFO - PROCESS | 11872 | Cycle 1(1): loaded http://localhost:51502/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51502/tests/dromaeo/cssquery-ext.html) 15:43:43 INFO - PROCESS | 11872 | RSS: Main: 306515968 15:43:43 INFO - PROCESS | 11872 | 15:46:46 INFO - PROCESS | 11872 | Cycle 1(1): loaded http://localhost:51502/tests/dromaeo/cssquery-ext.html (next: http://localhost:51502/tests/dromaeo/cssquery-jquery.html) 15:46:47 INFO - PROCESS | 11872 | RSS: Main: 276815872 15:46:47 INFO - PROCESS | 11872 | 15:49:49 INFO - PROCESS | 11872 | Cycle 1(1): loaded http://localhost:51502/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51502/tests/dromaeo/cssquery-mootools.html) 15:49:49 INFO - PROCESS | 11872 | RSS: Main: 219054080 15:49:49 INFO - PROCESS | 11872 | 15:52:52 INFO - PROCESS | 11872 | Cycle 1(1): loaded http://localhost:51502/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51502/tests/dromaeo/cssquery-prototype.html) 15:52:52 INFO - PROCESS | 11872 | RSS: Main: 246579200 15:52:52 INFO - PROCESS | 11872 | 15:55:56 INFO - PROCESS | 11872 | Cycle 1(1): loaded http://localhost:51502/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51502/tests/dromaeo/cssquery-yui.html) 15:55:56 INFO - PROCESS | 11872 | RSS: Main: 221077504 15:55:56 INFO - PROCESS | 11872 | 15:58:59 INFO - PROCESS | 11872 | Cycle 1(1): loaded http://localhost:51502/tests/dromaeo/cssquery-yui.html (next: http://localhost:51502/tests/dromaeo/cssquery-dojo.html) 15:59:00 INFO - PROCESS | 11872 | RSS: Main: 310263808 15:59:00 INFO - PROCESS | 11872 | 15:59:00 INFO - PROCESS | 11872 | __start_tp_report 15:59:00 INFO - PROCESS | 11872 | _x_x_mozilla_page_load 15:59:00 INFO - PROCESS | 11872 | _x_x_mozilla_page_load_details 15:59:00 INFO - PROCESS | 11872 | |i|pagename|runs| 15:59:00 INFO - PROCESS | 11872 | |0;dojo.html;2608.256646855646;2615.2807977806106;2621.436391175897;2662.1481126039675;2678.9953767337247;4550.294704320827;4614.400127983357;4675.953240467595;4781.521847815221;4801.975990120049;4652.441706995157;4659.301104834277;4669.089527542131;4693.55411235932;4709.293605959099;4357.150355680644;4359.847405340814;4378.759168245761;4381.123775244948;4396.230659634552;4330.545292744264;4388.144311859189;4418.425604671388;4427.446569178853;4429.313456414261;4416.447944006999;4446.199684056868;4468.151051300259;4469.374287599739;4471.754053527055;4248.320268757015;4358.803853826569;4371.169477799208;4394.296912494017;4470.485894122153;4246.214450326699;4254.91490170198;4261.616454519077;4287.249731297011;4315.978420107911;4631;4631.235846085426;4649.976750116261;4693;4748.3114948332295;5021.899562008776;5040.092783299005;5043.445221025684;5047.848564543033;5058.190689489701;4894.216925291937;4943.975280123613;4959;5051.494850514956;5111.233315002779;4688.390509233778;4694.600958918462;4697.882552936136;4740.478547359788;4745.027269409763;5120.180771076684;5166.586673066221;5170.663906846043;5171.741412929338;5204.7918083277;4838.588719958772;4940.135476291634;4941.876453088702;4983.526564976321;5007.073691367109;5104.259882317043;5120.206368012964;5120.513551212629;5160.638755287169;5167.121589329823;5032.345795046694;5049.192129259301;5061.063703214917;5067.5185857343495;5124.871878203075;4870.09903167915;4917.139500587383;4932.580730637936;5061.2661164131;5068;4254.744715317091;4312.180685669713;4315.8489452869;4367.170237654836;4371.256886329268;3761.7931013793955;3771.0949372150485;3774.169682669808;3796.335641262768;3813.4851795007876;4225.3873188387515;4260.403543503912;4308.676849236257;4309.267424537773;4347.369631403429;5031.874203144951;5032.169692000852;5049.242613607915;5100.6429549931145;5117.2068329409;4304.440422745023;4311.9784401077795;4314.1371725655;4362.1493808707;4364.650827933758;4449.933251001237;4530.252508336153;4565.041341318294;4566.337881007302;4572.45130584332;4724.314974328772;4724.6456515760765;4760.88097797544;4820.662553621213;4823.469418364048;5044.646874718735;5055.772490237875;5059.392872855281;5059.645824792229;5116.462771408948;4678.69588476748;4697.553732395417;4745.833895813768;4770.141374552475;4778.426588809365;4949.653524253267;4972.577330926912;4997.0505603935135;5024.29659847629;5027.522385373383;5038.395392552917;5039.974800125976;5041.722705251246;5044.9243261350375;5091.490850914879;4823.638227133049;4907.828226012072;4922.975385123052;4937.111319962298;4998.775055122601;4926.236433352836;4951.306817045688;4970.552650261494;4971.776270067928;5030.270610761346;4901.3138160658245;4903.632227582874;4907.9263811043575;4913.754312284443;4978.253262010582;4778.187708089564;4808.0383923214795;4812.542808433193;4985.700857948535;5076.82231121909;4764.404449443819;4776.379070720784;4777.641676874317;4832.395950506187;4859.757012149307 15:59:00 INFO - PROCESS | 11872 | |1;ext.html;573.1374281706031;579.9884002319957;580.3210244014502;580.4137820800989;583.5098517245513;27826;37973.81013094934;38966.80516597417;39085.21829563407;42169.57830421695;39090.21819563607;39442.60557394425;39515.40726889099;39522;39569.40645890314;7466.104067511893;7584.4690871639;7604.391648668094;7606.847863042736;7621.237876212362;7371.520851144685;7445.925540744577;7449.739259125931;7450.888236676454;7454.5899975501325;7455.552666840007;7481.064866891638;7493.512921660102;7495.175530691619;7498.812529686774;7440.55356678601;7491.737789177353;7492.213317601628;7493.850122997564;7499.51253168545;7637.961810190914;7702.922970770276;7708.922910770877;7710;7711.113221979488;37239.25521489555;37565.43651845225;37621.81189094064;37646.81176594127;37654.43518347227;2946.6169397978124;2957.5267957126757;2965.584818125464;2982.835944023078;3007.9097627071224;27100.864495677397;27734.722652773416;28696.569551456745;28753.28116797076;29045.854770726222;3386.4920261960656;3479.9826000869834;3502.7548071634997;3531.5055892175114;3544.9645503544893;262945;266137;266637;266695;267001;55152.83013208257;56303.873922522136;56347.210487109056;56392.43607563954;56413.71793141008;32800.67199328024;33814.830925845214;60015.09977350343;60393.396066039655;60480.69759651174;14091.224982626054;14396.712065758626;14428.134311941318;14432.278386080654;14459.277036148362;10514.421706806199;10596.205284603686;10615.52230149645;10621.84067238992;10651.520681569347;18605.511559075243;18646.923257662605;18713.81286187148;18919.716204256947;18988.240470381308;7309.817254568678;7350.926490735131;7372.631368431557;7373.5575865448245;7567.243275672388;719.7907515374117;818.5007145641155;834.5410024486508;850.6427300533791;899.5322432335149;25722.354117206047;27200.1839944798;27430.862845686042;27475.31311717223;27605.30986725348;888.648983651454;910.1399177776938;926.7173512078881;977.5307852230969;1011.3577878047346;13790.241536715377;14294.428222871176;14724.705505889822;14820.925895370454;14855.70288594222;396769;400284;400557;400562;400849;48338.75830620824;48710.26934595984;48734.53796386114;48752;48984.75507622439;1100.5817789240039;1116.8938950799661;1135.534430883334;1141.5833220874322;1142.440204299887;24729.25812225636;26400.207993760218;26942.59586106171;27444.17667469979;27595.31011724723;41373.172536549704;41555.168896622505;41707;41716.79141604394;41780.791096044326;328698;329145;329235;329757;331092;25360.365990849637;25701.228963131136;25741.3564660885;25812.22563323103;25837.354066148495;40166.598334016286;40369.1926161481;41586.58413415827;41881.79059104685;42066.7896660527;34393;34470.82764586161;35007;35905.46141807927;36040.63959360478;35054.12364690903;35537;35576.46635300524;36016.819915900254;36180.45729314115;30061.54907676343;34033.829830850686;34550.65449345474;34702.30595388129;35939;26794.97113149526;32111.839440803582;32240.516392253667;32340.191495212806;32441.51337729889;24239.63640545358;24457.877710611334;24704.1353552632;24944.251672449856;25071.373215669755 15:59:00 INFO - PROCESS | 11872 | |2;jquery.html;325.9771815972883;344.2512535235863;346.14329534402356;348.26516051132114;365.76956517394035;12478.2513049217;15801.762973555406;16583.502494925156;16794.244259008345;18135.818641813577;15788.921055394736;16023.599410014756;16139.193040347995;16225.594360141002;16502.33990640373;4925.433575138869;4958.789876854459;5051.696898186102;5120.820771273006;5122.8207012754565;3655.872044478444;4799;5014.348134742497;5664.971675141618;5995.490383317423;6005.669688167149;6010.27876654802;6018.879622407571;6025.096235564679;6025.758969641209;5144.485551444863;5393.406725260218;5417.322834645669;5527.032769265363;6012.879742405149;5322.414534401213;5341.519263266286;5342.866428339323;5351.678899266057;5361.571074314084;11600.88399116015;11828.645140645795;12061.33662648554;12108.273503589813;12146.757064858653;1690.5351028467146;1723.172877019038;1736.1753167245583;1927.942161735136;2309.5815751585546;9033.819323613556;9087.545622718904;9259.166674999282;9478.90521094787;9587.280953928414;1743.7820272465942;1748.5628592851788;1755.5962128710469;1776.1740790532465;1782.9108544572719;68642.65678671625;72222.63888680575;72426.63786681033;72710.27289727035;73680.63159684221;9517.524123793783;9589.472579008221;9681.322307438553;9850.60597576089;9915.760529933757;12880.420381082873;12881.09832311748;12884.291363975071;12895.419706113247;12898.774616411614;6871.244163142051;7037.507374483839;7040.401565866856;7257.201707812136;7295.854082918312;6818.079559259536;6854.2117656470145;7023.578585284899;7039;7041.436685065182;4018.6584140347813;4049.1294371709637;4051.149258655715;4061.289274376972;4134.428917011516;1591.5782317685823;1649.4391906751762;1700.2348942975711;1818.7999320074782;1821.7358483019889;738.5642470942063;758.2531206761336;809.3201710563037;852.9616167272487;853.7182729699184;15772.11064569987;16308.103054332125;16590.17049147538;16737.748933766004;17368.65262694739;792.8731402975496;793.3296364571928;805.7381351060928;809.4576633655465;837.4347315561971;8771.31604726004;9449.716508504756;9452.243820494345;9554.61781528731;9699;399624;410282;424862;424967;428257;71963.64018179875;73399.26600733925;75914;78182;79742;841.6170642357835;849.2229609906866;868.4789126524162;868.7524055644237;877.3156937588691;14558.27208639585;14659.120452772868;15308.923455382652;15407.679852879319;15575.844241557892;35443;35884.28231435305;36279.81860090682;36843.63156368509;37850.62149378581;50824;51057.489425105276;51197.23204151866;51800.222996654324;51838.481615183366;7256.637168141467;7586.734464293723;7703.691852325845;7725.806854828675;7807.804804879924;8584.841046458898;11075.612353567909;11436;11973.940130299292;12032.398380081137;9626.374285671409;10039.04629060238;10196.184305255414;10590.735231619272;10661.786764264827;10003.2997690161;10380.32527885685;10641.574337026432;10646.254762166574;10685.893141068489;10554.472276385997;10631.94684026575;10890.509927053143;10912.836307455553;10963.780724385628;7585.6965721372735;7754.340881025176;7841.255080767318;7850.214978502104;7961.402894782798;9197.586108625263;10013.148882345082;10198.388096714221;10291.772444320819;10733.892661073289 15:59:00 INFO - PROCESS | 11872 | |3;mootools.html;1317.6310633022752;1362.2235325864256;1396.5251814383107;1631.6818220447003;1662.2021429713745;6693.230278517972;7049.506534542584;7088.149422069352;7614.086309642844;7628.732994345199;7200.927990720104;7448.96275518623;7451.292127247916;7455.888161677565;7458.738944136956;2128.3082998025666;2169.6420090685097;2173.1850556041486;2174.4018146662193;2174.5759576882515;1857.0621835972815;2048.201201531404;2109.9367018989456;2111.5987962287195;2145.1205005947563;2143.7749036351192;2169.739631244253;2170.9891450542805;2171.9891400542974;2172.174573662014;2066.8553201275918;2091.1739862754125;2096.360610013945;2116.8094871461644;2121.02432880875;2068.4621998280554;2081.6669332906813;2093.5603523260133;2096.0462989339812;2101.516651170224;7504.137024242227;7527.548347099191;7532.54804711719;7534.54792712439;7541.509801862861;4272.166927449149;4389.4513185851765;4397.516273209944;4403.625691816167;4407.801648925774;2747.4917140329103;2856.22881821909;2915.2420370703558;2922.503174460347;2928.8535573221466;921.345844450441;928.0951072704127;945.1257586732245;949.9192568631605;954.2842867849113;9897.4556399398;9954.303198776017;9988.850167247425;9990.100890919779;10014.3490673106;3864.5942176071107;3971.3645816669195;4057.9391309130388;4113.074558224435;4123.546409894909;7482.8877566836545;7627.618619069024;7628.923710762932;7632.618369081523;7636.618169091523;4036.2129384769687;4037.394390841397;4042.9797851011144;4043.0700938784244;4043.433919251307;3714;3720.162963333228;3721.888343349704;3722.1997270586953;3722.4230244312175;3139.121046107048;3265.6734326567152;3326.534285200074;3376.3416133854153;3377.560917080764;926.8239034583543;932.5710173320349;1034.6947650443137;1054.035557464911;1054.2304117993908;578.6152208781198;677.4140368581142;789.403999980023;790.8260182759899;792.2948575767572;4821.710697358169;4873.951260487421;4952.133376659071;4965.652404331734;5203.245529398216;779.4154384211841;807.2976510435841;832.7168762620738;848.7962888906618;853.5561508015797;3286.1620286826706;3394.5417368654917;3395.303962687643;3462.23830757233;3490.5462289902152;8435.662573496991;8970.730878073668;8980.281577473786;8980.955095224614;8989.41568798026;7867.173946735625;8103.270705636521;8376.204260595234;8421.326293896474;8665.913340866637;6712.328767123347;6833.384995350541;6925.480588955848;6929.203141638776;6935.930640693528;4984.526469985346;4993.1012417763695;5063.240513922941;5076.213186956028;5270.314859068297;8172.18278172178;8208.220219079178;8282;8351.081381048201;8412.87380689278;7974;8194.05768336625;8244.29923456513;8495.957520212607;8504.23461888433;6194.349593292639;6195.597286176564;6359.586626869239;6468.676566171766;6537.05212744159;6953.061336719478;7018.368346848808;7021.824454388681;7072.646367681698;7088.255733147946;6211.689415529296;6224.533160013108;6335.841603959753;6441.967790161019;6453.774117905851;6107.908381374372;6208.906866397098;6213.627182369072;6241.531885108544;6306.211723534559;5734.283214598176;5870.618409803349;5897.056470964625;5897.3807750187325;5909.674967876808;4150.086980864205;4161.292580261303;4178.206140833232;4232.195882782262;4317.676174286878;4241.34259189826;4252.638525725224;4336.956630433655;4375.190589740908;4516.887077822949 15:59:00 INFO - PROCESS | 11872 | |4;prototype.html;282.5070252409544;291.27617869594053;292.3597321865114;295.56404303652107;299.1310243741929;4721.197396442604;4818.277258411232;4881.997571493533;4908.607311415087;4919.803207871685;4708.74101924394;4815.831445899395;4839.5644392004715;4848.975755121228;4849.6847704899155;3813.8474461021524;3814.332491813935;3815.084379748868;3832.3676593362134;3847.7306588538813;3657.4696668982983;3711.7772933623933;3820.9808950955344;3828.2152158807376;3839.289731399686;3693.353663108945;3763.6989040876665;3769.8492060317553;3774.320622288001;3802.524684414448;3727.7204209684382;3759.4172903200047;3762.454444105603;3772.302124107049;3785.4511095891216;3287.8849240276713;3311.7516186286125;3318.6725309876;3327.434336162858;3334.7165490933057;4530.682852200347;4672.836450724209;4692.55420735033;4708.3285433671235;4708.529147085264;4306.655467562588;4320.092780516095;4336.85325763749;4337.240982828024;4344.044310251739;5053.74731263439;5061.342025536694;5061.342025536694;5083.440821509631;5111.744412779346;3555.8755443559353;3653.269346130758;3660.5058317127114;3693.3351996640595;3698.815059247054;5310.230016647603;5315.202719592054;5326.6537675050995;5340.679559226459;5343.171808369709;3789.9621003789607;3806.544778617776;3811.8094095295123;3814;3815.3132436161204;3829.1193025604266;3843.6348546888003;3846.615338466187;3851.4786659269994;3892.4939757831867;4064.1871625674985;4261.318189089793;4298.505671847715;4315.417418648442;4319.697621166488;5044.9495505045215;5059.82427556147;5069.949300507022;5109.335786347751;5112.846614601568;1219.804591500317;1232.7842627540144;1258.534342293339;1274.955376561816;1278.277773058219;827.8592639251342;855.4183155454226;864.7677060189205;865.4244927123392;868.6829307302789;4425.867223983286;4428.734275943454;4439.756868076944;4445.5776701213335;4462;5128.640995130305;5164.638475306692;5170.793168273302;5204.817831375959;5212.869678257998;4243.915121697611;4418.513963464016;4439.844605438794;4484.708493947883;4484.932726009048;2724.1827451764393;2755.917322480329;2788.8466134362807;2792.944141117166;2798.230486616156;4935.432425271139;4949.925751113737;4950.425778595182;4954.504549545017;4961.5286547777905;5125.513076257749;5293.364796224478;5349.716068143617;5356.7589458473685;5366.838994830083;4920.606351491872;4922.21244600855;4926.75366231687;4937.40751109862;4958.6281028923695;5109.5912327013;5246.396664383645;5255.78976840922;5267.631265811357;5270.341207349082;5075.2387141929;5104.387473503203;5128.615353848401;5132.2814805926455;5167.405748338989;4906.435759887659;4911.263310503453;4928.383952005999;4930.630202734737;4940.580050695731;3631.1466805300206;3649.379605467024;3650.178709790276;3661.077934084627;3669.4679271504947;4993.700377977333;5151.922721159111;5161.561267292323;5202.306362482528;5226.503482169188;5083.923741143812;5092.770825312796;5094.363204599425;5101.693898365961;5143.871403214949;4838.903221935612;5102.158143906214;5106.642535022513;5112.696262453051;5124.948750512447;4749.4063242094735;4802.711837289774;4987.501249874984;4995.725235112103;5049.84850454487;5062.493750624908;5066.670666406671;5079.339685840817;5080.491950805038;5096.337476128079;4974.403071631283;4977.9502204978935;4999.150144475375;5030.144875371268;5045.729421760149 15:59:00 INFO - PROCESS | 11872 | |5;yui.html;632.9240491141062;638.9776357827477;639.5906619763349;682.4165338635466;727.1855521815564;12292.877071229284;13272.601821945333;13280.7343853123;13290.335483225848;13300.800487992688;13542.729145417086;13585.252811095386;13700.109492882955;13704.314784260798;13732.382042808073;609.2232403685292;731.8792399254116;738.4314078159828;754.241986803262;762.0550517358463;758.7458201502476;767.9539227646331;768.6310570925959;768.7808974442285;768.8231706707461;801.5070731500115;802.8594995875727;803.3412601666636;803.3653413803089;803.5259197073725;632.5888172687744;769.7652216074096;795.2643804480861;795.7493389582263;797.0873350014231;583.6410607476414;584.5615788158881;584.5820238529429;585.242111465653;585.2654918077785;12248.203866748721;12258.570950016707;12285.262884226975;12299.631011069681;12328.32194229317;11918.225315354473;12279.508819647204;12706.428210730539;12790.360481975957;13298.73921433349;9817.361871478332;9948.253880958957;10752.838707419394;10921.617743379024;11036.282641628268;4052.1895620875944;4070.5929407059352;4158.209940111369;4227.7463352198965;4313.1804957058375;50597.49402506001;52479;52633.94732105375;57788.71105644487;58088;10141.594336226615;10387.37675739458;10417.791644167226;10450.581976720998;10516.894831051592;18226.179821908045;18273.543161421072;18315.35896243625;18345.17446714901;18346.266149353876;6957.130358705162;7002.719891204397;7017.087778588751;7028.297170283033;7254.238304977901;3860.4402361657403;3864.71014673895;3887.727859049896;3924.117073658404;3984.86052988144;2892.898748543791;2988.521766831605;3012.29211135383;3020.2449387653087;3061.8315992620173;508.67444835305434;509.95410413063;522.814400887687;524.3393324411269;531.3358302122347;401.98794036178964;461.1675924955488;492.3943549434216;496.3225197605243;502.2892606961109;7549.245075492407;7769.805754856174;7891.329237014918;7933.761987140395;8004.479708818908;465.353159108839;469.5234337147798;499.1389852504401;499.3209235439799;507.908576456234;3488.7732297401094;3640.453931910182;3671.100580357776;3731.328360895065;3743.6069212732273;56980;75007;77604;78080;90828;77771;79163;80207.19792802114;80239;80240;60021;61387.79183122478;61635.6918215415;72271.17559739538;73513;7886.695108641776;8331.83336333282;8473.865508461982;8568.57157142153;8677.566121694017;38576.80711596424;38769;38777;39134.6086539131;39521.60478395294;39620.801895990335;41775;53000.46999529955;58500.707496462244;59954.40045599488;10062.496875156066;10080.89919100829;10084.747881302732;10100.141487973604;10128.139108175888;11235.831462528233;11266.66200014001;11320;11654.650360489199;12223.69440763988;10579.735506612396;10775.730606734895;10815.242932994615;10909.072728818139;11189.776204475702;10682.8397574038;10722.678319650424;11174.497147628213;11272.267302625303;11279.887201128213;10827.729306767078;11356.94321528387;11461.312321260752;11830.231034982698;11833.881661183623;8624.655013799378;9070.954645226731;9363.250939924654;9541.093596108358;10066.69799906004;8535.14324611702;8883.289336852908;9147.908520914973;9247.861282080908;9327.906720932975 15:59:00 INFO - PROCESS | 11872 | __end_tp_report 15:59:00 INFO - PROCESS | 11872 | __start_cc_report 15:59:00 INFO - PROCESS | 11872 | _x_x_mozilla_cycle_collect,1163 15:59:00 INFO - PROCESS | 11872 | __end_cc_report 15:59:00 INFO - PROCESS | 11872 | __startTimestamp1472597940186__endTimestamp 15:59:00 INFO - PROCESS | 11872 | 15:59:00 INFO - PROCESS | 11872 | ------- Summary: start ------- 15:59:00 INFO - PROCESS | 11872 | Number of tests: 6 15:59:00 INFO - PROCESS | 11872 | 15:59:00 INFO - PROCESS | 11872 | [#0] dojo.html Cycles:165 Average:4667.29 Median:4777.64 stddev:485.54 (10.2%) stddev-sans-first:459.37 15:59:00 INFO - PROCESS | 11872 | Values: 2608.3 2615.3 2621.4 2662.1 2679.0 4550.3 4614.4 4676.0 4781.5 4802.0 4652.4 4659.3 4669.1 4693.6 4709.3 4357.2 4359.8 4378.8 4381.1 4396.2 4330.5 4388.1 4418.4 4427.4 4429.3 4416.4 4446.2 4468.2 4469.4 4471.8 4248.3 4358.8 4371.2 4394.3 4470.5 4246.2 4254.9 4261.6 4287.2 4316.0 4631.0 4631.2 4650.0 4693.0 4748.3 5021.9 5040.1 5043.4 5047.8 5058.2 4894.2 4944.0 4959.0 5051.5 5111.2 4688.4 4694.6 4697.9 4740.5 4745.0 5120.2 5166.6 5170.7 5171.7 5204.8 4838.6 4940.1 4941.9 4983.5 5007.1 5104.3 5120.2 5120.5 5160.6 5167.1 5032.3 5049.2 5061.1 5067.5 5124.9 4870.1 4917.1 4932.6 5061.3 5068.0 4254.7 4312.2 4315.8 4367.2 4371.3 3761.8 3771.1 3774.2 3796.3 3813.5 4225.4 4260.4 4308.7 4309.3 4347.4 5031.9 5032.2 5049.2 5100.6 5117.2 4304.4 4312.0 4314.1 4362.1 4364.7 4449.9 4530.3 4565.0 4566.3 4572.5 4724.3 4724.6 4760.9 4820.7 4823.5 5044.6 5055.8 5059.4 5059.6 5116.5 4678.7 4697.6 4745.8 4770.1 4778.4 4949.7 4972.6 4997.1 5024.3 5027.5 5038.4 5040.0 5041.7 5044.9 5091.5 4823.6 4907.8 4923.0 4937.1 4998.8 4926.2 4951.3 4970.6 4971.8 5030.3 4901.3 4903.6 4907.9 4913.8 4978.3 4778.2 4808.0 4812.5 4985.7 5076.8 4764.4 4776.4 4777.6 4832.4 4859.8 15:59:00 INFO - PROCESS | 11872 | 15:59:00 INFO - PROCESS | 11872 | [#1] ext.html Cycles:180 Average:48002.35 Median:35977.91 stddev:88684.23 (246.5%) stddev-sans-first:88861.51 15:59:00 INFO - PROCESS | 11872 | Values: 573.1 580.0 580.3 580.4 583.5 27826.0 37973.8 38966.8 39085.2 42169.6 39090.2 39442.6 39515.4 39522.0 39569.4 7466.1 7584.5 7604.4 7606.8 7621.2 7371.5 7445.9 7449.7 7450.9 7454.6 7455.6 7481.1 7493.5 7495.2 7498.8 7440.6 7491.7 7492.2 7493.9 7499.5 7638.0 7702.9 7708.9 7710.0 7711.1 37239.3 37565.4 37621.8 37646.8 37654.4 2946.6 2957.5 2965.6 2982.8 3007.9 27100.9 27734.7 28696.6 28753.3 29045.9 3386.5 3480.0 3502.8 3531.5 3545.0 262945.0 266137.0 266637.0 266695.0 267001.0 55152.8 56303.9 56347.2 56392.4 56413.7 32800.7 33814.8 60015.1 60393.4 60480.7 14091.2 14396.7 14428.1 14432.3 14459.3 10514.4 10596.2 10615.5 10621.8 10651.5 18605.5 18646.9 18713.8 18919.7 18988.2 7309.8 7350.9 7372.6 7373.6 7567.2 719.8 818.5 834.5 850.6 899.5 25722.4 27200.2 27430.9 27475.3 27605.3 888.6 910.1 926.7 977.5 1011.4 13790.2 14294.4 14724.7 14820.9 14855.7 396769.0 400284.0 400557.0 400562.0 400849.0 48338.8 48710.3 48734.5 48752.0 48984.8 1100.6 1116.9 1135.5 1141.6 1142.4 24729.3 26400.2 26942.6 27444.2 27595.3 41373.2 41555.2 41707.0 41716.8 41780.8 328698.0 329145.0 329235.0 329757.0 331092.0 25360.4 25701.2 25741.4 25812.2 25837.4 40166.6 40369.2 41586.6 41881.8 42066.8 34393.0 34470.8 35007.0 35905.5 36040.6 35054.1 35537.0 35576.5 36016.8 36180.5 30061.5 34033.8 34550.7 34702.3 35939.0 26795.0 32111.8 32240.5 32340.2 32441.5 24239.6 24457.9 24704.1 24944.3 25071.4 15:59:00 INFO - PROCESS | 11872 | 15:59:00 INFO - PROCESS | 11872 | [#2] jquery.html Cycles:180 Average:24760.40 Median:4986.57 stddev:68887.55 (1381.5%) stddev-sans-first:69056.37 15:59:00 INFO - PROCESS | 11872 | Values: 326.0 344.3 346.1 348.3 365.8 12478.3 15801.8 16583.5 16794.2 18135.8 15788.9 16023.6 16139.2 16225.6 16502.3 4925.4 4958.8 5051.7 5120.8 5122.8 3655.9 4799.0 5014.3 5665.0 5995.5 6005.7 6010.3 6018.9 6025.1 6025.8 5144.5 5393.4 5417.3 5527.0 6012.9 5322.4 5341.5 5342.9 5351.7 5361.6 11600.9 11828.6 12061.3 12108.3 12146.8 1690.5 1723.2 1736.2 1927.9 2309.6 9033.8 9087.5 9259.2 9478.9 9587.3 1743.8 1748.6 1755.6 1776.2 1782.9 68642.7 72222.6 72426.6 72710.3 73680.6 9517.5 9589.5 9681.3 9850.6 9915.8 12880.4 12881.1 12884.3 12895.4 12898.8 6871.2 7037.5 7040.4 7257.2 7295.9 6818.1 6854.2 7023.6 7039.0 7041.4 4018.7 4049.1 4051.1 4061.3 4134.4 1591.6 1649.4 1700.2 1818.8 1821.7 738.6 758.3 809.3 853.0 853.7 15772.1 16308.1 16590.2 16737.7 17368.7 792.9 793.3 805.7 809.5 837.4 8771.3 9449.7 9452.2 9554.6 9699.0 399624.0 410282.0 424862.0 424967.0 428257.0 71963.6 73399.3 75914.0 78182.0 79742.0 841.6 849.2 868.5 868.8 877.3 14558.3 14659.1 15308.9 15407.7 15575.8 35443.0 35884.3 36279.8 36843.6 37850.6 50824.0 51057.5 51197.2 51800.2 51838.5 7256.6 7586.7 7703.7 7725.8 7807.8 8584.8 11075.6 11436.0 11973.9 12032.4 9626.4 10039.0 10196.2 10590.7 10661.8 10003.3 10380.3 10641.6 10646.3 10685.9 10554.5 10631.9 10890.5 10912.8 10963.8 7585.7 7754.3 7841.3 7850.2 7961.4 9197.6 10013.1 10198.4 10291.8 10733.9 15:59:00 INFO - PROCESS | 11872 | 15:59:00 INFO - PROCESS | 11872 | [#3] mootools.html Cycles:180 Average:4776.92 Median:3224.62 stddev:2617.13 (81.2%) stddev-sans-first:2611.56 15:59:00 INFO - PROCESS | 11872 | Values: 1317.6 1362.2 1396.5 1631.7 1662.2 6693.2 7049.5 7088.1 7614.1 7628.7 7200.9 7449.0 7451.3 7455.9 7458.7 2128.3 2169.6 2173.2 2174.4 2174.6 1857.1 2048.2 2109.9 2111.6 2145.1 2143.8 2169.7 2171.0 2172.0 2172.2 2066.9 2091.2 2096.4 2116.8 2121.0 2068.5 2081.7 2093.6 2096.0 2101.5 7504.1 7527.5 7532.5 7534.5 7541.5 4272.2 4389.5 4397.5 4403.6 4407.8 2747.5 2856.2 2915.2 2922.5 2928.9 921.3 928.1 945.1 949.9 954.3 9897.5 9954.3 9988.9 9990.1 10014.3 3864.6 3971.4 4057.9 4113.1 4123.5 7482.9 7627.6 7628.9 7632.6 7636.6 4036.2 4037.4 4043.0 4043.1 4043.4 3714.0 3720.2 3721.9 3722.2 3722.4 3139.1 3265.7 3326.5 3376.3 3377.6 926.8 932.6 1034.7 1054.0 1054.2 578.6 677.4 789.4 790.8 792.3 4821.7 4874.0 4952.1 4965.7 5203.2 779.4 807.3 832.7 848.8 853.6 3286.2 3394.5 3395.3 3462.2 3490.5 8435.7 8970.7 8980.3 8981.0 8989.4 7867.2 8103.3 8376.2 8421.3 8665.9 6712.3 6833.4 6925.5 6929.2 6935.9 4984.5 4993.1 5063.2 5076.2 5270.3 8172.2 8208.2 8282.0 8351.1 8412.9 7974.0 8194.1 8244.3 8496.0 8504.2 6194.3 6195.6 6359.6 6468.7 6537.1 6953.1 7018.4 7021.8 7072.6 7088.3 6211.7 6224.5 6335.8 6442.0 6453.8 6107.9 6208.9 6213.6 6241.5 6306.2 5734.3 5870.6 5897.1 5897.4 5909.7 4150.1 4161.3 4178.2 4232.2 4317.7 4241.3 4252.6 4337.0 4375.2 4516.9 15:59:00 INFO - PROCESS | 11872 | 15:59:00 INFO - PROCESS | 11872 | [#4] prototype.html Cycles:180 Average:4215.41 Median:4828.59 stddev:1224.08 (25.4%) stddev-sans-first:1191.38 15:59:00 INFO - PROCESS | 11872 | Values: 282.5 291.3 292.4 295.6 299.1 4721.2 4818.3 4882.0 4908.6 4919.8 4708.7 4815.8 4839.6 4849.0 4849.7 3813.8 3814.3 3815.1 3832.4 3847.7 3657.5 3711.8 3821.0 3828.2 3839.3 3693.4 3763.7 3769.8 3774.3 3802.5 3727.7 3759.4 3762.5 3772.3 3785.5 3287.9 3311.8 3318.7 3327.4 3334.7 4530.7 4672.8 4692.6 4708.3 4708.5 4306.7 4320.1 4336.9 4337.2 4344.0 5053.7 5061.3 5061.3 5083.4 5111.7 3555.9 3653.3 3660.5 3693.3 3698.8 5310.2 5315.2 5326.7 5340.7 5343.2 3790.0 3806.5 3811.8 3814.0 3815.3 3829.1 3843.6 3846.6 3851.5 3892.5 4064.2 4261.3 4298.5 4315.4 4319.7 5044.9 5059.8 5069.9 5109.3 5112.8 1219.8 1232.8 1258.5 1275.0 1278.3 827.9 855.4 864.8 865.4 868.7 4425.9 4428.7 4439.8 4445.6 4462.0 5128.6 5164.6 5170.8 5204.8 5212.9 4243.9 4418.5 4439.8 4484.7 4484.9 2724.2 2755.9 2788.8 2792.9 2798.2 4935.4 4949.9 4950.4 4954.5 4961.5 5125.5 5293.4 5349.7 5356.8 5366.8 4920.6 4922.2 4926.8 4937.4 4958.6 5109.6 5246.4 5255.8 5267.6 5270.3 5075.2 5104.4 5128.6 5132.3 5167.4 4906.4 4911.3 4928.4 4930.6 4940.6 3631.1 3649.4 3650.2 3661.1 3669.5 4993.7 5151.9 5161.6 5202.3 5226.5 5083.9 5092.8 5094.4 5101.7 5143.9 4838.9 5102.2 5106.6 5112.7 5124.9 4749.4 4802.7 4987.5 4995.7 5049.8 5062.5 5066.7 5079.3 5080.5 5096.3 4974.4 4978.0 4999.2 5030.1 5045.7 15:59:00 INFO - PROCESS | 11872 | 15:59:00 INFO - PROCESS | 11872 | [#5] yui.html Cycles:180 Average:15909.27 Median:494.36 stddev:21638.66 (4377.1%) stddev-sans-first:21668.96 15:59:00 INFO - PROCESS | 11872 | Values: 632.9 639.0 639.6 682.4 727.2 12292.9 13272.6 13280.7 13290.3 13300.8 13542.7 13585.3 13700.1 13704.3 13732.4 609.2 731.9 738.4 754.2 762.1 758.7 768.0 768.6 768.8 768.8 801.5 802.9 803.3 803.4 803.5 632.6 769.8 795.3 795.7 797.1 583.6 584.6 584.6 585.2 585.3 12248.2 12258.6 12285.3 12299.6 12328.3 11918.2 12279.5 12706.4 12790.4 13298.7 9817.4 9948.3 10752.8 10921.6 11036.3 4052.2 4070.6 4158.2 4227.7 4313.2 50597.5 52479.0 52633.9 57788.7 58088.0 10141.6 10387.4 10417.8 10450.6 10516.9 18226.2 18273.5 18315.4 18345.2 18346.3 6957.1 7002.7 7017.1 7028.3 7254.2 3860.4 3864.7 3887.7 3924.1 3984.9 2892.9 2988.5 3012.3 3020.2 3061.8 508.7 510.0 522.8 524.3 531.3 402.0 461.2 492.4 496.3 502.3 7549.2 7769.8 7891.3 7933.8 8004.5 465.4 469.5 499.1 499.3 507.9 3488.8 3640.5 3671.1 3731.3 3743.6 56980.0 75007.0 77604.0 78080.0 90828.0 77771.0 79163.0 80207.2 80239.0 80240.0 60021.0 61387.8 61635.7 72271.2 73513.0 7886.7 8331.8 8473.9 8568.6 8677.6 38576.8 38769.0 38777.0 39134.6 39521.6 39620.8 41775.0 53000.5 58500.7 59954.4 10062.5 10080.9 10084.7 10100.1 10128.1 11235.8 11266.7 11320.0 11654.7 12223.7 10579.7 10775.7 10815.2 10909.1 11189.8 10682.8 10722.7 11174.5 11272.3 11279.9 10827.7 11356.9 11461.3 11830.2 11833.9 8624.7 9071.0 9363.3 9541.1 10066.7 8535.1 8883.3 9147.9 9247.9 9327.9 15:59:00 INFO - PROCESS | 11872 | -------- Summary: end -------- 15:59:00 INFO - PROCESS | 11872 | 15:59:01 INFO - TEST-INFO | 11872: exit 0 15:59:01 INFO - TEST-OK | dromaeo_css | took 1121930ms 15:59:01 INFO - TEST-START | kraken 15:59:01 INFO - operating with platform_type : linux_ 15:59:01 INFO - Initialising browser for kraken test... 15:59:01 INFO - TEST-INFO | started process 12178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW_yukA/profile http://localhost:51502/getInfo.html) 15:59:05 INFO - PROCESS | 12178 | __metrics Screen width/height:1600/1200 15:59:05 INFO - PROCESS | 12178 | colorDepth:24 15:59:05 INFO - PROCESS | 12178 | Browser inner width/height: 1024/697 15:59:05 INFO - PROCESS | 12178 | __metrics 15:59:05 INFO - PROCESS | 12178 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:59:05 INFO - PROCESS | 12178 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:59:06 INFO - PROCESS | 12178 | console.error: PushService: 15:59:06 INFO - PROCESS | 12178 | stateChangeProcessEnqueue: Error transitioning state 15:59:06 INFO - PROCESS | 12178 | UnknownError 15:59:07 INFO - TEST-INFO | 12178: exit 0 15:59:07 INFO - Browser initialized. 15:59:07 INFO - Running cycle 1/1 for kraken test... 15:59:07 INFO - TEST-INFO | started process 12257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW_yukA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:19 INFO - PROCESS | 12257 | RSS: Main: 181637120 15:59:19 INFO - PROCESS | 12257 | 15:59:22 INFO - PROCESS | 12257 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51502/tests/kraken/driver.html?testName=audio-beat-detection) 15:59:22 INFO - PROCESS | 12257 | RSS: Main: 234647552 15:59:22 INFO - PROCESS | 12257 | 15:59:25 INFO - PROCESS | 12257 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51502/tests/kraken/driver.html?testName=audio-dft) 15:59:26 INFO - PROCESS | 12257 | RSS: Main: 225718272 15:59:26 INFO - PROCESS | 12257 | 15:59:29 INFO - PROCESS | 12257 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51502/tests/kraken/driver.html?testName=audio-fft) 15:59:30 INFO - PROCESS | 12257 | RSS: Main: 302858240 15:59:30 INFO - PROCESS | 12257 | 15:59:32 INFO - PROCESS | 12257 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51502/tests/kraken/driver.html?testName=audio-oscillator) 15:59:33 INFO - PROCESS | 12257 | RSS: Main: 213286912 15:59:33 INFO - PROCESS | 12257 | 15:59:35 INFO - PROCESS | 12257 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51502/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:59:35 INFO - PROCESS | 12257 | RSS: Main: 215449600 15:59:35 INFO - PROCESS | 12257 | 15:59:39 INFO - PROCESS | 12257 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51502/tests/kraken/driver.html?testName=imaging-darkroom) 15:59:39 INFO - PROCESS | 12257 | RSS: Main: 253616128 15:59:39 INFO - PROCESS | 12257 | 15:59:43 INFO - PROCESS | 12257 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51502/tests/kraken/driver.html?testName=imaging-desaturate) 15:59:43 INFO - PROCESS | 12257 | RSS: Main: 247652352 15:59:43 INFO - PROCESS | 12257 | 15:59:46 INFO - PROCESS | 12257 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51502/tests/kraken/driver.html?testName=json-parse-financial) 15:59:47 INFO - PROCESS | 12257 | RSS: Main: 250478592 15:59:47 INFO - PROCESS | 12257 | 15:59:49 INFO - PROCESS | 12257 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51502/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:59:49 INFO - PROCESS | 12257 | RSS: Main: 214331392 15:59:49 INFO - PROCESS | 12257 | 15:59:51 INFO - PROCESS | 12257 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51502/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:59:52 INFO - PROCESS | 12257 | RSS: Main: 222756864 15:59:52 INFO - PROCESS | 12257 | 15:59:54 INFO - PROCESS | 12257 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51502/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:59:55 INFO - PROCESS | 12257 | RSS: Main: 221659136 15:59:55 INFO - PROCESS | 12257 | 15:59:57 INFO - PROCESS | 12257 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:59:58 INFO - PROCESS | 12257 | RSS: Main: 223670272 15:59:58 INFO - PROCESS | 12257 | 16:00:01 INFO - PROCESS | 12257 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:00:02 INFO - PROCESS | 12257 | RSS: Main: 221802496 16:00:02 INFO - PROCESS | 12257 | 16:00:03 INFO - PROCESS | 12257 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51502/tests/kraken/driver.html?testName=ai-astar) 16:00:04 INFO - PROCESS | 12257 | RSS: Main: 272396288 16:00:04 INFO - PROCESS | 12257 | 16:00:04 INFO - PROCESS | 12257 | __start_tp_report 16:00:04 INFO - PROCESS | 12257 | _x_x_mozilla_page_load 16:00:04 INFO - PROCESS | 12257 | _x_x_mozilla_page_load_details 16:00:04 INFO - PROCESS | 12257 | |i|pagename|runs| 16:00:04 INFO - PROCESS | 12257 | |0;ai-astar;114;116;132;115;113;114;116;114;113;114 16:00:04 INFO - PROCESS | 12257 | |1;audio-beat-detection;155;124;151;206;122;153;153;126;190;129 16:00:04 INFO - PROCESS | 12257 | |2;audio-dft;161;162;163;162;160;161;161;162;162;163 16:00:04 INFO - PROCESS | 12257 | |3;audio-fft;76;83;77;178;76;77;76;76;158;76 16:00:04 INFO - PROCESS | 12257 | |4;audio-oscillator;84;84;144;82;82;84;147;83;84;138 16:00:04 INFO - PROCESS | 12257 | |5;imaging-gaussian-blur;117;117;118;118;118;116;117;117;118;118 16:00:04 INFO - PROCESS | 12257 | |6;imaging-darkroom;145;146;146;148;147;147;147;147;145;146 16:00:04 INFO - PROCESS | 12257 | |7;imaging-desaturate;95;95;96;95;96;96;96;96;95;96 16:00:04 INFO - PROCESS | 12257 | |8;json-parse-financial;64;64;65;64;67;67;66;66;64;66 16:00:04 INFO - PROCESS | 12257 | |9;json-stringify-tinderbox;69;69;68;68;68;67;69;69;69;68 16:00:04 INFO - PROCESS | 12257 | |10;stanford-crypto-aes;82;82;82;82;82;81;81;81;82;82 16:00:04 INFO - PROCESS | 12257 | |11;stanford-crypto-ccm;142;133;133;139;131;139;138;131;175;131 16:00:04 INFO - PROCESS | 12257 | |12;stanford-crypto-pbkdf2;174;173;173;170;173;172;172;173;173;172 16:00:04 INFO - PROCESS | 12257 | |13;stanford-crypto-sha256-iterative;70;74;70;71;74;68;69;74;68;68 16:00:04 INFO - PROCESS | 12257 | __end_tp_report 16:00:04 INFO - PROCESS | 12257 | __start_cc_report 16:00:04 INFO - PROCESS | 12257 | _x_x_mozilla_cycle_collect,2008 16:00:04 INFO - PROCESS | 12257 | __end_cc_report 16:00:04 INFO - PROCESS | 12257 | __startTimestamp1472598004137__endTimestamp 16:00:04 INFO - PROCESS | 12257 | 16:00:04 INFO - PROCESS | 12257 | ------- Summary: start ------- 16:00:04 INFO - PROCESS | 12257 | Number of tests: 14 16:00:04 INFO - PROCESS | 12257 | 16:00:04 INFO - PROCESS | 12257 | [#0] ai-astar Cycles:10 Average:116.10 Median:114.50 stddev:5.69 (5.0%) stddev-sans-first:5.98 16:00:04 INFO - PROCESS | 12257 | Values: 114.0 116.0 132.0 115.0 113.0 114.0 116.0 114.0 113.0 114.0 16:00:04 INFO - PROCESS | 12257 | 16:00:04 INFO - PROCESS | 12257 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:153.00 stddev:28.38 (18.5%) stddev-sans-first:30.06 16:00:04 INFO - PROCESS | 12257 | Values: 155.0 124.0 151.0 206.0 122.0 153.0 153.0 126.0 190.0 129.0 16:00:04 INFO - PROCESS | 12257 | 16:00:04 INFO - PROCESS | 12257 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 16:00:04 INFO - PROCESS | 12257 | Values: 161.0 162.0 163.0 162.0 160.0 161.0 161.0 162.0 162.0 163.0 16:00:04 INFO - PROCESS | 12257 | 16:00:04 INFO - PROCESS | 12257 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.00 stddev:38.66 (50.9%) stddev-sans-first:40.37 16:00:04 INFO - PROCESS | 12257 | Values: 76.0 83.0 77.0 178.0 76.0 77.0 76.0 76.0 158.0 76.0 16:00:04 INFO - PROCESS | 12257 | 16:00:04 INFO - PROCESS | 12257 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:83.50 stddev:28.94 (34.7%) stddev-sans-first:30.01 16:00:04 INFO - PROCESS | 12257 | Values: 84.0 84.0 144.0 82.0 82.0 84.0 147.0 83.0 84.0 138.0 16:00:04 INFO - PROCESS | 12257 | 16:00:04 INFO - PROCESS | 12257 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 16:00:04 INFO - PROCESS | 12257 | Values: 117.0 117.0 118.0 118.0 118.0 116.0 117.0 117.0 118.0 118.0 16:00:04 INFO - PROCESS | 12257 | 16:00:04 INFO - PROCESS | 12257 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:0.88 16:00:04 INFO - PROCESS | 12257 | Values: 145.0 146.0 146.0 148.0 147.0 147.0 147.0 147.0 145.0 146.0 16:00:04 INFO - PROCESS | 12257 | 16:00:04 INFO - PROCESS | 12257 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 16:00:04 INFO - PROCESS | 12257 | Values: 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 16:00:04 INFO - PROCESS | 12257 | 16:00:04 INFO - PROCESS | 12257 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:66.00 stddev:1.25 (1.9%) stddev-sans-first:1.24 16:00:04 INFO - PROCESS | 12257 | Values: 64.0 64.0 65.0 64.0 67.0 67.0 66.0 66.0 64.0 66.0 16:00:04 INFO - PROCESS | 12257 | 16:00:04 INFO - PROCESS | 12257 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 16:00:04 INFO - PROCESS | 12257 | Values: 69.0 69.0 68.0 68.0 68.0 67.0 69.0 69.0 69.0 68.0 16:00:04 INFO - PROCESS | 12257 | 16:00:04 INFO - PROCESS | 12257 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 16:00:04 INFO - PROCESS | 12257 | Values: 82.0 82.0 82.0 82.0 82.0 81.0 81.0 81.0 82.0 82.0 16:00:04 INFO - PROCESS | 12257 | 16:00:04 INFO - PROCESS | 12257 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:138.50 stddev:13.21 (9.5%) stddev-sans-first:13.97 16:00:04 INFO - PROCESS | 12257 | Values: 142.0 133.0 133.0 139.0 131.0 139.0 138.0 131.0 175.0 131.0 16:00:04 INFO - PROCESS | 12257 | 16:00:04 INFO - PROCESS | 12257 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:173.00 stddev:1.08 (0.6%) stddev-sans-first:1.00 16:00:04 INFO - PROCESS | 12257 | Values: 174.0 173.0 173.0 170.0 173.0 172.0 172.0 173.0 173.0 172.0 16:00:04 INFO - PROCESS | 12257 | 16:00:04 INFO - PROCESS | 12257 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.50 stddev:2.55 (3.6%) stddev-sans-first:2.69 16:00:04 INFO - PROCESS | 12257 | Values: 70.0 74.0 70.0 71.0 74.0 68.0 69.0 74.0 68.0 68.0 16:00:04 INFO - PROCESS | 12257 | -------- Summary: end -------- 16:00:04 INFO - PROCESS | 12257 | 16:00:05 INFO - TEST-INFO | 12257: exit 0 16:00:05 INFO - TEST-OK | kraken | took 64184ms 16:00:05 INFO - SUITE-END | took 1186s 16:00:05 INFO - Completed test suite (00:19:46) 16:00:05 INFO - javascript benchmark 16:00:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2608.256646855646, 2615.2807977806106, 2621.436391175897, 2662.1481126039675, 2678.9953767337247, 4550.294704320827, 4614.400127983357, 4675.953240467595, 4781.521847815221, 4801.975990120049, 4652.441706995157, 4659.301104834277, 4669.089527542131, 4693.55411235932, 4709.293605959099, 4357.150355680644, 4359.847405340814, 4378.759168245761, 4381.123775244948, 4396.230659634552, 4330.545292744264, 4388.144311859189, 4418.425604671388, 4427.446569178853, 4429.313456414261, 4416.447944006999, 4446.199684056868, 4468.151051300259, 4469.374287599739, 4471.754053527055, 4248.320268757015, 4358.803853826569, 4371.169477799208, 4394.296912494017, 4470.485894122153, 4246.214450326699, 4254.91490170198, 4261.616454519077, 4287.249731297011, 4315.978420107911, 4631.0, 4631.235846085426, 4649.976750116261, 4693.0, 4748.3114948332295, 5021.899562008776, 5040.092783299005, 5043.445221025684, 5047.848564543033, 5058.190689489701, 4894.216925291937, 4943.975280123613, 4959.0, 5051.494850514956, 5111.233315002779, 4688.390509233778, 4694.600958918462, 4697.882552936136, 4740.478547359788, 4745.027269409763, 5120.180771076684, 5166.586673066221, 5170.663906846043, 5171.741412929338, 5204.7918083277, 4838.588719958772, 4940.135476291634, 4941.876453088702, 4983.526564976321, 5007.073691367109, 5104.259882317043, 5120.206368012964, 5120.513551212629, 5160.638755287169, 5167.121589329823, 5032.345795046694, 5049.192129259301, 5061.063703214917, 5067.5185857343495, 5124.871878203075, 4870.09903167915, 4917.139500587383, 4932.580730637936, 5061.2661164131, 5068.0, 4254.744715317091, 4312.180685669713, 4315.8489452869, 4367.170237654836, 4371.256886329268, 3761.7931013793955, 3771.0949372150485, 3774.169682669808, 3796.335641262768, 3813.4851795007876, 4225.3873188387515, 4260.403543503912, 4308.676849236257, 4309.267424537773, 4347.369631403429, 5031.874203144951, 5032.169692000852, 5049.242613607915, 5100.6429549931145, 5117.2068329409, 4304.440422745023, 4311.9784401077795, 4314.1371725655, 4362.1493808707, 4364.650827933758, 4449.933251001237, 4530.252508336153, 4565.041341318294, 4566.337881007302, 4572.45130584332, 4724.314974328772, 4724.6456515760765, 4760.88097797544, 4820.662553621213, 4823.469418364048, 5044.646874718735, 5055.772490237875, 5059.392872855281, 5059.645824792229, 5116.462771408948, 4678.69588476748, 4697.553732395417, 4745.833895813768, 4770.141374552475, 4778.426588809365, 4949.653524253267, 4972.577330926912, 4997.0505603935135, 5024.29659847629, 5027.522385373383, 5038.395392552917, 5039.974800125976, 5041.722705251246, 5044.9243261350375, 5091.490850914879, 4823.638227133049, 4907.828226012072, 4922.975385123052, 4937.111319962298, 4998.775055122601, 4926.236433352836, 4951.306817045688, 4970.552650261494, 4971.776270067928, 5030.270610761346, 4901.3138160658245, 4903.632227582874, 4907.9263811043575, 4913.754312284443, 4978.253262010582, 4778.187708089564, 4808.0383923214795, 4812.542808433193, 4985.700857948535, 5076.82231121909, 4764.404449443819, 4776.379070720784, 4777.641676874317, 4832.395950506187, 4859.757012149307], "value": 4636.495745489486, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.1374281706031, 579.9884002319957, 580.3210244014502, 580.4137820800989, 583.5098517245513, 27826.0, 37973.81013094934, 38966.80516597417, 39085.21829563407, 42169.57830421695, 39090.21819563607, 39442.60557394425, 39515.40726889099, 39522.0, 39569.40645890314, 7466.104067511893, 7584.4690871639, 7604.391648668094, 7606.847863042736, 7621.237876212362, 7371.520851144685, 7445.925540744577, 7449.739259125931, 7450.888236676454, 7454.5899975501325, 7455.552666840007, 7481.064866891638, 7493.512921660102, 7495.175530691619, 7498.812529686774, 7440.55356678601, 7491.737789177353, 7492.213317601628, 7493.850122997564, 7499.51253168545, 7637.961810190914, 7702.922970770276, 7708.922910770877, 7710.0, 7711.113221979488, 37239.25521489555, 37565.43651845225, 37621.81189094064, 37646.81176594127, 37654.43518347227, 2946.6169397978124, 2957.5267957126757, 2965.584818125464, 2982.835944023078, 3007.9097627071224, 27100.864495677397, 27734.722652773416, 28696.569551456745, 28753.28116797076, 29045.854770726222, 3386.4920261960656, 3479.9826000869834, 3502.7548071634997, 3531.5055892175114, 3544.9645503544893, 262945.0, 266137.0, 266637.0, 266695.0, 267001.0, 55152.83013208257, 56303.873922522136, 56347.210487109056, 56392.43607563954, 56413.71793141008, 32800.67199328024, 33814.830925845214, 60015.09977350343, 60393.396066039655, 60480.69759651174, 14091.224982626054, 14396.712065758626, 14428.134311941318, 14432.278386080654, 14459.277036148362, 10514.421706806199, 10596.205284603686, 10615.52230149645, 10621.84067238992, 10651.520681569347, 18605.511559075243, 18646.923257662605, 18713.81286187148, 18919.716204256947, 18988.240470381308, 7309.817254568678, 7350.926490735131, 7372.631368431557, 7373.5575865448245, 7567.243275672388, 719.7907515374117, 818.5007145641155, 834.5410024486508, 850.6427300533791, 899.5322432335149, 25722.354117206047, 27200.1839944798, 27430.862845686042, 27475.31311717223, 27605.30986725348, 888.648983651454, 910.1399177776938, 926.7173512078881, 977.5307852230969, 1011.3577878047346, 13790.241536715377, 14294.428222871176, 14724.705505889822, 14820.925895370454, 14855.70288594222, 396769.0, 400284.0, 400557.0, 400562.0, 400849.0, 48338.75830620824, 48710.26934595984, 48734.53796386114, 48752.0, 48984.75507622439, 1100.5817789240039, 1116.8938950799661, 1135.534430883334, 1141.5833220874322, 1142.440204299887, 24729.25812225636, 26400.207993760218, 26942.59586106171, 27444.17667469979, 27595.31011724723, 41373.172536549704, 41555.168896622505, 41707.0, 41716.79141604394, 41780.791096044326, 328698.0, 329145.0, 329235.0, 329757.0, 331092.0, 25360.365990849637, 25701.228963131136, 25741.3564660885, 25812.22563323103, 25837.354066148495, 40166.598334016286, 40369.1926161481, 41586.58413415827, 41881.79059104685, 42066.7896660527, 34393.0, 34470.82764586161, 35007.0, 35905.46141807927, 36040.63959360478, 35054.12364690903, 35537.0, 35576.46635300524, 36016.819915900254, 36180.45729314115, 30061.54907676343, 34033.829830850686, 34550.65449345474, 34702.30595388129, 35939.0, 26794.97113149526, 32111.839440803582, 32240.516392253667, 32340.191495212806, 32441.51337729889, 24239.63640545358, 24457.877710611334, 24704.1353552632, 24944.251672449856, 25071.373215669755], "value": 17200.989077172148, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.9771815972883, 344.2512535235863, 346.14329534402356, 348.26516051132114, 365.76956517394035, 12478.2513049217, 15801.762973555406, 16583.502494925156, 16794.244259008345, 18135.818641813577, 15788.921055394736, 16023.599410014756, 16139.193040347995, 16225.594360141002, 16502.33990640373, 4925.433575138869, 4958.789876854459, 5051.696898186102, 5120.820771273006, 5122.8207012754565, 3655.872044478444, 4799.0, 5014.348134742497, 5664.971675141618, 5995.490383317423, 6005.669688167149, 6010.27876654802, 6018.879622407571, 6025.096235564679, 6025.758969641209, 5144.485551444863, 5393.406725260218, 5417.322834645669, 5527.032769265363, 6012.879742405149, 5322.414534401213, 5341.519263266286, 5342.866428339323, 5351.678899266057, 5361.571074314084, 11600.88399116015, 11828.645140645795, 12061.33662648554, 12108.273503589813, 12146.757064858653, 1690.5351028467146, 1723.172877019038, 1736.1753167245583, 1927.942161735136, 2309.5815751585546, 9033.819323613556, 9087.545622718904, 9259.166674999282, 9478.90521094787, 9587.280953928414, 1743.7820272465942, 1748.5628592851788, 1755.5962128710469, 1776.1740790532465, 1782.9108544572719, 68642.65678671625, 72222.63888680575, 72426.63786681033, 72710.27289727035, 73680.63159684221, 9517.524123793783, 9589.472579008221, 9681.322307438553, 9850.60597576089, 9915.760529933757, 12880.420381082873, 12881.09832311748, 12884.291363975071, 12895.419706113247, 12898.774616411614, 6871.244163142051, 7037.507374483839, 7040.401565866856, 7257.201707812136, 7295.854082918312, 6818.079559259536, 6854.2117656470145, 7023.578585284899, 7039.0, 7041.436685065182, 4018.6584140347813, 4049.1294371709637, 4051.149258655715, 4061.289274376972, 4134.428917011516, 1591.5782317685823, 1649.4391906751762, 1700.2348942975711, 1818.7999320074782, 1821.7358483019889, 738.5642470942063, 758.2531206761336, 809.3201710563037, 852.9616167272487, 853.7182729699184, 15772.11064569987, 16308.103054332125, 16590.17049147538, 16737.748933766004, 17368.65262694739, 792.8731402975496, 793.3296364571928, 805.7381351060928, 809.4576633655465, 837.4347315561971, 8771.31604726004, 9449.716508504756, 9452.243820494345, 9554.61781528731, 9699.0, 399624.0, 410282.0, 424862.0, 424967.0, 428257.0, 71963.64018179875, 73399.26600733925, 75914.0, 78182.0, 79742.0, 841.6170642357835, 849.2229609906866, 868.4789126524162, 868.7524055644237, 877.3156937588691, 14558.27208639585, 14659.120452772868, 15308.923455382652, 15407.679852879319, 15575.844241557892, 35443.0, 35884.28231435305, 36279.81860090682, 36843.63156368509, 37850.62149378581, 50824.0, 51057.489425105276, 51197.23204151866, 51800.222996654324, 51838.481615183366, 7256.637168141467, 7586.734464293723, 7703.691852325845, 7725.806854828675, 7807.804804879924, 8584.841046458898, 11075.612353567909, 11436.0, 11973.940130299292, 12032.398380081137, 9626.374285671409, 10039.04629060238, 10196.184305255414, 10590.735231619272, 10661.786764264827, 10003.2997690161, 10380.32527885685, 10641.574337026432, 10646.254762166574, 10685.893141068489, 10554.472276385997, 10631.94684026575, 10890.509927053143, 10912.836307455553, 10963.780724385628, 7585.6965721372735, 7754.340881025176, 7841.255080767318, 7850.214978502104, 7961.402894782798, 9197.586108625263, 10013.148882345082, 10198.388096714221, 10291.772444320819, 10733.892661073289], "value": 7959.787423559043, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.6310633022752, 1362.2235325864256, 1396.5251814383107, 1631.6818220447003, 1662.2021429713745, 6693.230278517972, 7049.506534542584, 7088.149422069352, 7614.086309642844, 7628.732994345199, 7200.927990720104, 7448.96275518623, 7451.292127247916, 7455.888161677565, 7458.738944136956, 2128.3082998025666, 2169.6420090685097, 2173.1850556041486, 2174.4018146662193, 2174.5759576882515, 1857.0621835972815, 2048.201201531404, 2109.9367018989456, 2111.5987962287195, 2145.1205005947563, 2143.7749036351192, 2169.739631244253, 2170.9891450542805, 2171.9891400542974, 2172.174573662014, 2066.8553201275918, 2091.1739862754125, 2096.360610013945, 2116.8094871461644, 2121.02432880875, 2068.4621998280554, 2081.6669332906813, 2093.5603523260133, 2096.0462989339812, 2101.516651170224, 7504.137024242227, 7527.548347099191, 7532.54804711719, 7534.54792712439, 7541.509801862861, 4272.166927449149, 4389.4513185851765, 4397.516273209944, 4403.625691816167, 4407.801648925774, 2747.4917140329103, 2856.22881821909, 2915.2420370703558, 2922.503174460347, 2928.8535573221466, 921.345844450441, 928.0951072704127, 945.1257586732245, 949.9192568631605, 954.2842867849113, 9897.4556399398, 9954.303198776017, 9988.850167247425, 9990.100890919779, 10014.3490673106, 3864.5942176071107, 3971.3645816669195, 4057.9391309130388, 4113.074558224435, 4123.546409894909, 7482.8877566836545, 7627.618619069024, 7628.923710762932, 7632.618369081523, 7636.618169091523, 4036.2129384769687, 4037.394390841397, 4042.9797851011144, 4043.0700938784244, 4043.433919251307, 3714.0, 3720.162963333228, 3721.888343349704, 3722.1997270586953, 3722.4230244312175, 3139.121046107048, 3265.6734326567152, 3326.534285200074, 3376.3416133854153, 3377.560917080764, 926.8239034583543, 932.5710173320349, 1034.6947650443137, 1054.035557464911, 1054.2304117993908, 578.6152208781198, 677.4140368581142, 789.403999980023, 790.8260182759899, 792.2948575767572, 4821.710697358169, 4873.951260487421, 4952.133376659071, 4965.652404331734, 5203.245529398216, 779.4154384211841, 807.2976510435841, 832.7168762620738, 848.7962888906618, 853.5561508015797, 3286.1620286826706, 3394.5417368654917, 3395.303962687643, 3462.23830757233, 3490.5462289902152, 8435.662573496991, 8970.730878073668, 8980.281577473786, 8980.955095224614, 8989.41568798026, 7867.173946735625, 8103.270705636521, 8376.204260595234, 8421.326293896474, 8665.913340866637, 6712.328767123347, 6833.384995350541, 6925.480588955848, 6929.203141638776, 6935.930640693528, 4984.526469985346, 4993.1012417763695, 5063.240513922941, 5076.213186956028, 5270.314859068297, 8172.18278172178, 8208.220219079178, 8282.0, 8351.081381048201, 8412.87380689278, 7974.0, 8194.05768336625, 8244.29923456513, 8495.957520212607, 8504.23461888433, 6194.349593292639, 6195.597286176564, 6359.586626869239, 6468.676566171766, 6537.05212744159, 6953.061336719478, 7018.368346848808, 7021.824454388681, 7072.646367681698, 7088.255733147946, 6211.689415529296, 6224.533160013108, 6335.841603959753, 6441.967790161019, 6453.774117905851, 6107.908381374372, 6208.906866397098, 6213.627182369072, 6241.531885108544, 6306.211723534559, 5734.283214598176, 5870.618409803349, 5897.056470964625, 5897.3807750187325, 5909.674967876808, 4150.086980864205, 4161.292580261303, 4178.206140833232, 4232.195882782262, 4317.676174286878, 4241.34259189826, 4252.638525725224, 4336.956630433655, 4375.190589740908, 4516.887077822949], "value": 3874.766904216538, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.5070252409544, 291.27617869594053, 292.3597321865114, 295.56404303652107, 299.1310243741929, 4721.197396442604, 4818.277258411232, 4881.997571493533, 4908.607311415087, 4919.803207871685, 4708.74101924394, 4815.831445899395, 4839.5644392004715, 4848.975755121228, 4849.6847704899155, 3813.8474461021524, 3814.332491813935, 3815.084379748868, 3832.3676593362134, 3847.7306588538813, 3657.4696668982983, 3711.7772933623933, 3820.9808950955344, 3828.2152158807376, 3839.289731399686, 3693.353663108945, 3763.6989040876665, 3769.8492060317553, 3774.320622288001, 3802.524684414448, 3727.7204209684382, 3759.4172903200047, 3762.454444105603, 3772.302124107049, 3785.4511095891216, 3287.8849240276713, 3311.7516186286125, 3318.6725309876, 3327.434336162858, 3334.7165490933057, 4530.682852200347, 4672.836450724209, 4692.55420735033, 4708.3285433671235, 4708.529147085264, 4306.655467562588, 4320.092780516095, 4336.85325763749, 4337.240982828024, 4344.044310251739, 5053.74731263439, 5061.342025536694, 5061.342025536694, 5083.440821509631, 5111.744412779346, 3555.8755443559353, 3653.269346130758, 3660.5058317127114, 3693.3351996640595, 3698.815059247054, 5310.230016647603, 5315.202719592054, 5326.6537675050995, 5340.679559226459, 5343.171808369709, 3789.9621003789607, 3806.544778617776, 3811.8094095295123, 3814.0, 3815.3132436161204, 3829.1193025604266, 3843.6348546888003, 3846.615338466187, 3851.4786659269994, 3892.4939757831867, 4064.1871625674985, 4261.318189089793, 4298.505671847715, 4315.417418648442, 4319.697621166488, 5044.9495505045215, 5059.82427556147, 5069.949300507022, 5109.335786347751, 5112.846614601568, 1219.804591500317, 1232.7842627540144, 1258.534342293339, 1274.955376561816, 1278.277773058219, 827.8592639251342, 855.4183155454226, 864.7677060189205, 865.4244927123392, 868.6829307302789, 4425.867223983286, 4428.734275943454, 4439.756868076944, 4445.5776701213335, 4462.0, 5128.640995130305, 5164.638475306692, 5170.793168273302, 5204.817831375959, 5212.869678257998, 4243.915121697611, 4418.513963464016, 4439.844605438794, 4484.708493947883, 4484.932726009048, 2724.1827451764393, 2755.917322480329, 2788.8466134362807, 2792.944141117166, 2798.230486616156, 4935.432425271139, 4949.925751113737, 4950.425778595182, 4954.504549545017, 4961.5286547777905, 5125.513076257749, 5293.364796224478, 5349.716068143617, 5356.7589458473685, 5366.838994830083, 4920.606351491872, 4922.21244600855, 4926.75366231687, 4937.40751109862, 4958.6281028923695, 5109.5912327013, 5246.396664383645, 5255.78976840922, 5267.631265811357, 5270.341207349082, 5075.2387141929, 5104.387473503203, 5128.615353848401, 5132.2814805926455, 5167.405748338989, 4906.435759887659, 4911.263310503453, 4928.383952005999, 4930.630202734737, 4940.580050695731, 3631.1466805300206, 3649.379605467024, 3650.178709790276, 3661.077934084627, 3669.4679271504947, 4993.700377977333, 5151.922721159111, 5161.561267292323, 5202.306362482528, 5226.503482169188, 5083.923741143812, 5092.770825312796, 5094.363204599425, 5101.693898365961, 5143.871403214949, 4838.903221935612, 5102.158143906214, 5106.642535022513, 5112.696262453051, 5124.948750512447, 4749.4063242094735, 4802.711837289774, 4987.501249874984, 4995.725235112103, 5049.84850454487, 5062.493750624908, 5066.670666406671, 5079.339685840817, 5080.491950805038, 5096.337476128079, 4974.403071631283, 4977.9502204978935, 4999.150144475375, 5030.144875371268, 5045.729421760149], "value": 3821.4716904250304, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.9240491141062, 638.9776357827477, 639.5906619763349, 682.4165338635466, 727.1855521815564, 12292.877071229284, 13272.601821945333, 13280.7343853123, 13290.335483225848, 13300.800487992688, 13542.729145417086, 13585.252811095386, 13700.109492882955, 13704.314784260798, 13732.382042808073, 609.2232403685292, 731.8792399254116, 738.4314078159828, 754.241986803262, 762.0550517358463, 758.7458201502476, 767.9539227646331, 768.6310570925959, 768.7808974442285, 768.8231706707461, 801.5070731500115, 802.8594995875727, 803.3412601666636, 803.3653413803089, 803.5259197073725, 632.5888172687744, 769.7652216074096, 795.2643804480861, 795.7493389582263, 797.0873350014231, 583.6410607476414, 584.5615788158881, 584.5820238529429, 585.242111465653, 585.2654918077785, 12248.203866748721, 12258.570950016707, 12285.262884226975, 12299.631011069681, 12328.32194229317, 11918.225315354473, 12279.508819647204, 12706.428210730539, 12790.360481975957, 13298.73921433349, 9817.361871478332, 9948.253880958957, 10752.838707419394, 10921.617743379024, 11036.282641628268, 4052.1895620875944, 4070.5929407059352, 4158.209940111369, 4227.7463352198965, 4313.1804957058375, 50597.49402506001, 52479.0, 52633.94732105375, 57788.71105644487, 58088.0, 10141.594336226615, 10387.37675739458, 10417.791644167226, 10450.581976720998, 10516.894831051592, 18226.179821908045, 18273.543161421072, 18315.35896243625, 18345.17446714901, 18346.266149353876, 6957.130358705162, 7002.719891204397, 7017.087778588751, 7028.297170283033, 7254.238304977901, 3860.4402361657403, 3864.71014673895, 3887.727859049896, 3924.117073658404, 3984.86052988144, 2892.898748543791, 2988.521766831605, 3012.29211135383, 3020.2449387653087, 3061.8315992620173, 508.67444835305434, 509.95410413063, 522.814400887687, 524.3393324411269, 531.3358302122347, 401.98794036178964, 461.1675924955488, 492.3943549434216, 496.3225197605243, 502.2892606961109, 7549.245075492407, 7769.805754856174, 7891.329237014918, 7933.761987140395, 8004.479708818908, 465.353159108839, 469.5234337147798, 499.1389852504401, 499.3209235439799, 507.908576456234, 3488.7732297401094, 3640.453931910182, 3671.100580357776, 3731.328360895065, 3743.6069212732273, 56980.0, 75007.0, 77604.0, 78080.0, 90828.0, 77771.0, 79163.0, 80207.19792802114, 80239.0, 80240.0, 60021.0, 61387.79183122478, 61635.6918215415, 72271.17559739538, 73513.0, 7886.695108641776, 8331.83336333282, 8473.865508461982, 8568.57157142153, 8677.566121694017, 38576.80711596424, 38769.0, 38777.0, 39134.6086539131, 39521.60478395294, 39620.801895990335, 41775.0, 53000.46999529955, 58500.707496462244, 59954.40045599488, 10062.496875156066, 10080.89919100829, 10084.747881302732, 10100.141487973604, 10128.139108175888, 11235.831462528233, 11266.66200014001, 11320.0, 11654.650360489199, 12223.69440763988, 10579.735506612396, 10775.730606734895, 10815.242932994615, 10909.072728818139, 11189.776204475702, 10682.8397574038, 10722.678319650424, 11174.497147628213, 11272.267302625303, 11279.887201128213, 10827.729306767078, 11356.94321528387, 11461.312321260752, 11830.231034982698, 11833.881661183623, 8624.655013799378, 9070.954645226731, 9363.250939924654, 9541.093596108358, 10066.69799906004, 8535.14324611702, 8883.289336852908, 9147.908520914973, 9247.861282080908, 9327.906720932975], "value": 6233.68269189367, "unit": "score"}], "name": "dromaeo_css", "value": 6232.362974136762, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 132.0, 115.0, 113.0, 114.0, 116.0, 114.0, 113.0, 114.0], "value": 116.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 151.0, 206.0, 122.0, 153.0, 153.0, 126.0, 190.0, 129.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 162.0, 160.0, 161.0, 161.0, 162.0, 162.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 77.0, 178.0, 76.0, 77.0, 76.0, 76.0, 158.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 144.0, 82.0, 82.0, 84.0, 147.0, 83.0, 84.0, 138.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 116.0, 117.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 145.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 67.0, 67.0, 66.0, 66.0, 64.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 68.0, 68.0, 67.0, 69.0, 69.0, 69.0, 68.0], "value": 68.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 82.0, 82.0, 81.0, 81.0, 81.0, 82.0, 82.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 133.0, 133.0, 139.0, 131.0, 139.0, 138.0, 131.0, 175.0, 131.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 173.0, 170.0, 173.0, 172.0, 172.0, 173.0, 173.0, 172.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 70.0, 71.0, 74.0, 68.0, 69.0, 74.0, 68.0, 68.0], "value": 70.6, "unit": "score"}], "name": "kraken", "value": 1582.3000000000002, "alertThreshold": 2.0}]} 16:00:05 INFO - Return code: 0 16:00:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:00:05 INFO - # TBPL SUCCESS # 16:00:05 INFO - Running post-action listener: _resource_record_post_action 16:00:05 INFO - [mozharness: 2016-08-30 23:00:05.929275Z] Finished run-tests step (success) 16:00:05 INFO - Running post-run listener: _resource_record_post_run 16:00:05 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408526848; Read time: 8; Write time: 287556 16:00:05 INFO - TinderboxPrint: CPU usage
13.0% 16:00:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:00:05 INFO - TinderboxPrint: I/O write bytes / time
408,526,848 / 287,556 16:00:05 INFO - TinderboxPrint: CPU idle
8,347.3 (87.0%) 16:00:05 INFO - TinderboxPrint: CPU user
1,202.2 (12.5%) 16:00:05 INFO - TinderboxPrint: Swap in / out
0 / 0 16:00:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113594368; Read time: 0; Write time: 80856 16:00:06 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 294932480; Read time: 0; Write time: 206700 16:00:06 INFO - Running post-run listener: _upload_blobber_files 16:00:06 INFO - Blob upload gear active. 16:00:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:00:06 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 16:00:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:00:07 INFO - (blobuploader) - INFO - Open directory for files ... 16:00:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:00:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:00:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:08 INFO - (blobuploader) - INFO - Done attempting. 16:00:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:00:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:00:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:12 INFO - (blobuploader) - INFO - Done attempting. 16:00:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:00:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:00:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:13 INFO - (blobuploader) - INFO - Done attempting. 16:00:13 INFO - (blobuploader) - INFO - Iteration through files over. 16:00:13 INFO - Return code: 0 16:00:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:00:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:00:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/63284ba78df2d6b8185b52dea5e5fee14738cc4118727b246051259b767ccf4f3566eca1ff93d2ab86ff00ff69ab56ddc883360965febdae6b5d0acf6a3b52a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9905ad565b55f2a0e29132b6b582d1a21d46c27630088b42e3449ddf23b89a11b6d98d1a91658de689dbdf364168380b71cc88ce34e01d7a39726f755ca322aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be1ad527ab7b95a26256e482dc5217e6e5d8e57d471b75d44af057beb1bf978c7e7a813dacddda2264cd29f0e839103f466a62f5193a71d8f29572dc4fd8a23d"} 16:00:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:00:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:00:13 INFO - Contents: 16:00:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/63284ba78df2d6b8185b52dea5e5fee14738cc4118727b246051259b767ccf4f3566eca1ff93d2ab86ff00ff69ab56ddc883360965febdae6b5d0acf6a3b52a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9905ad565b55f2a0e29132b6b582d1a21d46c27630088b42e3449ddf23b89a11b6d98d1a91658de689dbdf364168380b71cc88ce34e01d7a39726f755ca322aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be1ad527ab7b95a26256e482dc5217e6e5d8e57d471b75d44af057beb1bf978c7e7a813dacddda2264cd29f0e839103f466a62f5193a71d8f29572dc4fd8a23d"} 16:00:13 INFO - Running post-run listener: copy_logs_to_upload_dir 16:00:13 INFO - Copying logs to upload dir... 16:00:13 INFO - mkdir: /builds/slave/test/build/upload/logs 16:00:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.584957 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-30 16:00:12.933520) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 16:00:12.937502) ========= 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=31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/63284ba78df2d6b8185b52dea5e5fee14738cc4118727b246051259b767ccf4f3566eca1ff93d2ab86ff00ff69ab56ddc883360965febdae6b5d0acf6a3b52a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9905ad565b55f2a0e29132b6b582d1a21d46c27630088b42e3449ddf23b89a11b6d98d1a91658de689dbdf364168380b71cc88ce34e01d7a39726f755ca322aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be1ad527ab7b95a26256e482dc5217e6e5d8e57d471b75d44af057beb1bf978c7e7a813dacddda2264cd29f0e839103f466a62f5193a71d8f29572dc4fd8a23d"} build_url:https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/SV1G9fJsREmitS41qymFMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/63284ba78df2d6b8185b52dea5e5fee14738cc4118727b246051259b767ccf4f3566eca1ff93d2ab86ff00ff69ab56ddc883360965febdae6b5d0acf6a3b52a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9905ad565b55f2a0e29132b6b582d1a21d46c27630088b42e3449ddf23b89a11b6d98d1a91658de689dbdf364168380b71cc88ce34e01d7a39726f755ca322aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be1ad527ab7b95a26256e482dc5217e6e5d8e57d471b75d44af057beb1bf978c7e7a813dacddda2264cd29f0e839103f466a62f5193a71d8f29572dc4fd8a23d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 16:00:12.962690) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 16:00:12.962999) ========= 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=31acecf42b6a79ec49471d4a000001bb-1472594598.686784-332774006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 16:00:13.047816) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 16:00:13.048192) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 16:00:13.048488) ========= ========= Total master_lag: 0.19 =========