builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1480488156.99 results: success (0) buildid: 20161129140926 builduid: 82fb21ad50f846459b1bb3cb296d1682 revision: 746265e810c3ee8ece7314eb587f255c80bdfacb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 22:42:36.990153) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 22:42:36.990719) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 22:42:36.991051) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 22:42:37.017736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 22:42:37.018051) ========= 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=41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-29 22:42:37-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-11-29 22:42:37 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130894 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 22:42:37.164010) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 22:42:37.164477) ========= 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=41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019588 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 22:42:37.215169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 22:42:37.215532) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 746265e810c3ee8ece7314eb587f255c80bdfacb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 746265e810c3ee8ece7314eb587f255c80bdfacb --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=41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-29 22:42:37,287 truncating revision to first 12 chars 2016-11-29 22:42:37,288 Setting DEBUG logging. 2016-11-29 22:42:37,288 attempt 1/10 2016-11-29 22:42:37,288 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/746265e810c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 22:42:38,553 unpacking tar archive at: graphics-746265e810c3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.581946 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 22:42:38.811607) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 22:42:38.812001) ========= script_repo_revision: 746265e810c3ee8ece7314eb587f255c80bdfacb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 22:42:38.812420) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 22:42:38.812837) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 22:42:38.822542) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-29 22:42:38.823052) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:42:38 INFO - MultiFileLogger online at 20161129 22:42:38 in /builds/slave/test 22:42:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 22:42:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:42:38 INFO - {'append_to_log': False, 22:42:38 INFO - 'base_work_dir': '/builds/slave/test', 22:42:38 INFO - 'blob_upload_branch': 'Graphics', 22:42:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:42:38 INFO - 'branch': 'Graphics', 22:42:38 INFO - 'buildbot_json_path': 'buildprops.json', 22:42:38 INFO - 'config_files': ('talos/linux_config.py',), 22:42:38 INFO - 'default_actions': ('clobber', 22:42:38 INFO - 'read-buildbot-config', 22:42:38 INFO - 'download-and-extract', 22:42:38 INFO - 'populate-webroot', 22:42:38 INFO - 'create-virtualenv', 22:42:38 INFO - 'install', 22:42:38 INFO - 'run-tests'), 22:42:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:42:38 INFO - 'download_minidump_stackwalk': True, 22:42:38 INFO - 'download_symbols': 'ondemand', 22:42:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:42:38 INFO - 'tooltool.py': '/tools/tooltool.py', 22:42:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:42:38 INFO - '/tools/misc-python/virtualenv.py')}, 22:42:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:42:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:42:38 INFO - 'installer_path': 'installer.exe', 22:42:38 INFO - 'log_level': 'info', 22:42:38 INFO - 'log_name': 'talos', 22:42:38 INFO - 'log_to_console': True, 22:42:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:42:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:42:38 INFO - 'opt_config_files': (), 22:42:38 INFO - 'pip_index': False, 22:42:38 INFO - 'sps_profile': False, 22:42:38 INFO - 'sps_profile_interval': 0, 22:42:38 INFO - 'suite': 'dromaeojs', 22:42:38 INFO - 'system_bits': '32', 22:42:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:42:38 INFO - 'title': 'talos-linux64-ix-026', 22:42:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:42:38 INFO - 'use_talos_json': True, 22:42:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:42:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:42:38 INFO - 'work_dir': 'build'} 22:42:38 INFO - [mozharness: 2016-11-30 06:42:38.988436Z] Running clobber step. 22:42:38 INFO - Running pre-action listener: _resource_record_pre_action 22:42:38 INFO - Running main action method: clobber 22:42:38 INFO - rmtree: /builds/slave/test/build 22:42:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:42:39 INFO - Running post-action listener: _resource_record_post_action 22:42:39 INFO - [mozharness: 2016-11-30 06:42:39.453057Z] Finished clobber step (success) 22:42:39 INFO - [mozharness: 2016-11-30 06:42:39.453158Z] Running read-buildbot-config step. 22:42:39 INFO - Running pre-action listener: _resource_record_pre_action 22:42:39 INFO - Running main action method: read_buildbot_config 22:42:39 INFO - Using buildbot properties: 22:42:39 INFO - { 22:42:39 INFO - "project": "", 22:42:39 INFO - "product": "firefox", 22:42:39 INFO - "script_repo_revision": "default", 22:42:39 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 22:42:39 INFO - "repository": "", 22:42:39 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 22:42:39 INFO - "buildid": "20161129140926", 22:42:39 INFO - "pgo_build": "False", 22:42:39 INFO - "basedir": "/builds/slave/test", 22:42:39 INFO - "buildnumber": 13, 22:42:39 INFO - "slavename": "talos-linux64-ix-026", 22:42:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:42:39 INFO - "platform": "ubuntu64_hw", 22:42:39 INFO - "scheduler": "tests-graphics-linux64-talos", 22:42:39 INFO - "branch": "graphics", 22:42:39 INFO - "repo_path": "projects/graphics", 22:42:39 INFO - "revision": "746265e810c3ee8ece7314eb587f255c80bdfacb", 22:42:39 INFO - "stage_platform": "linux64", 22:42:39 INFO - "builduid": "82fb21ad50f846459b1bb3cb296d1682", 22:42:39 INFO - "slavebuilddir": "test" 22:42:39 INFO - } 22:42:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 22:42:39 INFO - Running post-action listener: _resource_record_post_action 22:42:39 INFO - [mozharness: 2016-11-30 06:42:39.455619Z] Finished read-buildbot-config step (success) 22:42:39 INFO - [mozharness: 2016-11-30 06:42:39.455706Z] Running download-and-extract step. 22:42:39 INFO - Running pre-action listener: _resource_record_pre_action 22:42:39 INFO - Running main action method: download_and_extract 22:42:39 INFO - mkdir: /builds/slave/test/build/tests 22:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:39 INFO - trying https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 22:42:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 22:42:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:42:40 INFO - Downloaded 1361 bytes. 22:42:40 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 22:42:40 INFO - Using the following test package requirements: 22:42:40 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 22:42:40 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:42:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:42:40 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:42:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:42:40 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:42:40 INFO - u'jsshell-linux-x86_64.zip'], 22:42:40 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:42:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:42:40 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 22:42:40 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:42:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:42:40 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:42:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:42:40 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:42:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:42:40 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:42:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:42:40 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:42:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 22:42:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:42:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:42:40 INFO - Http code: 200 22:42:40 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 22:42:40 INFO - x-amz-cf-id: py1VaoEXeqg9kLHbcJuqJKvNDFSkCUVwM-EOgbsHq0iUYFo2j5QKoA== 22:42:40 INFO - x-amz-version-id: QacKPrEFxAfp4Tvacba6U6VuJULtJils 22:42:40 INFO - Expected file size: 20217576 22:42:40 INFO - Obtained file size: 20217576 22:42:44 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:42:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 22:42:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:42:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:42:46 INFO - Http code: 200 22:42:46 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 22:42:46 INFO - x-amz-cf-id: gWfl_xUb8qOteFRIA7B2pGFpehax5z4JjKpnHezKak5by8laLFojig== 22:42:46 INFO - x-amz-version-id: QacKPrEFxAfp4Tvacba6U6VuJULtJils 22:42:46 INFO - Expected file size: 20217576 22:42:46 INFO - Obtained file size: 20217576 22:42:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 22:42:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:42:50 INFO - Fetch https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:42:51 INFO - Http code: 200 22:42:51 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 22:42:51 INFO - x-amz-cf-id: RYMZk7ZXPv3PBbQhBXXgBPjg7vCB12eT0yYl_Wqfjwp3sOuhy-SXmA== 22:42:51 INFO - x-amz-version-id: 1qv3F88JbEhDD0evDX95aVZa0UFCk6Uh 22:42:51 INFO - Expected file size: 14409702 22:42:51 INFO - Obtained file size: 14409702 22:42: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')]} 22:42:51 INFO - trying https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:42:51 INFO - Downloading https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:42:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:42:52 INFO - Downloaded 55682953 bytes. 22:42:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:42:52 INFO - mkdir: /builds/slave/test/properties 22:42:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:42:52 INFO - Writing to file /builds/slave/test/properties/build_url 22:42:52 INFO - Contents: 22:42:52 INFO - build_url:https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:42:53 INFO - Running post-action listener: _resource_record_post_action 22:42:53 INFO - Running post-action listener: set_extra_try_arguments 22:42:53 INFO - [mozharness: 2016-11-30 06:42:53.315822Z] Finished download-and-extract step (success) 22:42:53 INFO - [mozharness: 2016-11-30 06:42:53.316050Z] Running populate-webroot step. 22:42:53 INFO - Running pre-action listener: _resource_record_pre_action 22:42:53 INFO - Running main action method: populate_webroot 22:42:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:42:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:42:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:42:53 INFO - '--tppagecycles', 22:42:53 INFO - '7'], 22:42:53 INFO - 'tests': ['tsvgm']}}, 22:42:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:42:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:42:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:42:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:42:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:42:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:42:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:42:53 INFO - 'talos_options': ['--disable-e10s'], 22:42:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:42:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:42:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:42:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:42:53 INFO - 'talos_options': ['--disable-e10s'], 22:42:53 INFO - 'tests': ['damp', 'tps']}, 22:42:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:42:53 INFO - 'tests': ['damp', 'tps']}, 22:42:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:42:53 INFO - 'tests': ['dromaeo_dom']}, 22:42:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:42:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:42:53 INFO - 'tests': ['basic_compositor_video']}, 22:42:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:42:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:42:53 INFO - 'tests': ['a11yr', 22:42:53 INFO - 'ts_paint', 22:42:53 INFO - 'tpaint', 22:42:53 INFO - 'sessionrestore', 22:42:53 INFO - 'sessionrestore_no_auto_restore', 22:42:53 INFO - 'tabpaint']}, 22:42:53 INFO - 'other-e10s': {'tests': ['a11yr', 22:42:53 INFO - 'ts_paint', 22:42:53 INFO - 'tpaint', 22:42:53 INFO - 'sessionrestore', 22:42:53 INFO - 'sessionrestore_no_auto_restore', 22:42:53 INFO - 'tabpaint']}, 22:42:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:42:53 INFO - 'ts_paint', 22:42:53 INFO - 'tpaint', 22:42:53 INFO - 'sessionrestore', 22:42:53 INFO - 'sessionrestore_no_auto_restore', 22:42:53 INFO - 'tabpaint']}, 22:42:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:42:53 INFO - 'ts_paint', 22:42:53 INFO - 'tpaint', 22:42:53 INFO - 'sessionrestore', 22:42:53 INFO - 'sessionrestore_no_auto_restore', 22:42:53 INFO - 'tabpaint']}, 22:42:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:42:53 INFO - 'tests': ['a11yr', 22:42:53 INFO - 'ts_paint', 22:42:53 INFO - 'tpaint', 22:42:53 INFO - 'sessionrestore', 22:42:53 INFO - 'sessionrestore_no_auto_restore', 22:42:53 INFO - 'tabpaint']}, 22:42:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:42:53 INFO - 'tests': ['a11yr', 22:42:53 INFO - 'ts_paint', 22:42:53 INFO - 'tpaint', 22:42:53 INFO - 'sessionrestore', 22:42:53 INFO - 'sessionrestore_no_auto_restore', 22:42:53 INFO - 'tabpaint']}, 22:42:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:42:53 INFO - 'tests': ['tsvgx', 22:42:53 INFO - 'tsvgr_opacity', 22:42:53 INFO - 'tart', 22:42:53 INFO - 'tscrollx', 22:42:53 INFO - 'cart', 22:42:53 INFO - 'tsvg_static']}, 22:42:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:42:53 INFO - 'tsvgr_opacity', 22:42:53 INFO - 'tart', 22:42:53 INFO - 'tscrollx', 22:42:53 INFO - 'cart', 22:42:53 INFO - 'tsvg_static']}, 22:42:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:42:53 INFO - 'talos_options': ['--disable-e10s'], 22:42:53 INFO - 'tests': ['tp5o']}, 22:42:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:42:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:42:53 INFO - 'talos_options': ['--disable-e10s', 22:42:53 INFO - '--xperf_path', 22:42:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:42:53 INFO - 'tests': ['tp5n']}, 22:42:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:42:53 INFO - 'talos_options': ['--xperf_path', 22:42:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:42:53 INFO - 'tests': ['tp5n']}}, 22:42:53 INFO - 'talos.zip': {'path': '', 22:42:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:42:53 INFO - Running post-action listener: _resource_record_post_action 22:42:53 INFO - [mozharness: 2016-11-30 06:42:53.334985Z] Finished populate-webroot step (success) 22:42:53 INFO - [mozharness: 2016-11-30 06:42:53.335071Z] Running create-virtualenv step. 22:42:53 INFO - Running pre-action listener: _resource_record_pre_action 22:42:53 INFO - Running main action method: create_virtualenv 22:42:53 INFO - Creating virtualenv /builds/slave/test/build/venv 22:42:53 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 22:42:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:42:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:42:53 INFO - Using real prefix '/usr' 22:42:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:42:53 INFO - Installing distribute.............................................................................................................................................................................................done. 22:42:55 INFO - Installing pip.................done. 22:42:55 INFO - Return code: 0 22:42:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:42:56 INFO - Reading from file tmpfile_stdout 22:42:56 INFO - Output received: 22:42:56 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 22:42:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:56 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 0x7f7bc4a07e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25afb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d9fc0>, '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 0x27daec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27db350>, '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': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', '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 22:42:56 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 22:42:56 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 22:42:56 INFO - Using env: {'DISPLAY': ':0', 22:42:56 INFO - 'HOME': '/home/cltbld', 22:42:56 INFO - 'LANG': 'en_US.UTF-8', 22:42:56 INFO - 'LANGUAGE': 'en_US:en', 22:42:56 INFO - 'LOGNAME': 'cltbld', 22:42:56 INFO - 'MAIL': '/var/mail/cltbld', 22:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:56 INFO - 'MOZ_NO_REMOTE': '1', 22:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:56 INFO - 'NO_EM_RESTART': '1', 22:42:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:56 INFO - 'PWD': '/builds/slave/test', 22:42:56 INFO - 'SHELL': '/bin/bash', 22:42:56 INFO - 'SHLVL': '1', 22:42:56 INFO - 'TERM': 'linux', 22:42:56 INFO - 'TMOUT': '86400', 22:42:56 INFO - 'USER': 'cltbld', 22:42:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', 22:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:56 INFO - '_': '/tools/buildbot/bin/python'} 22:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:56 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 22:42:56 INFO - Cleaning up... 22:42:56 INFO - Return code: 0 22:42:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:56 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 0x7f7bc4a07e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25afb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d9fc0>, '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 0x27daec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27db350>, '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': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', '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 22:42:56 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 22:42:56 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 22:42:56 INFO - Using env: {'DISPLAY': ':0', 22:42:56 INFO - 'HOME': '/home/cltbld', 22:42:56 INFO - 'LANG': 'en_US.UTF-8', 22:42:56 INFO - 'LANGUAGE': 'en_US:en', 22:42:56 INFO - 'LOGNAME': 'cltbld', 22:42:56 INFO - 'MAIL': '/var/mail/cltbld', 22:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:56 INFO - 'MOZ_NO_REMOTE': '1', 22:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:56 INFO - 'NO_EM_RESTART': '1', 22:42:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:56 INFO - 'PWD': '/builds/slave/test', 22:42:56 INFO - 'SHELL': '/bin/bash', 22:42:56 INFO - 'SHLVL': '1', 22:42:56 INFO - 'TERM': 'linux', 22:42:56 INFO - 'TMOUT': '86400', 22:42:56 INFO - 'USER': 'cltbld', 22:42:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', 22:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:56 INFO - '_': '/tools/buildbot/bin/python'} 22:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:56 INFO - Downloading/unpacking psutil>=3.1.1 22:42:56 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 22:42:56 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 22:42:56 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 22:42:56 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 22:42:56 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 22:42:56 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 22:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:42:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:42:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:42:58 INFO - Installing collected packages: psutil 22:42:58 INFO - Running setup.py install for psutil 22:42:58 INFO - building 'psutil._psutil_linux' extension 22:42:58 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 22:42:58 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 22:42:58 INFO - building 'psutil._psutil_posix' extension 22:42:58 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 22:42:59 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 22:42:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:42:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:42:59 INFO - Successfully installed psutil 22:42:59 INFO - Cleaning up... 22:42:59 INFO - Return code: 0 22:42:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:42:59 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')]} 22:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:59 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')]} 22:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:59 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 0x7f7bc4a07e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25afb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d9fc0>, '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 0x27daec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27db350>, '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': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', '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 22:42:59 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 22:42:59 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 22:42:59 INFO - Using env: {'DISPLAY': ':0', 22:42:59 INFO - 'HOME': '/home/cltbld', 22:42:59 INFO - 'LANG': 'en_US.UTF-8', 22:42:59 INFO - 'LANGUAGE': 'en_US:en', 22:42:59 INFO - 'LOGNAME': 'cltbld', 22:42:59 INFO - 'MAIL': '/var/mail/cltbld', 22:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:59 INFO - 'MOZ_NO_REMOTE': '1', 22:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:59 INFO - 'NO_EM_RESTART': '1', 22:42:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:59 INFO - 'PWD': '/builds/slave/test', 22:42:59 INFO - 'SHELL': '/bin/bash', 22:42:59 INFO - 'SHLVL': '1', 22:42:59 INFO - 'TERM': 'linux', 22:42:59 INFO - 'TMOUT': '86400', 22:42:59 INFO - 'USER': 'cltbld', 22:42:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', 22:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:59 INFO - '_': '/tools/buildbot/bin/python'} 22:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:43:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:43:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:43:01 INFO - Installing collected packages: mozsystemmonitor 22:43:01 INFO - Running setup.py install for mozsystemmonitor 22:43:01 INFO - Successfully installed mozsystemmonitor 22:43:01 INFO - Cleaning up... 22:43:01 INFO - Return code: 0 22:43:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7bc4a07e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25afb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d9fc0>, '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 0x27daec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27db350>, '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': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', '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 22:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:43:01 INFO - Using env: {'DISPLAY': ':0', 22:43:01 INFO - 'HOME': '/home/cltbld', 22:43:01 INFO - 'LANG': 'en_US.UTF-8', 22:43:01 INFO - 'LANGUAGE': 'en_US:en', 22:43:01 INFO - 'LOGNAME': 'cltbld', 22:43:01 INFO - 'MAIL': '/var/mail/cltbld', 22:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:01 INFO - 'MOZ_NO_REMOTE': '1', 22:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:43:01 INFO - 'NO_EM_RESTART': '1', 22:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:43:01 INFO - 'PWD': '/builds/slave/test', 22:43:01 INFO - 'SHELL': '/bin/bash', 22:43:01 INFO - 'SHLVL': '1', 22:43:01 INFO - 'TERM': 'linux', 22:43:01 INFO - 'TMOUT': '86400', 22:43:01 INFO - 'USER': 'cltbld', 22:43:01 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', 22:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:01 INFO - '_': '/tools/buildbot/bin/python'} 22:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:01 INFO - Downloading/unpacking jsonschema==2.5.1 22:43:01 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 22:43:01 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 22:43:01 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 22:43:01 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 22:43:01 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 22:43:01 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 22:43:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:43:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:43:03 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 22:43:03 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 22:43:03 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 22:43:03 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 22:43:03 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 22:43:03 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 22:43:04 INFO - Downloading functools32-3.2.3-2.tar.gz 22:43:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:43:04 INFO - warning: no files found matching '*.txt' 22:43:04 INFO - no previously-included directories found matching 'build' 22:43:04 INFO - no previously-included directories found matching 'dist' 22:43:04 INFO - no previously-included directories found matching '.git*' 22:43:04 INFO - Installing collected packages: jsonschema, functools32 22:43:04 INFO - Running setup.py install for functools32 22:43:04 INFO - warning: no files found matching '*.txt' 22:43:04 INFO - no previously-included directories found matching 'build' 22:43:04 INFO - no previously-included directories found matching 'dist' 22:43:04 INFO - no previously-included directories found matching '.git*' 22:43:04 INFO - Successfully installed jsonschema functools32 22:43:04 INFO - Cleaning up... 22:43:04 INFO - Return code: 0 22:43:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7bc4a07e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25afb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d9fc0>, '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 0x27daec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27db350>, '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': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', '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 22:43:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:43:04 INFO - Using env: {'DISPLAY': ':0', 22:43:04 INFO - 'HOME': '/home/cltbld', 22:43:04 INFO - 'LANG': 'en_US.UTF-8', 22:43:04 INFO - 'LANGUAGE': 'en_US:en', 22:43:04 INFO - 'LOGNAME': 'cltbld', 22:43:04 INFO - 'MAIL': '/var/mail/cltbld', 22:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:04 INFO - 'MOZ_NO_REMOTE': '1', 22:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:43:04 INFO - 'NO_EM_RESTART': '1', 22:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:43:04 INFO - 'PWD': '/builds/slave/test', 22:43:04 INFO - 'SHELL': '/bin/bash', 22:43:04 INFO - 'SHLVL': '1', 22:43:04 INFO - 'TERM': 'linux', 22:43:04 INFO - 'TMOUT': '86400', 22:43:04 INFO - 'USER': 'cltbld', 22:43:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', 22:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:04 INFO - '_': '/tools/buildbot/bin/python'} 22:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:43:04 INFO - Cleaning up... 22:43:04 INFO - Return code: 0 22:43:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7bc4a07e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25afb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d9fc0>, '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 0x27daec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27db350>, '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': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', '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 22:43:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:43:04 INFO - Using env: {'DISPLAY': ':0', 22:43:04 INFO - 'HOME': '/home/cltbld', 22:43:04 INFO - 'LANG': 'en_US.UTF-8', 22:43:04 INFO - 'LANGUAGE': 'en_US:en', 22:43:04 INFO - 'LOGNAME': 'cltbld', 22:43:04 INFO - 'MAIL': '/var/mail/cltbld', 22:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:04 INFO - 'MOZ_NO_REMOTE': '1', 22:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:43:04 INFO - 'NO_EM_RESTART': '1', 22:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:43:04 INFO - 'PWD': '/builds/slave/test', 22:43:04 INFO - 'SHELL': '/bin/bash', 22:43:04 INFO - 'SHLVL': '1', 22:43:04 INFO - 'TERM': 'linux', 22:43:04 INFO - 'TMOUT': '86400', 22:43:04 INFO - 'USER': 'cltbld', 22:43:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', 22:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:04 INFO - '_': '/tools/buildbot/bin/python'} 22:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:04 INFO - Downloading/unpacking blobuploader==1.2.4 22:43:04 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 22:43:04 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 22:43:04 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 22:43:04 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 22:43:04 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 22:43:04 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 22:43:06 INFO - Downloading blobuploader-1.2.4.tar.gz 22:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:43:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:43:06 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 22:43:06 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 22:43:06 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 22:43:06 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 22:43:06 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 22:43:06 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 22:43:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:43:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:07 INFO - Downloading docopt-0.6.1.tar.gz 22:43:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:43:07 INFO - Installing collected packages: blobuploader, requests, docopt 22:43:07 INFO - Running setup.py install for blobuploader 22:43:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:43:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:43:07 INFO - Running setup.py install for requests 22:43:08 INFO - Running setup.py install for docopt 22:43:08 INFO - Successfully installed blobuploader requests docopt 22:43:08 INFO - Cleaning up... 22:43:08 INFO - Return code: 0 22:43:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:43:08 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')]} 22:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:08 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')]} 22:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:08 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 0x7f7bc4a07e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25afb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d9fc0>, '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 0x27daec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27db350>, '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': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', '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 22:43:08 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 22:43:08 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 22:43:08 INFO - Using env: {'DISPLAY': ':0', 22:43:08 INFO - 'HOME': '/home/cltbld', 22:43:08 INFO - 'LANG': 'en_US.UTF-8', 22:43:08 INFO - 'LANGUAGE': 'en_US:en', 22:43:08 INFO - 'LOGNAME': 'cltbld', 22:43:08 INFO - 'MAIL': '/var/mail/cltbld', 22:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:08 INFO - 'MOZ_NO_REMOTE': '1', 22:43:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:43:08 INFO - 'NO_EM_RESTART': '1', 22:43:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:43:08 INFO - 'PWD': '/builds/slave/test', 22:43:08 INFO - 'SHELL': '/bin/bash', 22:43:08 INFO - 'SHLVL': '1', 22:43:08 INFO - 'TERM': 'linux', 22:43:08 INFO - 'TMOUT': '86400', 22:43:08 INFO - 'USER': 'cltbld', 22:43:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', 22:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:08 INFO - '_': '/tools/buildbot/bin/python'} 22:43:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:43:08 INFO - Running setup.py (path:/tmp/pip-t0j9Kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:43:08 INFO - Running setup.py (path:/tmp/pip-crQJtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:43:08 INFO - Running setup.py (path:/tmp/pip-1GerOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:43:08 INFO - Running setup.py (path:/tmp/pip-2m28xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:43:08 INFO - Running setup.py (path:/tmp/pip-PGuuE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:43:08 INFO - Running setup.py (path:/tmp/pip-7NO8uB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:43:08 INFO - Running setup.py (path:/tmp/pip-CobAgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:43:08 INFO - Running setup.py (path:/tmp/pip-kwdoFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:43:09 INFO - Running setup.py (path:/tmp/pip-TH92DF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:43:09 INFO - Running setup.py (path:/tmp/pip-XUFYBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:43:09 INFO - Running setup.py (path:/tmp/pip-ZzzIKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:43:09 INFO - Running setup.py (path:/tmp/pip-uu03jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:43:09 INFO - Running setup.py (path:/tmp/pip-W9734s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:43:09 INFO - Running setup.py (path:/tmp/pip-PCLas0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:43:09 INFO - Running setup.py (path:/tmp/pip-94K3J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:43:09 INFO - Running setup.py (path:/tmp/pip-YT8ZzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:43:09 INFO - Running setup.py (path:/tmp/pip-XKJkQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:43:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:43:09 INFO - Running setup.py install for manifestparser 22:43:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:43:09 INFO - Running setup.py install for mozcrash 22:43:09 INFO - Running setup.py install for mozdebug 22:43:09 INFO - Running setup.py install for mozdevice 22:43:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:43:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:43:10 INFO - Running setup.py install for mozfile 22:43:10 INFO - Running setup.py install for mozhttpd 22:43:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:43:10 INFO - Running setup.py install for mozinfo 22:43:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:43:10 INFO - Running setup.py install for mozInstall 22:43:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:43:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:43:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:43:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:43:10 INFO - Running setup.py install for mozleak 22:43:10 INFO - Running setup.py install for mozlog 22:43:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:43:10 INFO - Running setup.py install for moznetwork 22:43:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:43:10 INFO - Running setup.py install for mozprocess 22:43:10 INFO - Running setup.py install for mozprofile 22:43:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:43:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:43:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:43:11 INFO - Running setup.py install for mozrunner 22:43:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:43:11 INFO - Running setup.py install for mozscreenshot 22:43:11 INFO - Running setup.py install for moztest 22:43:11 INFO - Running setup.py install for mozversion 22:43:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:43:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:43:11 INFO - Cleaning up... 22:43:11 INFO - Return code: 0 22:43:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:43:11 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')]} 22:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:11 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')]} 22:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:11 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 0x7f7bc4a07e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25afb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d9fc0>, '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 0x27daec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27db350>, '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': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', '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 22:43:11 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 22:43:11 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 22:43:11 INFO - Using env: {'DISPLAY': ':0', 22:43:11 INFO - 'HOME': '/home/cltbld', 22:43:11 INFO - 'LANG': 'en_US.UTF-8', 22:43:11 INFO - 'LANGUAGE': 'en_US:en', 22:43:11 INFO - 'LOGNAME': 'cltbld', 22:43:11 INFO - 'MAIL': '/var/mail/cltbld', 22:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:11 INFO - 'MOZ_NO_REMOTE': '1', 22:43:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:43:11 INFO - 'NO_EM_RESTART': '1', 22:43:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:43:11 INFO - 'PWD': '/builds/slave/test', 22:43:11 INFO - 'SHELL': '/bin/bash', 22:43:11 INFO - 'SHLVL': '1', 22:43:11 INFO - 'TERM': 'linux', 22:43:11 INFO - 'TMOUT': '86400', 22:43:11 INFO - 'USER': 'cltbld', 22:43:11 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', 22:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:11 INFO - '_': '/tools/buildbot/bin/python'} 22:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:43:11 INFO - Running setup.py (path:/tmp/pip-t4fgE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:43:11 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)) 22:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:43:11 INFO - Running setup.py (path:/tmp/pip-cUR96h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 22:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:43:11 INFO - Running setup.py (path:/tmp/pip-hefSLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:43:11 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)) 22:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:43:11 INFO - Running setup.py (path:/tmp/pip-vLKehs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 22:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:43:11 INFO - Running setup.py (path:/tmp/pip-IU39Q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:43:12 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)) 22:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:43:12 INFO - Running setup.py (path:/tmp/pip-Jup3ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:43:12 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)) 22:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:43:12 INFO - Running setup.py (path:/tmp/pip-IghrwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:43:12 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)) 22:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:43:12 INFO - Running setup.py (path:/tmp/pip-FjriR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:43:12 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)) 22:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:43:12 INFO - Running setup.py (path:/tmp/pip-lYLGwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:43:12 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)) 22:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:43:12 INFO - Running setup.py (path:/tmp/pip-yCAO58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:43:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:43:12 INFO - Running setup.py (path:/tmp/pip-USpEjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:43:12 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)) 22:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:43:12 INFO - Running setup.py (path:/tmp/pip-wyL9B7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:43:12 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)) 22:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:43:12 INFO - Running setup.py (path:/tmp/pip-r0ynBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:43:12 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)) 22:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:43:12 INFO - Running setup.py (path:/tmp/pip-HcXP7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:43:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 22:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:43:12 INFO - Running setup.py (path:/tmp/pip-9CkMK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:43:12 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)) 22:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:43:12 INFO - Running setup.py (path:/tmp/pip-MbpdxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:43:12 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)) 22:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:43:12 INFO - Running setup.py (path:/tmp/pip-REaWQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:43:12 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)) 22:43:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:43:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:43:12 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)) 22:43:12 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:43:12 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:43:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:14 INFO - Downloading blessings-1.6.tar.gz 22:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:43:14 INFO - Installing collected packages: blessings 22:43:14 INFO - Running setup.py install for blessings 22:43:15 INFO - Successfully installed blessings 22:43:15 INFO - Cleaning up... 22:43:15 INFO - Return code: 0 22:43:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:43:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:43:15 INFO - Reading from file tmpfile_stdout 22:43:15 INFO - Current package versions: 22:43:15 INFO - argparse == 1.2.1 22:43:15 INFO - blessings == 1.6 22:43:15 INFO - blobuploader == 1.2.4 22:43:15 INFO - docopt == 0.6.1 22:43:15 INFO - functools32 == 3.2.3-2 22:43:15 INFO - jsonschema == 2.5.1 22:43:15 INFO - manifestparser == 1.1 22:43:15 INFO - mozInstall == 1.12 22:43:15 INFO - mozcrash == 1.0 22:43:15 INFO - mozdebug == 0.1 22:43:15 INFO - mozdevice == 0.49 22:43:15 INFO - mozfile == 1.2 22:43:15 INFO - mozhttpd == 0.7 22:43:15 INFO - mozinfo == 0.9 22:43:15 INFO - mozleak == 0.1 22:43:15 INFO - mozlog == 3.4 22:43:15 INFO - moznetwork == 0.27 22:43:15 INFO - mozprocess == 0.23 22:43:15 INFO - mozprofile == 0.28 22:43:15 INFO - mozrunner == 6.13 22:43:15 INFO - mozscreenshot == 0.1 22:43:15 INFO - mozsystemmonitor == 0.3 22:43:15 INFO - moztest == 0.7 22:43:15 INFO - mozversion == 1.4 22:43:15 INFO - psutil == 3.1.1 22:43:15 INFO - requests == 1.2.3 22:43:15 INFO - wsgiref == 0.1.2 22:43:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:43:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:15 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 0x7f7bc4a07e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25afb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d9fc0>, '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 0x27daec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27db350>, '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': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', '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 22:43:15 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 22:43:15 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 22:43:15 INFO - Using env: {'DISPLAY': ':0', 22:43:15 INFO - 'HOME': '/home/cltbld', 22:43:15 INFO - 'LANG': 'en_US.UTF-8', 22:43:15 INFO - 'LANGUAGE': 'en_US:en', 22:43:15 INFO - 'LOGNAME': 'cltbld', 22:43:15 INFO - 'MAIL': '/var/mail/cltbld', 22:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:15 INFO - 'MOZ_NO_REMOTE': '1', 22:43:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:43:15 INFO - 'NO_EM_RESTART': '1', 22:43:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:43:15 INFO - 'PWD': '/builds/slave/test', 22:43:15 INFO - 'SHELL': '/bin/bash', 22:43:15 INFO - 'SHLVL': '1', 22:43:15 INFO - 'TERM': 'linux', 22:43:15 INFO - 'TMOUT': '86400', 22:43:15 INFO - 'USER': 'cltbld', 22:43:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', 22:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:15 INFO - '_': '/tools/buildbot/bin/python'} 22:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:15 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)) 22:43:15 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)) 22:43:15 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)) 22:43:15 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)) 22:43:15 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)) 22:43:15 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)) 22:43:15 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)) 22:43:15 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)) 22:43:15 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)) 22:43:15 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)) 22:43:15 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)) 22:43:15 INFO - Cleaning up... 22:43:15 INFO - Return code: 0 22:43:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:43:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7bc4a07e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25afb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d9fc0>, '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 0x27daec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27db350>, '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': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', '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 22:43:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:43:15 INFO - Using env: {'DISPLAY': ':0', 22:43:15 INFO - 'HOME': '/home/cltbld', 22:43:15 INFO - 'LANG': 'en_US.UTF-8', 22:43:15 INFO - 'LANGUAGE': 'en_US:en', 22:43:15 INFO - 'LOGNAME': 'cltbld', 22:43:15 INFO - 'MAIL': '/var/mail/cltbld', 22:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:15 INFO - 'MOZ_NO_REMOTE': '1', 22:43:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:43:15 INFO - 'NO_EM_RESTART': '1', 22:43:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:43:15 INFO - 'PWD': '/builds/slave/test', 22:43:15 INFO - 'SHELL': '/bin/bash', 22:43:15 INFO - 'SHLVL': '1', 22:43:15 INFO - 'TERM': 'linux', 22:43:15 INFO - 'TMOUT': '86400', 22:43:15 INFO - 'USER': 'cltbld', 22:43:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', 22:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:15 INFO - '_': '/tools/buildbot/bin/python'} 22:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:43:15 INFO - Cleaning up... 22:43:15 INFO - Return code: 0 22:43:15 INFO - Running post-action listener: _resource_record_post_action 22:43:15 INFO - Running post-action listener: _start_resource_monitoring 22:43:15 INFO - Starting resource monitoring. 22:43:15 INFO - [mozharness: 2016-11-30 06:43:15.862320Z] Finished create-virtualenv step (success) 22:43:15 INFO - [mozharness: 2016-11-30 06:43:15.862793Z] Running install step. 22:43:15 INFO - Running pre-action listener: _resource_record_pre_action 22:43:15 INFO - Running main action method: install 22:43:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:43:16 INFO - Reading from file tmpfile_stdout 22:43:16 INFO - Detecting whether we're running mozinstall >=1.0... 22:43:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:43:16 INFO - Reading from file tmpfile_stdout 22:43:16 INFO - Output received: 22:43:16 INFO - Usage: mozinstall [options] installer 22:43:16 INFO - Options: 22:43:16 INFO - -h, --help show this help message and exit 22:43:16 INFO - -d DEST, --destination=DEST 22:43:16 INFO - Directory to install application into. [default: 22:43:16 INFO - "/builds/slave/test"] 22:43:16 INFO - --app=APP Application being installed. [default: firefox] 22:43:16 INFO - mkdir: /builds/slave/test/build/application 22:43:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:43:32 INFO - Reading from file tmpfile_stdout 22:43:32 INFO - Output received: 22:43:32 INFO - /builds/slave/test/build/application/firefox/firefox 22:43:32 INFO - Running post-action listener: _resource_record_post_action 22:43:32 INFO - [mozharness: 2016-11-30 06:43:32.193802Z] Finished install step (success) 22:43:32 INFO - [mozharness: 2016-11-30 06:43:32.194044Z] Running run-tests step. 22:43:32 INFO - Running pre-action listener: _resource_record_pre_action 22:43:32 INFO - Running main action method: run_tests 22:43:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:43:32 INFO - Python 2.7.3 22:43:32 INFO - Return code: 0 22:43:32 INFO - grabbing minidump binary from tooltool 22:43: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')]} 22:43:32 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 0x27d9fc0>, '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 0x27daec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27db350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:43:32 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 22:43:32 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 22:43:32 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 22:43:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:43:32 INFO - Return code: 0 22:43:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:43:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:43:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:43:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:43:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:43:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 22:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 22:43:32 INFO - Using env: {'DISPLAY': ':0', 22:43:32 INFO - 'HOME': '/home/cltbld', 22:43:32 INFO - 'LANG': 'en_US.UTF-8', 22:43:32 INFO - 'LANGUAGE': 'en_US:en', 22:43:32 INFO - 'LOGNAME': 'cltbld', 22:43:32 INFO - 'MAIL': '/var/mail/cltbld', 22:43:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:43:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:32 INFO - 'MOZ_NO_REMOTE': '1', 22:43:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:43:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:43:32 INFO - 'NO_EM_RESTART': '1', 22:43:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:43:32 INFO - 'PWD': '/builds/slave/test', 22:43:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:43:32 INFO - 'SHELL': '/bin/bash', 22:43:32 INFO - 'SHLVL': '1', 22:43:32 INFO - 'TERM': 'linux', 22:43:32 INFO - 'TMOUT': '86400', 22:43:32 INFO - 'USER': 'cltbld', 22:43:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400', 22:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:32 INFO - '_': '/tools/buildbot/bin/python'} 22:43:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 22:43:32 INFO - mozversion application_buildid: 20161129140926 22:43:32 INFO - mozversion application_changeset: 746265e810c3ee8ece7314eb587f255c80bdfacb 22:43:32 INFO - mozversion application_display_name: Nightly 22:43:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:43:32 INFO - mozversion application_name: Firefox 22:43:32 INFO - mozversion application_remotingname: firefox 22:43:32 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 22:43:32 INFO - mozversion application_vendor: Mozilla 22:43:32 INFO - mozversion application_version: 53.0a1 22:43:32 INFO - mozversion platform_buildid: 20161129140926 22:43:32 INFO - mozversion platform_changeset: 746265e810c3ee8ece7314eb587f255c80bdfacb 22:43:32 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 22:43:32 INFO - mozversion platform_version: 53.0a1 22:43:32 INFO - using testdate: 1480488212 22:43:32 INFO - actual date: 1480488212 22:43:32 INFO - starting webserver on 'localhost:53209' 22:43:32 INFO - SUITE-START | Running 2 tests 22:43:32 INFO - TEST-START | dromaeo_css 22:43:32 INFO - operating with platform_type : linux_ 22:43:32 INFO - Initialising browser for dromaeo_css test... 22:43:32 INFO - TEST-INFO | started process 5627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyS211K/profile http://localhost:53209/getInfo.html) 22:43:37 INFO - PROCESS | 5627 | __metrics Screen width/height:1600/1200 22:43:37 INFO - PROCESS | 5627 | colorDepth:24 22:43:37 INFO - PROCESS | 5627 | Browser inner width/height: 1024/697 22:43:37 INFO - PROCESS | 5627 | __metrics 22:43:38 INFO - PROCESS | 5627 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:43:38 INFO - PROCESS | 5627 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:43:39 INFO - PROCESS | 5627 | console.error: PushService: 22:43:39 INFO - PROCESS | 5627 | stateChangeProcessEnqueue: Error transitioning state 22:43:39 INFO - PROCESS | 5627 | UnknownError 22:43:39 INFO - TEST-INFO | 5627: exit 0 22:43:39 INFO - Browser initialized. 22:43:39 INFO - Running cycle 1/1 for dromaeo_css test... 22:43:39 INFO - TEST-INFO | started process 5709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyS211K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:43:52 INFO - PROCESS | 5709 | RSS: Main: 175144960 22:43:52 INFO - PROCESS | 5709 | 22:44:43 INFO - PROCESS | 5709 | 1480488283637 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] 22:46:56 INFO - PROCESS | 5709 | Cycle 1(1): loaded http://localhost:53209/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53209/tests/dromaeo/cssquery-ext.html) 22:46:58 INFO - PROCESS | 5709 | RSS: Main: 357474304 22:46:58 INFO - PROCESS | 5709 | 22:50:01 INFO - PROCESS | 5709 | Cycle 1(1): loaded http://localhost:53209/tests/dromaeo/cssquery-ext.html (next: http://localhost:53209/tests/dromaeo/cssquery-jquery.html) 22:50:02 INFO - PROCESS | 5709 | RSS: Main: 278495232 22:50:02 INFO - PROCESS | 5709 | 22:53:04 INFO - PROCESS | 5709 | Cycle 1(1): loaded http://localhost:53209/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53209/tests/dromaeo/cssquery-mootools.html) 22:53:05 INFO - PROCESS | 5709 | RSS: Main: 223150080 22:53:05 INFO - PROCESS | 5709 | 22:56:07 INFO - PROCESS | 5709 | Cycle 1(1): loaded http://localhost:53209/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53209/tests/dromaeo/cssquery-prototype.html) 22:56:08 INFO - PROCESS | 5709 | RSS: Main: 221401088 22:56:08 INFO - PROCESS | 5709 | 22:59:11 INFO - PROCESS | 5709 | Cycle 1(1): loaded http://localhost:53209/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53209/tests/dromaeo/cssquery-yui.html) 22:59:12 INFO - PROCESS | 5709 | RSS: Main: 221638656 22:59:12 INFO - PROCESS | 5709 | 23:02:14 INFO - PROCESS | 5709 | Cycle 1(1): loaded http://localhost:53209/tests/dromaeo/cssquery-yui.html (next: http://localhost:53209/tests/dromaeo/cssquery-dojo.html) 23:02:15 INFO - PROCESS | 5709 | RSS: Main: 314142720 23:02:15 INFO - PROCESS | 5709 | 23:02:15 INFO - PROCESS | 5709 | __start_tp_report 23:02:15 INFO - PROCESS | 5709 | _x_x_mozilla_page_load 23:02:15 INFO - PROCESS | 5709 | _x_x_mozilla_page_load_details 23:02:15 INFO - PROCESS | 5709 | |i|pagename|runs| 23:02:15 INFO - PROCESS | 5709 | |0;dojo.html;2552.3108760634623;2640.867956602169;2659.867006649667;2665.560182569876;2674.8528830914292;4579.633629309656;4663.556962088604;4663.603593694535;4674.158651442739;4695.741734204617;4685.9062818743605;4694.483606803257;4695.90608187836;4706.152892479352;4708.058388322341;4295.59191876772;4318.287482565373;4326.415933848922;4362.0621566363225;4363.258246098171;4339;4358.346248062784;4362.280223763091;4365.759883206422;4378.190034843564;4270.636995855356;4272.2950713132295;4281.614654681078;4336.176126535964;4375.868723938287;4357.607815296638;4361.105973275471;4362.083962367875;4370.650347972186;4411.00752330723;4193.748375097504;4223.303154979425;4230.302000169968;4290.871273861789;4328.307470804688;4584.40402747644;4604.493505714368;4624.05206932578;4628.907421851578;4634.83778067766;4937.1606826839525;4969.378827646544;4982.6013918886765;4998.025385049917;5021.6735912165595;4859.514048595148;4908.558229759303;4996.625253105995;5001.999600079962;5038.823641172541;4576.88557786058;4609.516000819933;4613.700109492872;4644.349791029259;4657.580817726353;5053.519915608012;5054.469280725544;5058.620603454756;5065.088284108822;5109.3613298337705;4844.95155048452;4848.17581011229;4850.417949846041;4855.247436647254;4909.582685471703;4827.25177597473;4865.9756701216975;4867.7322747249245;4922.926156107661;4927.113119638428;4833.927491087637;4877.804887804519;4892.339534162914;4901.387326584177;4902;4858.708477491362;4890.682105663121;4911.631627627942;4928.137575924199;4938.456769755324;4190.455240818674;4199.370094485852;4227.281362168439;4236.406903033578;4237.724547904377;3683.852645894188;3686.262747450467;3690.4833323334756;3712.350338690718;3721.7580857244193;4193.1194449165405;4245.320748680197;4321.092570560155;4325.1565944641125;4355.041890784022;4955.554000140005;4959.553640172402;4963.081829861487;4984.028114517707;5063.038022775734;4317.568243175658;4323.113761678911;4327.2643650579475;4327.870163895088;4366.410534577855;4472.239719247736;4476.239039363316;4481.311213272076;4482.7534485602955;4522;4539.16025535277;4571.954280457286;4574.245249533789;4673.065386922561;4698.92951605733;4984.40187177541;4984.775685094107;5005.074061298671;5008.824691135793;5059.797608095782;4693.108309421199;4699.6240300776535;4701.529847015271;4702.600278976189;4749.073930583503;4774.665773395829;4787.066522028171;4793.784279707491;4904.362432883702;4960.057589058211;4869.488703686062;4913.9017219656125;4920.606351491943;4922.704637721748;4923.852284431473;4801.423829140525;4804.855854324376;4808.61531077506;4808.927866081942;4809.470958194526;4808.879778005438;4809.254565542346;4811.78346974394;4816.362436771515;4817.229243321051;4710.222813235915;4727.739974301447;4746.33551302811;4755;4757.785899634456;4903.95096049035;4904.950950490592;4909.754512274443;4927.9507204927495;4956.231784073474;4795.088933102699;4799.784009719501;4802.903941921212;4834;4842.757862106951 23:02:15 INFO - PROCESS | 5709 | |1;ext.html;554.7475898466198;558.6592178770951;558.8826346467241;560.1262031231277;570.8801151758131;27446.31384215393;37019.44470832936;38238.61761382389;38496;42248.577514224846;38355.808220958854;39003.21993560127;39111;39220.60779392205;39222.41166382506;7383.5200711953685;7541.095068591777;7546.54720716756;7550.433717471212;7552.358049565793;7335;7529;9571.712848614552;9894.060064293917;9895.455749933752;9721.854172187423;9749.95125024374;9776.266779991494;9778.266630002743;9779.11987921087;9339.673111441101;9378.109079637423;9388.155066044088;9395.201407880339;9406.153446189808;9726.75683107928;9803.705888823346;9808.509574521246;9812.067853553901;9813.313068085237;36208.27583448316;36403.635963640554;36471.27057458836;36552.63447365519;36554.086147846254;2919.5328747400313;2971.272038350618;2971.450281697893;3148.4962406015156;3164.161497203243;27422.5886611701;27885;28232.15303540897;28733.856330718212;29005.12984610465;3318.5188147718445;3362.4788157835574;3407.386670399327;3439.8108104054268;3539.026767638894;232424;233878.9999999983;235022;236647;240556;51408.714782130744;51813.740931295855;51882.74058629683;51933;52419.475805242226;53979.19031214535;53995.46004539983;54067.188992165145;54108;54119.45880541144;11757.882421175678;11885.168038237412;11899.940500297444;11926.761464770656;11948.940255298668;8141.51150930946;8288.8342233155;9981.401115932922;10123.1901447884;10145.543450544596;16119.838801611833;16265.674686506203;16511.33954641825;16938.23777929996;16960.982341059575;5417.620766546383;5494.615376923657;5572.832815015556;5606.6916319602815;5663.461971112738;685.8411465043934;757.6590534259606;811.3063330852036;849.7663142635824;871.6339137562239;26663.866680666473;27153.321166970985;27310.45379092407;27649.170524883884;28879.7112028877;897.3225214962662;934.6962237272913;942.2509105261197;955.6607404371487;959.3045042344245;13832.198421869669;14620.268986550629;14711;14721.11673299584;14877;359442;361788;361950;362663;362811;47131.764341178074;47295;47378.289325660146;47436;47501.76249118732;998.2962011781676;1049.2655141401049;1066.0991462214417;1083.2254937719254;1173.9823902641467;27096.864515677295;28265.858670707337;28906.27734306659;28932.42135157327;29071.563926540697;41106.177876442904;41588.79205603953;41607.79196104;41610.58389416067;41674.58325416707;273337;273958;276289;276906;277010;22873;23805.047798087882;23809.642855356837;23820.404489887893;25086.74913250844;39113.21773564456;39254.6074539251;39256;39588.406173906835;40056.1988760229;33663.15842103967;34240;34404.13989650179;34466.82766586151;35042.824785875906;30469.847650761603;30687.386252274384;30781.538276926312;30786.84606576953;31530.842345788125;31633.841830791618;31674.36651267008;31813.5227971576;35094.12264693403;35145.64854351424;29398.706012940453;31170.532442013842;32022.839885800422;32063.679363207004;32330.515042273913;23967.52064958726;24380.26859194227;24418.75581244236;24631.87684061568;24768.628470573316 23:02:15 INFO - PROCESS | 5709 | |2;jquery.html;315.52670993509736;342.45891491443524;345.1302717152775;347.86954891915525;368.655307287686;12514.937425312872;13438.798418023725;15617.375304987801;15873.52379428619;16344.101074440901;16008.199590020511;16026.35894564216;16039.83960160398;16164.35342586298;16278.104704241292;4181.954511372157;4857.805687772485;5129.487051294859;5129.897402051956;5132.178851383779;4940.308356830046;5026.497350264981;5050.116229659813;5053.191489361703;5054.418741844698;5019.64862459628;5021.799128034874;5026.145555255597;5026.899462010758;5028.396592408916;4823.782929768169;4976.925346119811;4980.626453016038;5005.174146265862;5005.674631149;4489.73061616304;4494.5730155635165;4495.730256184606;4496.505384407713;4496.752678602676;19478.00700856321;19824.405267841987;19966.60066798656;20141;20217.393478195532;1930.7200455933812;1968.6062787442568;1978.584497255578;2016.25398602518;2050.805173508514;12264.509419623204;12408.966234748917;12410.503579856795;13452.1256118352;13488.797668034988;1667.158085166995;1715.9485215443433;1768.1336145288844;1789.2127463915836;1792.5339411752907;55932.44067559313;65083;65609.3439065608;66996;67523.66238168826;9447.196988256075;9489.857652135224;9565.521723913776;9639.759006024766;9858.45778482176;12861.61415157528;12894.097413181174;12902.67743306406;12907;12922.224666520038;6750.831229219309;6751.358620931003;6917.51577389588;6921.377076063078;6964.199117101497;6182.876342473125;6249.875022495994;6296.496280297565;6399.232092148879;6469.7412103515335;5218.66078704883;5592.5246354059545;5624.521915637135;6019.69901504923;6077.392260773887;1651.8513333800015;1700.0819557439092;1702.5147832867574;1750.9299628014737;1803.089439832876;807.3016840432983;817.6320655704837;825.0882774534053;836.481381543447;847.635516727813;15866.9206653966;16418.507444776675;16560.337586496647;16836.326546937984;17603.471895843144;787.2127872127872;824.4270232188692;840.815020695446;862.4695812075529;867.9169992019079;8815.911840881638;9237.491937943343;9353.25173986093;9404.670836520689;9461.763455913657;367934;369276;370973;372266;373664;76114.23885761182;87191.56404217938;91305.54347228355;91808.54095729478;92341.53829230946;846.95341756204;893.4282059481936;896.090468174803;903.6566104880103;907.2968449451596;15070.924645376703;15226.619334516725;15507.534773956799;15926.442574509836;16224.756628650815;38689.41965870571;39013;39382;39849.80075099606;40757.38863916984;50690.23964640607;50913;51248;51394;53651.490235868565;7242.529235599669;7284.299153057908;7450.478466507509;7486.812829679302;7531.8117047074265;9876.308658393844;11310.547578096784;11517.136214783757;11696.35670038156;11851.525938962344;9771.511424428609;9793.363431376938;9960.601575937171;10499.107575855833;10581.31221470602;10015.198784097109;10043.949780251052;10402.323848949794;10519.368837869752;10639.202059845387;10155.441450719985;10445.373277603368;10787.514561844893;10862.565497380016;11026.834597480884;7278.599677017814;7346.191918889025;7365.484416090822;7433.591152486449;7732.729354472792;10588.4705764713;10607.522661480098;10708.839367409651;10791.730206744895;10843.67468975932 23:02:15 INFO - PROCESS | 5709 | |3;mootools.html;1255.4789762248668;1314.3493970484608;1359.6125104345263;1647.211413748379;1647.43163608555;6563.343665633441;6969.895451568224;6977.30226977302;6982.9301706982915;6991.965040174792;5659.717014149297;5795.565332600061;6466.191726034246;6766.627835469048;6892.379685828275;2041.214132558968;2069.7205877206534;2072.5958438104576;2075.9065842037144;2076.3667081540125;1941.5243265399997;1993.4119434766778;2003.3388981636026;2061.124022290528;2065.442330570745;1731.1084791332473;1783.4203883737773;1975.4863735428748;2028.229272876305;2032.7967203279702;2017.1427143463968;2024.888631125295;2031.3398145602591;2031.603837251744;2032.9491762705902;1984.5832375201226;1989.7015447682963;2035.847311451647;2037.0425899827057;2042.2035406191596;6646.401823835878;6717.798466046026;6730.427913627347;6893.241743408221;6980.930190698079;4081.08175660477;4209.452771139763;4211.4525111735275;4212.220739163234;4219.092895027584;2583.32833463299;2756.1180422264883;2795.0357126791223;2806.1441260415563;2827.067067867599;837.2213841127749;873.9912600873973;885.588201486312;902.3187493442474;903.3766700976371;8967.730968070968;9047.68333108338;9070.909290907073;9077.273818094536;9085.727428177099;3589.039042789709;3681.3557627415094;3769.2838360711376;3786.261678972574;3789.7157713171073;7827.569483678452;7841.607919603997;7869.606519674108;7877.842443151105;7879.487833290817;4108.322126849036;4117.464729585135;4139.523954745183;4144.585541445831;4147.108371700099;3670.0274427276795;3750.624937506282;3760.52993375828;3762.4920635714375;3772.660460558563;3254.8047117173046;3270.689284517967;3332.9166770830925;3334.749893757978;3469.3408252432464;1081.864766904137;1088.3850624397348;1092.5247517329988;1101.1136035491506;1108.196557495809;653.3956090616161;718.3642476408417;728.9671964761599;751.2600088912417;754.2758951406602;4324.783760811947;4363.8565098080035;4407.735535867858;4410.095930334273;4541.84103556374;357.2266044014679;372.4060124102107;377.15705398434477;399.4707013207512;402.89121937077414;3081.368319494543;3095.1797773590015;3114.672959339282;3184.2676184477236;3262.4780035194253;7323.743668971667;7824.061112666516;7869.48848324857;7891;7904.446688731734;7839.804004899923;7859.4891332063235;7862.803429914298;7865.331446827084;7878.487898286593;6162.599431036968;6237.937620623827;6242.594231374856;6282.403171698681;6313.43179113882;4424.889377765581;4434.113177364605;4483.596476317147;4485.753283569435;4587.371483123577;7294.96352518234;7314.195438501654;7345.338919497271;7348.853022939618;7450.627468626655;7230.674619642024;7596.126445458843;7614.124375696644;7615.162332143349;7621.123570789208;5698.430156984268;5905.202797622266;5922.526197904243;5923.940760592512;5927.881442371215;6495.317991611002;6550.672466376567;6556;6559.409653131241;6565.048068030204;4848.466668666514;5655.85860353478;5671.546276297804;5838.4453476919625;5887.0580707086665;5693.715314234189;5756.625819321731;5784.595078344475;5864.882702345843;5938.257717785277;5360.973195133999;5454.809081682122;5457.290552228185;5457.399686034453;5460;3827.2536855312946;3906.7069969751815;3977.2045590882517;3984.5019372578427;4011.7793521356607;3757.455169000534;3930.665893399093;4042.211768705074;4066.9389959150044;4094.2835003873606 23:02:15 INFO - PROCESS | 5709 | |4;prototype.html;267.59192231846436;270.96612923384583;274.310110073166;280.19164709812196;286.2857171357463;4861.270809378595;4871.585915197204;4889.168841296979;4900.338454308671;4909.779059942302;4740.293494342042;4770.427548694153;4772.6181905447565;4779.450363208232;4809.398825146856;3544.5214895989097;3603.261331427051;3659.780413175218;3734.860867435431;3779.3764028935193;3705.4441833725023;3724.9068773280615;3727.3599616168935;3731.6081811409817;3755.5493340799144;3698.39119982807;3701.38927077032;3707.258548290339;3708.2954238694697;3709.9443508347395;3533.4169861972746;3591.191981804099;3622.4023036198996;3709.777413355194;3714.4428335749585;3261.7879837810465;3265.1837040739815;3270.1988012936745;3279.0818570800216;3285.88060700849;4583.587477127041;4614.531225794218;4615.884602884921;4623.491415944243;4659.18464268755;4252.638525725317;4275.551067137968;4276.486821581399;4281.7002809803325;4291.957080429218;4792.771361317004;4974.50764770571;4980.427250866124;4995;5012.77442515084;3466.4107101792756;3467.4105402081705;3471.427214509603;3477.2002439438816;3477.2176260341475;5241.475852414766;5245.763940622643;5247.160454327328;5275.129603615399;5292.153255479105;3474.6699063588917;3512.2624248908014;3545;3547.237343971007;3584.8207589620415;3577.5689724110566;3589.820508974593;3597.2985267872514;3597.730170237243;3602.2075143468396;4165.604267594574;4169.395437661522;4170.061736109351;4170.52039015511;4180.686448516312;4825.420949486084;5064.974675126601;5069.5690866276045;5081.771320290596;5086.974565127225;1193.3257709394338;1213.696575856036;1220.395904027512;1221.3343727668441;1224.381687247934;800.2314884106074;811.0672726364728;818.251300060438;826.404988408345;828.8756686496953;4316.352547117957;4317.481902171697;4335.588119128741;4369.497507786646;4436.44544431946;5119.206522988943;5177.870553236199;5211.973940130275;5229.163333866563;5233.424323324507;4470.463544374696;4472.530384309665;4492.865214043584;4493.707908985905;4495.910081798345;2581.3417578517356;2663.600459931026;2669.785247712286;2694.1782756259136;2705.567109262548;4769.57073863354;4778.1638213312535;4780.569748722632;4785.473597904228;4806.8798280043275;5200.609954253446;5212.4266330703595;5227.869303267449;5235.842924712265;5244.763985620656;4610.815567377334;4806.4712881583;4812.663113582015;4817.2774083887;4820.71075735457;5100.107481190851;5101.51535604117;5108.667936584259;5115.900081482499;5122.359705036871;4941.407031156285;4946.752662366939;4962.354893863775;5026.47222041695;5036.625460941252;4678.836240731558;4772.284157376283;4779.4742578317055;4940.431850337257;4990.201567749143;3638.508801311895;3646.1796095878217;3653.3058718843336;3672.5577490969276;3677.5403074615674;5298.655587386807;5307.203919412119;5308.787648494017;5317.494837990384;5319.951818549809;4964.67729597575;5093.337866077386;5139.743012849417;5166.19183285847;5166.689998600096;5063.87340316495;5075.137226671401;5079.314292570603;5087.516685914832;5088.659216760332;4992.8751781205765;5008.874778130576;5025.748712564284;5026.5727413168825;5058.9494105058475;4828.444728856086;5045.142325804549;5050.949490505048;5094.159463688598;5115.820946266863;4752.928706069342;4816.8795780105775;4847.054824309226;4921.286413469955;4962.007598480391 23:02:15 INFO - PROCESS | 5709 | |5;yui.html;543.1608165384481;552.1276383314364;596.6897213449007;606.9119977603248;684.4231468521018;11533.250338727987;12278.81581776272;12650.240985540862;12672.80990785139;12980.675483112904;10999.560017599306;11112.777744445106;11127.777444451107;11129.833052504198;11132.276402033862;604.7550741949517;740.3669862267751;755.0637209859761;757.3638143959073;757.571971835911;619.8357435279654;729.3763831923709;745.9216782237868;749.2919191364163;752.2853289375088;784.415610370275;784.764570628812;785.5326080981806;785.658238666182;785.6935795039939;619.5167769140078;783.6238605469349;784.5959330944568;785.1873311122961;785.4698078796818;469.68531084173685;553.1509133480089;566.7959534567552;571.7027145884117;577.4110407384486;11081.168912331608;11089.55641774328;11171.218014738972;11180.944095279552;11186.216964812467;11179.161562882817;11541.653750387502;11915.344656043913;12231.204971676902;12406.577723852868;10729.141668666565;10792.784144317147;10833.241673082888;10883.292585981964;10931.945340273327;3907.179492306619;3907.9609203908167;3987.6809855211804;4008.398740188966;4058.188362327546;58616.413835861946;58823;58877.70561147167;58912.410875891124;58959.115613265836;9350.57922393494;9526.618935242652;9544.856827147598;10013.949930250303;10113.94943025295;17845.7323140153;18016;18068;18131.637367252846;18185.272589096552;6113.144159817629;6129.233845769279;6155.199824022849;6243.687815609202;6306.684665766693;3366.259422926952;3464.151282935697;3483.4600636900814;3596.2987217492337;3608.711303095746;2551.7448255174336;2648.351153967252;2654.6018097285178;2658.082961378321;2666.2667766364407;434.35715141590623;435.80824437248145;436.9847055353047;443.560874734011;445.4298497922664;478.8754923719858;491.3440556856565;530.3847536857227;542.4602520492135;554.2296208270507;7036.648167591702;7316;7692.884606730903;7695.7691269260895;7705.8844117338285;463.1385622741698;478.6936360729136;486.92696095585944;494.03909396224;517.7851191755454;3565.1283076385107;3588.3540962626976;3593.982030089885;3695.593484716679;3772.3398405278967;64089.35910640927;66893.33106668969;69174.65412672904;72088.27911720816;72533.637331813;47274.05451890943;54467.365979020695;59682.10476842851;61311.38688613146;61652.38347616556;54610;56111.71944140253;56290.718546407006;56708.149377759364;57647.1352929698;6754.86490270182;7179.928200718135;7212.350888420067;7224.2414546473965;7235.529690570096;37765.81117094397;39944.80027599844;40004.79997599994;40837.795811020755;40952.59047409607;50439;50500;53254;54809.45190548203;54879;8753.91246087531;8885.378023538291;8916.777080573038;8921.241694456045;8991.505467199106;10106.343087699275;10330.225233107396;10348.844767328646;10415.795447756773;10618.469076546296;9351.53242337894;9515.762105947406;9651.613935442503;9748.317617766688;9830.655927042519;9587.089226523469;10663.360198388122;10757.623483178051;11041.282316649713;11399.487023084146;10475.371477711362;10520.526576303932;10555.577776889146;10807.945960270463;10916.399598022184;9285.442873427615;9424.198943089914;9729.85405218908;9733.707988760349;10089.747756306151;8536.189062039097;9091.772705682411;9505.524723763645;9525.666601668909;9530.380525266113 23:02:15 INFO - PROCESS | 5709 | __end_tp_report 23:02:15 INFO - PROCESS | 5709 | __start_cc_report 23:02:15 INFO - PROCESS | 5709 | _x_x_mozilla_cycle_collect,1998 23:02:15 INFO - PROCESS | 5709 | __end_cc_report 23:02:15 INFO - PROCESS | 5709 | __startTimestamp1480489335179__endTimestamp 23:02:15 INFO - PROCESS | 5709 | 23:02:15 INFO - PROCESS | 5709 | ------- Summary: start ------- 23:02:15 INFO - PROCESS | 5709 | Number of tests: 6 23:02:15 INFO - PROCESS | 5709 | 23:02:15 INFO - PROCESS | 5709 | [#0] dojo.html Cycles:165 Average:4593.45 Median:4706.15 stddev:461.22 (9.8%) stddev-sans-first:433.95 23:02:15 INFO - PROCESS | 5709 | Values: 2552.3 2640.9 2659.9 2665.6 2674.9 4579.6 4663.6 4663.6 4674.2 4695.7 4685.9 4694.5 4695.9 4706.2 4708.1 4295.6 4318.3 4326.4 4362.1 4363.3 4339.0 4358.3 4362.3 4365.8 4378.2 4270.6 4272.3 4281.6 4336.2 4375.9 4357.6 4361.1 4362.1 4370.7 4411.0 4193.7 4223.3 4230.3 4290.9 4328.3 4584.4 4604.5 4624.1 4628.9 4634.8 4937.2 4969.4 4982.6 4998.0 5021.7 4859.5 4908.6 4996.6 5002.0 5038.8 4576.9 4609.5 4613.7 4644.3 4657.6 5053.5 5054.5 5058.6 5065.1 5109.4 4845.0 4848.2 4850.4 4855.2 4909.6 4827.3 4866.0 4867.7 4922.9 4927.1 4833.9 4877.8 4892.3 4901.4 4902.0 4858.7 4890.7 4911.6 4928.1 4938.5 4190.5 4199.4 4227.3 4236.4 4237.7 3683.9 3686.3 3690.5 3712.4 3721.8 4193.1 4245.3 4321.1 4325.2 4355.0 4955.6 4959.6 4963.1 4984.0 5063.0 4317.6 4323.1 4327.3 4327.9 4366.4 4472.2 4476.2 4481.3 4482.8 4522.0 4539.2 4572.0 4574.2 4673.1 4698.9 4984.4 4984.8 5005.1 5008.8 5059.8 4693.1 4699.6 4701.5 4702.6 4749.1 4774.7 4787.1 4793.8 4904.4 4960.1 4869.5 4913.9 4920.6 4922.7 4923.9 4801.4 4804.9 4808.6 4808.9 4809.5 4808.9 4809.3 4811.8 4816.4 4817.2 4710.2 4727.7 4746.3 4755.0 4757.8 4904.0 4905.0 4909.8 4928.0 4956.2 4795.1 4799.8 4802.9 4834.0 4842.8 23:02:15 INFO - PROCESS | 5709 | 23:02:15 INFO - PROCESS | 5709 | [#1] ext.html Cycles:180 Average:44292.90 Median:199435.64 stddev:77672.75 (38.9%) stddev-sans-first:77821.22 23:02:15 INFO - PROCESS | 5709 | Values: 554.7 558.7 558.9 560.1 570.9 27446.3 37019.4 38238.6 38496.0 42248.6 38355.8 39003.2 39111.0 39220.6 39222.4 7383.5 7541.1 7546.5 7550.4 7552.4 7335.0 7529.0 9571.7 9894.1 9895.5 9721.9 9750.0 9776.3 9778.3 9779.1 9339.7 9378.1 9388.2 9395.2 9406.2 9726.8 9803.7 9808.5 9812.1 9813.3 36208.3 36403.6 36471.3 36552.6 36554.1 2919.5 2971.3 2971.5 3148.5 3164.2 27422.6 27885.0 28232.2 28733.9 29005.1 3318.5 3362.5 3407.4 3439.8 3539.0 232424.0 233879.0 235022.0 236647.0 240556.0 51408.7 51813.7 51882.7 51933.0 52419.5 53979.2 53995.5 54067.2 54108.0 54119.5 11757.9 11885.2 11899.9 11926.8 11948.9 8141.5 8288.8 9981.4 10123.2 10145.5 16119.8 16265.7 16511.3 16938.2 16961.0 5417.6 5494.6 5572.8 5606.7 5663.5 685.8 757.7 811.3 849.8 871.6 26663.9 27153.3 27310.5 27649.2 28879.7 897.3 934.7 942.3 955.7 959.3 13832.2 14620.3 14711.0 14721.1 14877.0 359442.0 361788.0 361950.0 362663.0 362811.0 47131.8 47295.0 47378.3 47436.0 47501.8 998.3 1049.3 1066.1 1083.2 1174.0 27096.9 28265.9 28906.3 28932.4 29071.6 41106.2 41588.8 41607.8 41610.6 41674.6 273337.0 273958.0 276289.0 276906.0 277010.0 22873.0 23805.0 23809.6 23820.4 25086.7 39113.2 39254.6 39256.0 39588.4 40056.2 33663.2 34240.0 34404.1 34466.8 35042.8 30469.8 30687.4 30781.5 30786.8 31530.8 31633.8 31674.4 31813.5 35094.1 35145.6 29398.7 31170.5 32022.8 32063.7 32330.5 23967.5 24380.3 24418.8 24631.9 24768.6 23:02:15 INFO - PROCESS | 5709 | 23:02:15 INFO - PROCESS | 5709 | [#2] jquery.html Cycles:180 Average:23917.60 Median:4496.63 stddev:61602.89 (1370.0%) stddev-sans-first:61750.21 23:02:15 INFO - PROCESS | 5709 | Values: 315.5 342.5 345.1 347.9 368.7 12514.9 13438.8 15617.4 15873.5 16344.1 16008.2 16026.4 16039.8 16164.4 16278.1 4182.0 4857.8 5129.5 5129.9 5132.2 4940.3 5026.5 5050.1 5053.2 5054.4 5019.6 5021.8 5026.1 5026.9 5028.4 4823.8 4976.9 4980.6 5005.2 5005.7 4489.7 4494.6 4495.7 4496.5 4496.8 19478.0 19824.4 19966.6 20141.0 20217.4 1930.7 1968.6 1978.6 2016.3 2050.8 12264.5 12409.0 12410.5 13452.1 13488.8 1667.2 1715.9 1768.1 1789.2 1792.5 55932.4 65083.0 65609.3 66996.0 67523.7 9447.2 9489.9 9565.5 9639.8 9858.5 12861.6 12894.1 12902.7 12907.0 12922.2 6750.8 6751.4 6917.5 6921.4 6964.2 6182.9 6249.9 6296.5 6399.2 6469.7 5218.7 5592.5 5624.5 6019.7 6077.4 1651.9 1700.1 1702.5 1750.9 1803.1 807.3 817.6 825.1 836.5 847.6 15866.9 16418.5 16560.3 16836.3 17603.5 787.2 824.4 840.8 862.5 867.9 8815.9 9237.5 9353.3 9404.7 9461.8 367934.0 369276.0 370973.0 372266.0 373664.0 76114.2 87191.6 91305.5 91808.5 92341.5 847.0 893.4 896.1 903.7 907.3 15070.9 15226.6 15507.5 15926.4 16224.8 38689.4 39013.0 39382.0 39849.8 40757.4 50690.2 50913.0 51248.0 51394.0 53651.5 7242.5 7284.3 7450.5 7486.8 7531.8 9876.3 11310.5 11517.1 11696.4 11851.5 9771.5 9793.4 9960.6 10499.1 10581.3 10015.2 10043.9 10402.3 10519.4 10639.2 10155.4 10445.4 10787.5 10862.6 11026.8 7278.6 7346.2 7365.5 7433.6 7732.7 10588.5 10607.5 10708.8 10791.7 10843.7 23:02:15 INFO - PROCESS | 5709 | 23:02:15 INFO - PROCESS | 5709 | [#3] mootools.html Cycles:180 Average:4425.28 Median:4458.85 stddev:2384.20 (53.5%) stddev-sans-first:2378.99 23:02:15 INFO - PROCESS | 5709 | Values: 1255.5 1314.3 1359.6 1647.2 1647.4 6563.3 6969.9 6977.3 6982.9 6992.0 5659.7 5795.6 6466.2 6766.6 6892.4 2041.2 2069.7 2072.6 2075.9 2076.4 1941.5 1993.4 2003.3 2061.1 2065.4 1731.1 1783.4 1975.5 2028.2 2032.8 2017.1 2024.9 2031.3 2031.6 2032.9 1984.6 1989.7 2035.8 2037.0 2042.2 6646.4 6717.8 6730.4 6893.2 6980.9 4081.1 4209.5 4211.5 4212.2 4219.1 2583.3 2756.1 2795.0 2806.1 2827.1 837.2 874.0 885.6 902.3 903.4 8967.7 9047.7 9070.9 9077.3 9085.7 3589.0 3681.4 3769.3 3786.3 3789.7 7827.6 7841.6 7869.6 7877.8 7879.5 4108.3 4117.5 4139.5 4144.6 4147.1 3670.0 3750.6 3760.5 3762.5 3772.7 3254.8 3270.7 3332.9 3334.7 3469.3 1081.9 1088.4 1092.5 1101.1 1108.2 653.4 718.4 729.0 751.3 754.3 4324.8 4363.9 4407.7 4410.1 4541.8 357.2 372.4 377.2 399.5 402.9 3081.4 3095.2 3114.7 3184.3 3262.5 7323.7 7824.1 7869.5 7891.0 7904.4 7839.8 7859.5 7862.8 7865.3 7878.5 6162.6 6237.9 6242.6 6282.4 6313.4 4424.9 4434.1 4483.6 4485.8 4587.4 7295.0 7314.2 7345.3 7348.9 7450.6 7230.7 7596.1 7614.1 7615.2 7621.1 5698.4 5905.2 5922.5 5923.9 5927.9 6495.3 6550.7 6556.0 6559.4 6565.0 4848.5 5655.9 5671.5 5838.4 5887.1 5693.7 5756.6 5784.6 5864.9 5938.3 5361.0 5454.8 5457.3 5457.4 5460.0 3827.3 3906.7 3977.2 3984.5 4011.8 3757.5 3930.7 4042.2 4066.9 4094.3 23:02:15 INFO - PROCESS | 5709 | 23:02:15 INFO - PROCESS | 5709 | [#4] prototype.html Cycles:180 Average:4148.37 Median:4771.36 stddev:1231.66 (25.8%) stddev-sans-first:1200.18 23:02:15 INFO - PROCESS | 5709 | Values: 267.6 271.0 274.3 280.2 286.3 4861.3 4871.6 4889.2 4900.3 4909.8 4740.3 4770.4 4772.6 4779.5 4809.4 3544.5 3603.3 3659.8 3734.9 3779.4 3705.4 3724.9 3727.4 3731.6 3755.5 3698.4 3701.4 3707.3 3708.3 3709.9 3533.4 3591.2 3622.4 3709.8 3714.4 3261.8 3265.2 3270.2 3279.1 3285.9 4583.6 4614.5 4615.9 4623.5 4659.2 4252.6 4275.6 4276.5 4281.7 4292.0 4792.8 4974.5 4980.4 4995.0 5012.8 3466.4 3467.4 3471.4 3477.2 3477.2 5241.5 5245.8 5247.2 5275.1 5292.2 3474.7 3512.3 3545.0 3547.2 3584.8 3577.6 3589.8 3597.3 3597.7 3602.2 4165.6 4169.4 4170.1 4170.5 4180.7 4825.4 5065.0 5069.6 5081.8 5087.0 1193.3 1213.7 1220.4 1221.3 1224.4 800.2 811.1 818.3 826.4 828.9 4316.4 4317.5 4335.6 4369.5 4436.4 5119.2 5177.9 5212.0 5229.2 5233.4 4470.5 4472.5 4492.9 4493.7 4495.9 2581.3 2663.6 2669.8 2694.2 2705.6 4769.6 4778.2 4780.6 4785.5 4806.9 5200.6 5212.4 5227.9 5235.8 5244.8 4610.8 4806.5 4812.7 4817.3 4820.7 5100.1 5101.5 5108.7 5115.9 5122.4 4941.4 4946.8 4962.4 5026.5 5036.6 4678.8 4772.3 4779.5 4940.4 4990.2 3638.5 3646.2 3653.3 3672.6 3677.5 5298.7 5307.2 5308.8 5317.5 5320.0 4964.7 5093.3 5139.7 5166.2 5166.7 5063.9 5075.1 5079.3 5087.5 5088.7 4992.9 5008.9 5025.7 5026.6 5058.9 4828.4 5045.1 5050.9 5094.2 5115.8 4752.9 4816.9 4847.1 4921.3 4962.0 23:02:15 INFO - PROCESS | 5709 | 23:02:15 INFO - PROCESS | 5709 | [#5] yui.html Cycles:180 Average:14665.99 Median:542.81 stddev:19247.06 (3545.8%) stddev-sans-first:19271.84 23:02:15 INFO - PROCESS | 5709 | Values: 543.2 552.1 596.7 606.9 684.4 11533.3 12278.8 12650.2 12672.8 12980.7 10999.6 11112.8 11127.8 11129.8 11132.3 604.8 740.4 755.1 757.4 757.6 619.8 729.4 745.9 749.3 752.3 784.4 784.8 785.5 785.7 785.7 619.5 783.6 784.6 785.2 785.5 469.7 553.2 566.8 571.7 577.4 11081.2 11089.6 11171.2 11180.9 11186.2 11179.2 11541.7 11915.3 12231.2 12406.6 10729.1 10792.8 10833.2 10883.3 10931.9 3907.2 3908.0 3987.7 4008.4 4058.2 58616.4 58823.0 58877.7 58912.4 58959.1 9350.6 9526.6 9544.9 10013.9 10113.9 17845.7 18016.0 18068.0 18131.6 18185.3 6113.1 6129.2 6155.2 6243.7 6306.7 3366.3 3464.2 3483.5 3596.3 3608.7 2551.7 2648.4 2654.6 2658.1 2666.3 434.4 435.8 437.0 443.6 445.4 478.9 491.3 530.4 542.5 554.2 7036.6 7316.0 7692.9 7695.8 7705.9 463.1 478.7 486.9 494.0 517.8 3565.1 3588.4 3594.0 3695.6 3772.3 64089.4 66893.3 69174.7 72088.3 72533.6 47274.1 54467.4 59682.1 61311.4 61652.4 54610.0 56111.7 56290.7 56708.1 57647.1 6754.9 7179.9 7212.4 7224.2 7235.5 37765.8 39944.8 40004.8 40837.8 40952.6 50439.0 50500.0 53254.0 54809.5 54879.0 8753.9 8885.4 8916.8 8921.2 8991.5 10106.3 10330.2 10348.8 10415.8 10618.5 9351.5 9515.8 9651.6 9748.3 9830.7 9587.1 10663.4 10757.6 11041.3 11399.5 10475.4 10520.5 10555.6 10807.9 10916.4 9285.4 9424.2 9729.9 9733.7 10089.7 8536.2 9091.8 9505.5 9525.7 9530.4 23:02:15 INFO - PROCESS | 5709 | -------- Summary: end -------- 23:02:15 INFO - PROCESS | 5709 | 23:02:16 INFO - TEST-INFO | 5709: exit 0 23:02:16 INFO - TEST-OK | dromaeo_css | took 1123688ms 23:02:16 INFO - TEST-START | kraken 23:02:16 INFO - operating with platform_type : linux_ 23:02:16 INFO - Initialising browser for kraken test... 23:02:16 INFO - TEST-INFO | started process 6011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxnbePa/profile http://localhost:53209/getInfo.html) 23:02:20 INFO - PROCESS | 6011 | __metrics Screen width/height:1600/1200 23:02:20 INFO - PROCESS | 6011 | colorDepth:24 23:02:20 INFO - PROCESS | 6011 | Browser inner width/height: 1024/697 23:02:20 INFO - PROCESS | 6011 | __metrics 23:02:20 INFO - PROCESS | 6011 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:02:20 INFO - PROCESS | 6011 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:02:21 INFO - PROCESS | 6011 | console.error: PushService: 23:02:21 INFO - PROCESS | 6011 | stateChangeProcessEnqueue: Error transitioning state 23:02:21 INFO - PROCESS | 6011 | UnknownError 23:02:22 INFO - TEST-INFO | 6011: exit 0 23:02:22 INFO - Browser initialized. 23:02:22 INFO - Running cycle 1/1 for kraken test... 23:02:22 INFO - TEST-INFO | started process 6094 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxnbePa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:02:34 INFO - PROCESS | 6094 | RSS: Main: 174608384 23:02:34 INFO - PROCESS | 6094 | 23:02:37 INFO - PROCESS | 6094 | Cycle 1(1): loaded http://localhost:53209/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53209/tests/kraken/driver.html?testName=audio-beat-detection) 23:02:38 INFO - PROCESS | 6094 | RSS: Main: 235810816 23:02:38 INFO - PROCESS | 6094 | 23:02:41 INFO - PROCESS | 6094 | Cycle 1(1): loaded http://localhost:53209/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53209/tests/kraken/driver.html?testName=audio-dft) 23:02:41 INFO - PROCESS | 6094 | RSS: Main: 218222592 23:02:41 INFO - PROCESS | 6094 | 23:02:44 INFO - PROCESS | 6094 | Cycle 1(1): loaded http://localhost:53209/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53209/tests/kraken/driver.html?testName=audio-fft) 23:02:45 INFO - PROCESS | 6094 | RSS: Main: 300466176 23:02:45 INFO - PROCESS | 6094 | 23:02:47 INFO - PROCESS | 6094 | Cycle 1(1): loaded http://localhost:53209/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53209/tests/kraken/driver.html?testName=audio-oscillator) 23:02:48 INFO - PROCESS | 6094 | RSS: Main: 212221952 23:02:48 INFO - PROCESS | 6094 | 23:02:50 INFO - PROCESS | 6094 | Cycle 1(1): loaded http://localhost:53209/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53209/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:02:51 INFO - PROCESS | 6094 | RSS: Main: 215146496 23:02:51 INFO - PROCESS | 6094 | 23:02:54 INFO - PROCESS | 6094 | Cycle 1(1): loaded http://localhost:53209/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53209/tests/kraken/driver.html?testName=imaging-darkroom) 23:02:55 INFO - PROCESS | 6094 | RSS: Main: 253550592 23:02:55 INFO - PROCESS | 6094 | 23:02:58 INFO - PROCESS | 6094 | Cycle 1(1): loaded http://localhost:53209/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53209/tests/kraken/driver.html?testName=imaging-desaturate) 23:02:59 INFO - PROCESS | 6094 | RSS: Main: 248094720 23:02:59 INFO - PROCESS | 6094 | 23:03:01 INFO - PROCESS | 6094 | Cycle 1(1): loaded http://localhost:53209/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53209/tests/kraken/driver.html?testName=json-parse-financial) 23:03:02 INFO - PROCESS | 6094 | RSS: Main: 250380288 23:03:02 INFO - PROCESS | 6094 | 23:03:04 INFO - PROCESS | 6094 | Cycle 1(1): loaded http://localhost:53209/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53209/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:03:04 INFO - PROCESS | 6094 | RSS: Main: 213565440 23:03:04 INFO - PROCESS | 6094 | 23:03:06 INFO - PROCESS | 6094 | Cycle 1(1): loaded http://localhost:53209/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53209/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:03:07 INFO - PROCESS | 6094 | RSS: Main: 221138944 23:03:07 INFO - PROCESS | 6094 | 23:03:09 INFO - PROCESS | 6094 | Cycle 1(1): loaded http://localhost:53209/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53209/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:03:10 INFO - PROCESS | 6094 | RSS: Main: 229371904 23:03:10 INFO - PROCESS | 6094 | 23:03:13 INFO - PROCESS | 6094 | Cycle 1(1): loaded http://localhost:53209/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:03:14 INFO - PROCESS | 6094 | RSS: Main: 237719552 23:03:14 INFO - PROCESS | 6094 | 23:03:17 INFO - PROCESS | 6094 | Cycle 1(1): loaded http://localhost:53209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:03:17 INFO - PROCESS | 6094 | RSS: Main: 234954752 23:03:17 INFO - PROCESS | 6094 | 23:03:19 INFO - PROCESS | 6094 | Cycle 1(1): loaded http://localhost:53209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53209/tests/kraken/driver.html?testName=ai-astar) 23:03:19 INFO - PROCESS | 6094 | RSS: Main: 285429760 23:03:19 INFO - PROCESS | 6094 | 23:03:19 INFO - PROCESS | 6094 | __start_tp_report 23:03:19 INFO - PROCESS | 6094 | _x_x_mozilla_page_load 23:03:19 INFO - PROCESS | 6094 | _x_x_mozilla_page_load_details 23:03:19 INFO - PROCESS | 6094 | |i|pagename|runs| 23:03:19 INFO - PROCESS | 6094 | |0;ai-astar;109;116;116;116;117;117;115;118;115;116 23:03:19 INFO - PROCESS | 6094 | |1;audio-beat-detection;158;134;131;185;132;136;130;129;150;130 23:03:19 INFO - PROCESS | 6094 | |2;audio-dft;162;160;162;161;162;161;162;161;160;161 23:03:19 INFO - PROCESS | 6094 | |3;audio-fft;75;76;76;107;77;76;78;76;91;77 23:03:19 INFO - PROCESS | 6094 | |4;audio-oscillator;83;83;108;84;83;84;106;84;84;107 23:03:19 INFO - PROCESS | 6094 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;118 23:03:19 INFO - PROCESS | 6094 | |6;imaging-darkroom;148;148;147;147;147;148;147;147;147;148 23:03:19 INFO - PROCESS | 6094 | |7;imaging-desaturate;96;95;96;96;96;95;96;95;97;95 23:03:19 INFO - PROCESS | 6094 | |8;json-parse-financial;68;67;66;67;67;68;67;67;67;68 23:03:19 INFO - PROCESS | 6094 | |9;json-stringify-tinderbox;66;66;64;66;66;65;66;66;80;66 23:03:19 INFO - PROCESS | 6094 | |10;stanford-crypto-aes;85;85;92;85;86;93;85;86;85;85 23:03:19 INFO - PROCESS | 6094 | |11;stanford-crypto-ccm;148;142;155;142;142;157;145;164;202;142 23:03:19 INFO - PROCESS | 6094 | |12;stanford-crypto-pbkdf2;182;177;179;180;187;182;178;179;182;182 23:03:19 INFO - PROCESS | 6094 | |13;stanford-crypto-sha256-iterative;73;71;71;71;72;75;72;71;71;71 23:03:19 INFO - PROCESS | 6094 | __end_tp_report 23:03:19 INFO - PROCESS | 6094 | __start_cc_report 23:03:19 INFO - PROCESS | 6094 | _x_x_mozilla_cycle_collect,1962 23:03:19 INFO - PROCESS | 6094 | __end_cc_report 23:03:19 INFO - PROCESS | 6094 | __startTimestamp1480489399697__endTimestamp 23:03:19 INFO - PROCESS | 6094 | 23:03:19 INFO - PROCESS | 6094 | ------- Summary: start ------- 23:03:19 INFO - PROCESS | 6094 | Number of tests: 14 23:03:19 INFO - PROCESS | 6094 | 23:03:19 INFO - PROCESS | 6094 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:2.46 (2.1%) stddev-sans-first:0.97 23:03:19 INFO - PROCESS | 6094 | Values: 109.0 116.0 116.0 116.0 117.0 117.0 115.0 118.0 115.0 116.0 23:03:19 INFO - PROCESS | 6094 | 23:03:19 INFO - PROCESS | 6094 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:135.00 stddev:18.09 (13.4%) stddev-sans-first:18.17 23:03:19 INFO - PROCESS | 6094 | Values: 158.0 134.0 131.0 185.0 132.0 136.0 130.0 129.0 150.0 130.0 23:03:19 INFO - PROCESS | 6094 | 23:03:19 INFO - PROCESS | 6094 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 23:03:19 INFO - PROCESS | 6094 | Values: 162.0 160.0 162.0 161.0 162.0 161.0 162.0 161.0 160.0 161.0 23:03:19 INFO - PROCESS | 6094 | 23:03:19 INFO - PROCESS | 6094 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.50 stddev:10.29 (13.5%) stddev-sans-first:10.69 23:03:19 INFO - PROCESS | 6094 | Values: 75.0 76.0 76.0 107.0 77.0 76.0 78.0 76.0 91.0 77.0 23:03:19 INFO - PROCESS | 6094 | 23:03:19 INFO - PROCESS | 6094 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:83.50 stddev:11.34 (13.6%) stddev-sans-first:11.68 23:03:19 INFO - PROCESS | 6094 | Values: 83.0 83.0 108.0 84.0 83.0 84.0 106.0 84.0 84.0 107.0 23:03:19 INFO - PROCESS | 6094 | 23:03:19 INFO - PROCESS | 6094 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 23:03:19 INFO - PROCESS | 6094 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 23:03:19 INFO - PROCESS | 6094 | 23:03:19 INFO - PROCESS | 6094 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 23:03:19 INFO - PROCESS | 6094 | Values: 148.0 148.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 148.0 23:03:19 INFO - PROCESS | 6094 | 23:03:19 INFO - PROCESS | 6094 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 23:03:19 INFO - PROCESS | 6094 | Values: 96.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 97.0 95.0 23:03:19 INFO - PROCESS | 6094 | 23:03:19 INFO - PROCESS | 6094 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 23:03:19 INFO - PROCESS | 6094 | Values: 68.0 67.0 66.0 67.0 67.0 68.0 67.0 67.0 67.0 68.0 23:03:19 INFO - PROCESS | 6094 | 23:03:19 INFO - PROCESS | 6094 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:66.00 stddev:4.58 (6.9%) stddev-sans-first:4.84 23:03:19 INFO - PROCESS | 6094 | Values: 66.0 66.0 64.0 66.0 66.0 65.0 66.0 66.0 80.0 66.0 23:03:19 INFO - PROCESS | 6094 | 23:03:19 INFO - PROCESS | 6094 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:85.50 stddev:3.09 (3.6%) stddev-sans-first:3.22 23:03:19 INFO - PROCESS | 6094 | Values: 85.0 85.0 92.0 85.0 86.0 93.0 85.0 86.0 85.0 85.0 23:03:19 INFO - PROCESS | 6094 | 23:03:19 INFO - PROCESS | 6094 | [#11] stanford-crypto-ccm Cycles:10 Average:153.90 Median:151.50 stddev:18.58 (12.3%) stddev-sans-first:19.58 23:03:19 INFO - PROCESS | 6094 | Values: 148.0 142.0 155.0 142.0 142.0 157.0 145.0 164.0 202.0 142.0 23:03:19 INFO - PROCESS | 6094 | 23:03:19 INFO - PROCESS | 6094 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.80 Median:182.00 stddev:2.86 (1.6%) stddev-sans-first:3.00 23:03:19 INFO - PROCESS | 6094 | Values: 182.0 177.0 179.0 180.0 187.0 182.0 178.0 179.0 182.0 182.0 23:03:19 INFO - PROCESS | 6094 | 23:03:19 INFO - PROCESS | 6094 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:71.50 stddev:1.32 (1.8%) stddev-sans-first:1.32 23:03:19 INFO - PROCESS | 6094 | Values: 73.0 71.0 71.0 71.0 72.0 75.0 72.0 71.0 71.0 71.0 23:03:19 INFO - PROCESS | 6094 | -------- Summary: end -------- 23:03:19 INFO - PROCESS | 6094 | 23:03:21 INFO - TEST-INFO | 6094: exit 0 23:03:21 INFO - TEST-OK | kraken | took 64920ms 23:03:21 INFO - SUITE-END | took 1188s 23:03:21 INFO - Completed test suite (00:19:48) 23:03:21 INFO - javascript benchmark 23:03:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2552.3108760634623, 2640.867956602169, 2659.867006649667, 2665.560182569876, 2674.8528830914292, 4579.633629309656, 4663.556962088604, 4663.603593694535, 4674.158651442739, 4695.741734204617, 4685.9062818743605, 4694.483606803257, 4695.90608187836, 4706.152892479352, 4708.058388322341, 4295.59191876772, 4318.287482565373, 4326.415933848922, 4362.0621566363225, 4363.258246098171, 4339.0, 4358.346248062784, 4362.280223763091, 4365.759883206422, 4378.190034843564, 4270.636995855356, 4272.2950713132295, 4281.614654681078, 4336.176126535964, 4375.868723938287, 4357.607815296638, 4361.105973275471, 4362.083962367875, 4370.650347972186, 4411.00752330723, 4193.748375097504, 4223.303154979425, 4230.302000169968, 4290.871273861789, 4328.307470804688, 4584.40402747644, 4604.493505714368, 4624.05206932578, 4628.907421851578, 4634.83778067766, 4937.1606826839525, 4969.378827646544, 4982.6013918886765, 4998.025385049917, 5021.6735912165595, 4859.514048595148, 4908.558229759303, 4996.625253105995, 5001.999600079962, 5038.823641172541, 4576.88557786058, 4609.516000819933, 4613.700109492872, 4644.349791029259, 4657.580817726353, 5053.519915608012, 5054.469280725544, 5058.620603454756, 5065.088284108822, 5109.3613298337705, 4844.95155048452, 4848.17581011229, 4850.417949846041, 4855.247436647254, 4909.582685471703, 4827.25177597473, 4865.9756701216975, 4867.7322747249245, 4922.926156107661, 4927.113119638428, 4833.927491087637, 4877.804887804519, 4892.339534162914, 4901.387326584177, 4902.0, 4858.708477491362, 4890.682105663121, 4911.631627627942, 4928.137575924199, 4938.456769755324, 4190.455240818674, 4199.370094485852, 4227.281362168439, 4236.406903033578, 4237.724547904377, 3683.852645894188, 3686.262747450467, 3690.4833323334756, 3712.350338690718, 3721.7580857244193, 4193.1194449165405, 4245.320748680197, 4321.092570560155, 4325.1565944641125, 4355.041890784022, 4955.554000140005, 4959.553640172402, 4963.081829861487, 4984.028114517707, 5063.038022775734, 4317.568243175658, 4323.113761678911, 4327.2643650579475, 4327.870163895088, 4366.410534577855, 4472.239719247736, 4476.239039363316, 4481.311213272076, 4482.7534485602955, 4522.0, 4539.16025535277, 4571.954280457286, 4574.245249533789, 4673.065386922561, 4698.92951605733, 4984.40187177541, 4984.775685094107, 5005.074061298671, 5008.824691135793, 5059.797608095782, 4693.108309421199, 4699.6240300776535, 4701.529847015271, 4702.600278976189, 4749.073930583503, 4774.665773395829, 4787.066522028171, 4793.784279707491, 4904.362432883702, 4960.057589058211, 4869.488703686062, 4913.9017219656125, 4920.606351491943, 4922.704637721748, 4923.852284431473, 4801.423829140525, 4804.855854324376, 4808.61531077506, 4808.927866081942, 4809.470958194526, 4808.879778005438, 4809.254565542346, 4811.78346974394, 4816.362436771515, 4817.229243321051, 4710.222813235915, 4727.739974301447, 4746.33551302811, 4755.0, 4757.785899634456, 4903.95096049035, 4904.950950490592, 4909.754512274443, 4927.9507204927495, 4956.231784073474, 4795.088933102699, 4799.784009719501, 4802.903941921212, 4834.0, 4842.757862106951], "value": 4565.084600411495, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.7475898466198, 558.6592178770951, 558.8826346467241, 560.1262031231277, 570.8801151758131, 27446.31384215393, 37019.44470832936, 38238.61761382389, 38496.0, 42248.577514224846, 38355.808220958854, 39003.21993560127, 39111.0, 39220.60779392205, 39222.41166382506, 7383.5200711953685, 7541.095068591777, 7546.54720716756, 7550.433717471212, 7552.358049565793, 7335.0, 7529.0, 9571.712848614552, 9894.060064293917, 9895.455749933752, 9721.854172187423, 9749.95125024374, 9776.266779991494, 9778.266630002743, 9779.11987921087, 9339.673111441101, 9378.109079637423, 9388.155066044088, 9395.201407880339, 9406.153446189808, 9726.75683107928, 9803.705888823346, 9808.509574521246, 9812.067853553901, 9813.313068085237, 36208.27583448316, 36403.635963640554, 36471.27057458836, 36552.63447365519, 36554.086147846254, 2919.5328747400313, 2971.272038350618, 2971.450281697893, 3148.4962406015156, 3164.161497203243, 27422.5886611701, 27885.0, 28232.15303540897, 28733.856330718212, 29005.12984610465, 3318.5188147718445, 3362.4788157835574, 3407.386670399327, 3439.8108104054268, 3539.026767638894, 232424.0, 233878.9999999983, 235022.0, 236647.0, 240556.0, 51408.714782130744, 51813.740931295855, 51882.74058629683, 51933.0, 52419.475805242226, 53979.19031214535, 53995.46004539983, 54067.188992165145, 54108.0, 54119.45880541144, 11757.882421175678, 11885.168038237412, 11899.940500297444, 11926.761464770656, 11948.940255298668, 8141.51150930946, 8288.8342233155, 9981.401115932922, 10123.1901447884, 10145.543450544596, 16119.838801611833, 16265.674686506203, 16511.33954641825, 16938.23777929996, 16960.982341059575, 5417.620766546383, 5494.615376923657, 5572.832815015556, 5606.6916319602815, 5663.461971112738, 685.8411465043934, 757.6590534259606, 811.3063330852036, 849.7663142635824, 871.6339137562239, 26663.866680666473, 27153.321166970985, 27310.45379092407, 27649.170524883884, 28879.7112028877, 897.3225214962662, 934.6962237272913, 942.2509105261197, 955.6607404371487, 959.3045042344245, 13832.198421869669, 14620.268986550629, 14711.0, 14721.11673299584, 14877.0, 359442.0, 361788.0, 361950.0, 362663.0, 362811.0, 47131.764341178074, 47295.0, 47378.289325660146, 47436.0, 47501.76249118732, 998.2962011781676, 1049.2655141401049, 1066.0991462214417, 1083.2254937719254, 1173.9823902641467, 27096.864515677295, 28265.858670707337, 28906.27734306659, 28932.42135157327, 29071.563926540697, 41106.177876442904, 41588.79205603953, 41607.79196104, 41610.58389416067, 41674.58325416707, 273337.0, 273958.0, 276289.0, 276906.0, 277010.0, 22873.0, 23805.047798087882, 23809.642855356837, 23820.404489887893, 25086.74913250844, 39113.21773564456, 39254.6074539251, 39256.0, 39588.406173906835, 40056.1988760229, 33663.15842103967, 34240.0, 34404.13989650179, 34466.82766586151, 35042.824785875906, 30469.847650761603, 30687.386252274384, 30781.538276926312, 30786.84606576953, 31530.842345788125, 31633.841830791618, 31674.36651267008, 31813.5227971576, 35094.12264693403, 35145.64854351424, 29398.706012940453, 31170.532442013842, 32022.839885800422, 32063.679363207004, 32330.515042273913, 23967.52064958726, 24380.26859194227, 24418.75581244236, 24631.87684061568, 24768.628470573316], "value": 16890.289833853243, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.52670993509736, 342.45891491443524, 345.1302717152775, 347.86954891915525, 368.655307287686, 12514.937425312872, 13438.798418023725, 15617.375304987801, 15873.52379428619, 16344.101074440901, 16008.199590020511, 16026.35894564216, 16039.83960160398, 16164.35342586298, 16278.104704241292, 4181.954511372157, 4857.805687772485, 5129.487051294859, 5129.897402051956, 5132.178851383779, 4940.308356830046, 5026.497350264981, 5050.116229659813, 5053.191489361703, 5054.418741844698, 5019.64862459628, 5021.799128034874, 5026.145555255597, 5026.899462010758, 5028.396592408916, 4823.782929768169, 4976.925346119811, 4980.626453016038, 5005.174146265862, 5005.674631149, 4489.73061616304, 4494.5730155635165, 4495.730256184606, 4496.505384407713, 4496.752678602676, 19478.00700856321, 19824.405267841987, 19966.60066798656, 20141.0, 20217.393478195532, 1930.7200455933812, 1968.6062787442568, 1978.584497255578, 2016.25398602518, 2050.805173508514, 12264.509419623204, 12408.966234748917, 12410.503579856795, 13452.1256118352, 13488.797668034988, 1667.158085166995, 1715.9485215443433, 1768.1336145288844, 1789.2127463915836, 1792.5339411752907, 55932.44067559313, 65083.0, 65609.3439065608, 66996.0, 67523.66238168826, 9447.196988256075, 9489.857652135224, 9565.521723913776, 9639.759006024766, 9858.45778482176, 12861.61415157528, 12894.097413181174, 12902.67743306406, 12907.0, 12922.224666520038, 6750.831229219309, 6751.358620931003, 6917.51577389588, 6921.377076063078, 6964.199117101497, 6182.876342473125, 6249.875022495994, 6296.496280297565, 6399.232092148879, 6469.7412103515335, 5218.66078704883, 5592.5246354059545, 5624.521915637135, 6019.69901504923, 6077.392260773887, 1651.8513333800015, 1700.0819557439092, 1702.5147832867574, 1750.9299628014737, 1803.089439832876, 807.3016840432983, 817.6320655704837, 825.0882774534053, 836.481381543447, 847.635516727813, 15866.9206653966, 16418.507444776675, 16560.337586496647, 16836.326546937984, 17603.471895843144, 787.2127872127872, 824.4270232188692, 840.815020695446, 862.4695812075529, 867.9169992019079, 8815.911840881638, 9237.491937943343, 9353.25173986093, 9404.670836520689, 9461.763455913657, 367934.0, 369276.0, 370973.0, 372266.0, 373664.0, 76114.23885761182, 87191.56404217938, 91305.54347228355, 91808.54095729478, 92341.53829230946, 846.95341756204, 893.4282059481936, 896.090468174803, 903.6566104880103, 907.2968449451596, 15070.924645376703, 15226.619334516725, 15507.534773956799, 15926.442574509836, 16224.756628650815, 38689.41965870571, 39013.0, 39382.0, 39849.80075099606, 40757.38863916984, 50690.23964640607, 50913.0, 51248.0, 51394.0, 53651.490235868565, 7242.529235599669, 7284.299153057908, 7450.478466507509, 7486.812829679302, 7531.8117047074265, 9876.308658393844, 11310.547578096784, 11517.136214783757, 11696.35670038156, 11851.525938962344, 9771.511424428609, 9793.363431376938, 9960.601575937171, 10499.107575855833, 10581.31221470602, 10015.198784097109, 10043.949780251052, 10402.323848949794, 10519.368837869752, 10639.202059845387, 10155.441450719985, 10445.373277603368, 10787.514561844893, 10862.565497380016, 11026.834597480884, 7278.599677017814, 7346.191918889025, 7365.484416090822, 7433.591152486449, 7732.729354472792, 10588.4705764713, 10607.522661480098, 10708.839367409651, 10791.730206744895, 10843.67468975932], "value": 8092.85802498133, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1255.4789762248668, 1314.3493970484608, 1359.6125104345263, 1647.211413748379, 1647.43163608555, 6563.343665633441, 6969.895451568224, 6977.30226977302, 6982.9301706982915, 6991.965040174792, 5659.717014149297, 5795.565332600061, 6466.191726034246, 6766.627835469048, 6892.379685828275, 2041.214132558968, 2069.7205877206534, 2072.5958438104576, 2075.9065842037144, 2076.3667081540125, 1941.5243265399997, 1993.4119434766778, 2003.3388981636026, 2061.124022290528, 2065.442330570745, 1731.1084791332473, 1783.4203883737773, 1975.4863735428748, 2028.229272876305, 2032.7967203279702, 2017.1427143463968, 2024.888631125295, 2031.3398145602591, 2031.603837251744, 2032.9491762705902, 1984.5832375201226, 1989.7015447682963, 2035.847311451647, 2037.0425899827057, 2042.2035406191596, 6646.401823835878, 6717.798466046026, 6730.427913627347, 6893.241743408221, 6980.930190698079, 4081.08175660477, 4209.452771139763, 4211.4525111735275, 4212.220739163234, 4219.092895027584, 2583.32833463299, 2756.1180422264883, 2795.0357126791223, 2806.1441260415563, 2827.067067867599, 837.2213841127749, 873.9912600873973, 885.588201486312, 902.3187493442474, 903.3766700976371, 8967.730968070968, 9047.68333108338, 9070.909290907073, 9077.273818094536, 9085.727428177099, 3589.039042789709, 3681.3557627415094, 3769.2838360711376, 3786.261678972574, 3789.7157713171073, 7827.569483678452, 7841.607919603997, 7869.606519674108, 7877.842443151105, 7879.487833290817, 4108.322126849036, 4117.464729585135, 4139.523954745183, 4144.585541445831, 4147.108371700099, 3670.0274427276795, 3750.624937506282, 3760.52993375828, 3762.4920635714375, 3772.660460558563, 3254.8047117173046, 3270.689284517967, 3332.9166770830925, 3334.749893757978, 3469.3408252432464, 1081.864766904137, 1088.3850624397348, 1092.5247517329988, 1101.1136035491506, 1108.196557495809, 653.3956090616161, 718.3642476408417, 728.9671964761599, 751.2600088912417, 754.2758951406602, 4324.783760811947, 4363.8565098080035, 4407.735535867858, 4410.095930334273, 4541.84103556374, 357.2266044014679, 372.4060124102107, 377.15705398434477, 399.4707013207512, 402.89121937077414, 3081.368319494543, 3095.1797773590015, 3114.672959339282, 3184.2676184477236, 3262.4780035194253, 7323.743668971667, 7824.061112666516, 7869.48848324857, 7891.0, 7904.446688731734, 7839.804004899923, 7859.4891332063235, 7862.803429914298, 7865.331446827084, 7878.487898286593, 6162.599431036968, 6237.937620623827, 6242.594231374856, 6282.403171698681, 6313.43179113882, 4424.889377765581, 4434.113177364605, 4483.596476317147, 4485.753283569435, 4587.371483123577, 7294.96352518234, 7314.195438501654, 7345.338919497271, 7348.853022939618, 7450.627468626655, 7230.674619642024, 7596.126445458843, 7614.124375696644, 7615.162332143349, 7621.123570789208, 5698.430156984268, 5905.202797622266, 5922.526197904243, 5923.940760592512, 5927.881442371215, 6495.317991611002, 6550.672466376567, 6556.0, 6559.409653131241, 6565.048068030204, 4848.466668666514, 5655.85860353478, 5671.546276297804, 5838.4453476919625, 5887.0580707086665, 5693.715314234189, 5756.625819321731, 5784.595078344475, 5864.882702345843, 5938.257717785277, 5360.973195133999, 5454.809081682122, 5457.290552228185, 5457.399686034453, 5460.0, 3827.2536855312946, 3906.7069969751815, 3977.2045590882517, 3984.5019372578427, 4011.7793521356607, 3757.455169000534, 3930.665893399093, 4042.211768705074, 4066.9389959150044, 4094.2835003873606], "value": 3573.376253195647, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [267.59192231846436, 270.96612923384583, 274.310110073166, 280.19164709812196, 286.2857171357463, 4861.270809378595, 4871.585915197204, 4889.168841296979, 4900.338454308671, 4909.779059942302, 4740.293494342042, 4770.427548694153, 4772.6181905447565, 4779.450363208232, 4809.398825146856, 3544.5214895989097, 3603.261331427051, 3659.780413175218, 3734.860867435431, 3779.3764028935193, 3705.4441833725023, 3724.9068773280615, 3727.3599616168935, 3731.6081811409817, 3755.5493340799144, 3698.39119982807, 3701.38927077032, 3707.258548290339, 3708.2954238694697, 3709.9443508347395, 3533.4169861972746, 3591.191981804099, 3622.4023036198996, 3709.777413355194, 3714.4428335749585, 3261.7879837810465, 3265.1837040739815, 3270.1988012936745, 3279.0818570800216, 3285.88060700849, 4583.587477127041, 4614.531225794218, 4615.884602884921, 4623.491415944243, 4659.18464268755, 4252.638525725317, 4275.551067137968, 4276.486821581399, 4281.7002809803325, 4291.957080429218, 4792.771361317004, 4974.50764770571, 4980.427250866124, 4995.0, 5012.77442515084, 3466.4107101792756, 3467.4105402081705, 3471.427214509603, 3477.2002439438816, 3477.2176260341475, 5241.475852414766, 5245.763940622643, 5247.160454327328, 5275.129603615399, 5292.153255479105, 3474.6699063588917, 3512.2624248908014, 3545.0, 3547.237343971007, 3584.8207589620415, 3577.5689724110566, 3589.820508974593, 3597.2985267872514, 3597.730170237243, 3602.2075143468396, 4165.604267594574, 4169.395437661522, 4170.061736109351, 4170.52039015511, 4180.686448516312, 4825.420949486084, 5064.974675126601, 5069.5690866276045, 5081.771320290596, 5086.974565127225, 1193.3257709394338, 1213.696575856036, 1220.395904027512, 1221.3343727668441, 1224.381687247934, 800.2314884106074, 811.0672726364728, 818.251300060438, 826.404988408345, 828.8756686496953, 4316.352547117957, 4317.481902171697, 4335.588119128741, 4369.497507786646, 4436.44544431946, 5119.206522988943, 5177.870553236199, 5211.973940130275, 5229.163333866563, 5233.424323324507, 4470.463544374696, 4472.530384309665, 4492.865214043584, 4493.707908985905, 4495.910081798345, 2581.3417578517356, 2663.600459931026, 2669.785247712286, 2694.1782756259136, 2705.567109262548, 4769.57073863354, 4778.1638213312535, 4780.569748722632, 4785.473597904228, 4806.8798280043275, 5200.609954253446, 5212.4266330703595, 5227.869303267449, 5235.842924712265, 5244.763985620656, 4610.815567377334, 4806.4712881583, 4812.663113582015, 4817.2774083887, 4820.71075735457, 5100.107481190851, 5101.51535604117, 5108.667936584259, 5115.900081482499, 5122.359705036871, 4941.407031156285, 4946.752662366939, 4962.354893863775, 5026.47222041695, 5036.625460941252, 4678.836240731558, 4772.284157376283, 4779.4742578317055, 4940.431850337257, 4990.201567749143, 3638.508801311895, 3646.1796095878217, 3653.3058718843336, 3672.5577490969276, 3677.5403074615674, 5298.655587386807, 5307.203919412119, 5308.787648494017, 5317.494837990384, 5319.951818549809, 4964.67729597575, 5093.337866077386, 5139.743012849417, 5166.19183285847, 5166.689998600096, 5063.87340316495, 5075.137226671401, 5079.314292570603, 5087.516685914832, 5088.659216760332, 4992.8751781205765, 5008.874778130576, 5025.748712564284, 5026.5727413168825, 5058.9494105058475, 4828.444728856086, 5045.142325804549, 5050.949490505048, 5094.159463688598, 5115.820946266863, 4752.928706069342, 4816.8795780105775, 4847.054824309226, 4921.286413469955, 4962.007598480391], "value": 3747.052104837443, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.1608165384481, 552.1276383314364, 596.6897213449007, 606.9119977603248, 684.4231468521018, 11533.250338727987, 12278.81581776272, 12650.240985540862, 12672.80990785139, 12980.675483112904, 10999.560017599306, 11112.777744445106, 11127.777444451107, 11129.833052504198, 11132.276402033862, 604.7550741949517, 740.3669862267751, 755.0637209859761, 757.3638143959073, 757.571971835911, 619.8357435279654, 729.3763831923709, 745.9216782237868, 749.2919191364163, 752.2853289375088, 784.415610370275, 784.764570628812, 785.5326080981806, 785.658238666182, 785.6935795039939, 619.5167769140078, 783.6238605469349, 784.5959330944568, 785.1873311122961, 785.4698078796818, 469.68531084173685, 553.1509133480089, 566.7959534567552, 571.7027145884117, 577.4110407384486, 11081.168912331608, 11089.55641774328, 11171.218014738972, 11180.944095279552, 11186.216964812467, 11179.161562882817, 11541.653750387502, 11915.344656043913, 12231.204971676902, 12406.577723852868, 10729.141668666565, 10792.784144317147, 10833.241673082888, 10883.292585981964, 10931.945340273327, 3907.179492306619, 3907.9609203908167, 3987.6809855211804, 4008.398740188966, 4058.188362327546, 58616.413835861946, 58823.0, 58877.70561147167, 58912.410875891124, 58959.115613265836, 9350.57922393494, 9526.618935242652, 9544.856827147598, 10013.949930250303, 10113.94943025295, 17845.7323140153, 18016.0, 18068.0, 18131.637367252846, 18185.272589096552, 6113.144159817629, 6129.233845769279, 6155.199824022849, 6243.687815609202, 6306.684665766693, 3366.259422926952, 3464.151282935697, 3483.4600636900814, 3596.2987217492337, 3608.711303095746, 2551.7448255174336, 2648.351153967252, 2654.6018097285178, 2658.082961378321, 2666.2667766364407, 434.35715141590623, 435.80824437248145, 436.9847055353047, 443.560874734011, 445.4298497922664, 478.8754923719858, 491.3440556856565, 530.3847536857227, 542.4602520492135, 554.2296208270507, 7036.648167591702, 7316.0, 7692.884606730903, 7695.7691269260895, 7705.8844117338285, 463.1385622741698, 478.6936360729136, 486.92696095585944, 494.03909396224, 517.7851191755454, 3565.1283076385107, 3588.3540962626976, 3593.982030089885, 3695.593484716679, 3772.3398405278967, 64089.35910640927, 66893.33106668969, 69174.65412672904, 72088.27911720816, 72533.637331813, 47274.05451890943, 54467.365979020695, 59682.10476842851, 61311.38688613146, 61652.38347616556, 54610.0, 56111.71944140253, 56290.718546407006, 56708.149377759364, 57647.1352929698, 6754.86490270182, 7179.928200718135, 7212.350888420067, 7224.2414546473965, 7235.529690570096, 37765.81117094397, 39944.80027599844, 40004.79997599994, 40837.795811020755, 40952.59047409607, 50439.0, 50500.0, 53254.0, 54809.45190548203, 54879.0, 8753.91246087531, 8885.378023538291, 8916.777080573038, 8921.241694456045, 8991.505467199106, 10106.343087699275, 10330.225233107396, 10348.844767328646, 10415.795447756773, 10618.469076546296, 9351.53242337894, 9515.762105947406, 9651.613935442503, 9748.317617766688, 9830.655927042519, 9587.089226523469, 10663.360198388122, 10757.623483178051, 11041.282316649713, 11399.487023084146, 10475.371477711362, 10520.526576303932, 10555.577776889146, 10807.945960270463, 10916.399598022184, 9285.442873427615, 9424.198943089914, 9729.85405218908, 9733.707988760349, 10089.747756306151, 8536.189062039097, 9091.772705682411, 9505.524723763645, 9525.666601668909, 9530.380525266113], "value": 5854.080168445767, "unit": "score"}], "name": "dromaeo_css", "value": 6047.534752553577, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 116.0, 116.0, 117.0, 117.0, 115.0, 118.0, 115.0, 116.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 134.0, 131.0, 185.0, 132.0, 136.0, 130.0, 129.0, 150.0, 130.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 161.0, 162.0, 161.0, 162.0, 161.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 107.0, 77.0, 76.0, 78.0, 76.0, 91.0, 77.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 108.0, 84.0, 83.0, 84.0, 106.0, 84.0, 84.0, 107.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 97.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0], "value": 67.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 64.0, 66.0, 66.0, 65.0, 66.0, 66.0, 80.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 92.0, 85.0, 86.0, 93.0, 85.0, 86.0, 85.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 142.0, 155.0, 142.0, 142.0, 157.0, 145.0, 164.0, 202.0, 142.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 177.0, 179.0, 180.0, 187.0, 182.0, 178.0, 179.0, 182.0, 182.0], "value": 180.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 71.0, 71.0, 72.0, 75.0, 72.0, 71.0, 71.0, 71.0], "value": 71.8, "unit": "score"}], "name": "kraken", "value": 1577.5000000000002, "alertThreshold": 2.0}]} 23:03:21 INFO - Return code: 0 23:03:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:03:21 INFO - # TBPL SUCCESS # 23:03:21 INFO - Running post-action listener: _resource_record_post_action 23:03:21 INFO - [mozharness: 2016-11-30 07:03:21.495312Z] Finished run-tests step (success) 23:03:21 INFO - Running post-run listener: _resource_record_post_run 23:03:21 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 745472; Write bytes: 391532544; Read time: 380; Write time: 297536 23:03:21 INFO - TinderboxPrint: CPU usage
13.1% 23:03:21 INFO - TinderboxPrint: I/O read bytes / time
745,472 / 380 23:03:21 INFO - TinderboxPrint: I/O write bytes / time
391,532,544 / 297,536 23:03:21 INFO - TinderboxPrint: CPU idle
8,358.1 (86.9%) 23:03:21 INFO - TinderboxPrint: CPU user
1,207.8 (12.6%) 23:03:21 INFO - TinderboxPrint: Swap in / out
0 / 0 23:03:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99778560; Read time: 0; Write time: 95820 23:03:21 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 741376; Write bytes: 291753984; Read time: 364; Write time: 201716 23:03:22 INFO - Running post-run listener: _upload_blobber_files 23:03:22 INFO - Blob upload gear active. 23:03:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:03:22 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 23:03:22 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:03:22 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:03:22 INFO - (blobuploader) - INFO - Open directory for files ... 23:03:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:03:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:03:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:03:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:03:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:03:23 INFO - (blobuploader) - INFO - Done attempting. 23:03:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:03:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:03:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:03:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:03:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:03:24 INFO - (blobuploader) - INFO - Done attempting. 23:03:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:03:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:03:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:03:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:03:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:03:27 INFO - (blobuploader) - INFO - Done attempting. 23:03:27 INFO - (blobuploader) - INFO - Iteration through files over. 23:03:27 INFO - Return code: 0 23:03:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:03:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:03:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/490a49717dd4033a24483ae3aec86cf24aba2c7168a704c98c5f34c0bc1ddd10164aa0cc7ce666348303f69822aa96bed38867a89740fbefa6501571a25aaf21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e2396cd1ef97521997d5c50267092b8640cc24bc984837814ff1ca7e33b796f0ceeaf98e9249b819c53df9059832c168a5d8d0fc9799bc26d621fbf664c25f5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/acad9b3233806a489998efcc3e806dbbba7333f89f99a75e20c2d9b0b200dad70b26c164a0e716d29154047550551b596569ed7e7b54a598df4c8bca8e6b436f"} 23:03:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:03:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:03:27 INFO - Contents: 23:03:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/490a49717dd4033a24483ae3aec86cf24aba2c7168a704c98c5f34c0bc1ddd10164aa0cc7ce666348303f69822aa96bed38867a89740fbefa6501571a25aaf21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e2396cd1ef97521997d5c50267092b8640cc24bc984837814ff1ca7e33b796f0ceeaf98e9249b819c53df9059832c168a5d8d0fc9799bc26d621fbf664c25f5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/acad9b3233806a489998efcc3e806dbbba7333f89f99a75e20c2d9b0b200dad70b26c164a0e716d29154047550551b596569ed7e7b54a598df4c8bca8e6b436f"} 23:03:27 INFO - Running post-run listener: copy_logs_to_upload_dir 23:03:27 INFO - Copying logs to upload dir... 23:03:27 INFO - mkdir: /builds/slave/test/build/upload/logs 23:03:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.644692 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-29 23:03:27.488980) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 23:03:27.492874) ========= 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=41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/490a49717dd4033a24483ae3aec86cf24aba2c7168a704c98c5f34c0bc1ddd10164aa0cc7ce666348303f69822aa96bed38867a89740fbefa6501571a25aaf21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e2396cd1ef97521997d5c50267092b8640cc24bc984837814ff1ca7e33b796f0ceeaf98e9249b819c53df9059832c168a5d8d0fc9799bc26d621fbf664c25f5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/acad9b3233806a489998efcc3e806dbbba7333f89f99a75e20c2d9b0b200dad70b26c164a0e716d29154047550551b596569ed7e7b54a598df4c8bca8e6b436f"} build_url:https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011707 build_url: 'https://queue.taskcluster.net/v1/task/Dm3U78DOSo2mMbN4hUTqDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/490a49717dd4033a24483ae3aec86cf24aba2c7168a704c98c5f34c0bc1ddd10164aa0cc7ce666348303f69822aa96bed38867a89740fbefa6501571a25aaf21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e2396cd1ef97521997d5c50267092b8640cc24bc984837814ff1ca7e33b796f0ceeaf98e9249b819c53df9059832c168a5d8d0fc9799bc26d621fbf664c25f5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/acad9b3233806a489998efcc3e806dbbba7333f89f99a75e20c2d9b0b200dad70b26c164a0e716d29154047550551b596569ed7e7b54a598df4c8bca8e6b436f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 23:03:27.521168) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 23:03:27.521842) ========= 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=41bf3e9aed84707956354da8000001c5-1480488156.44914-1333948400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 23:03:27.602303) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 23:03:27.602615) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 23:03:27.602932) ========= ========= Total master_lag: 0.17 =========