builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1479995556.76 results: success (0) buildid: 20161124030208 builduid: cbbe1c5a40e9436abf03f44a750e068c revision: 34fce7c12173bdd6dda54c2ebf6d344252f1ac48 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 05:52:36.761045) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 05:52:36.761892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 05:52:36.762440) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 05:52:36.785171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 05:52:36.785819) ========= 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=8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-24 05:52:36-- 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% 227M=0s 2016-11-24 05:52:36 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123200 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 05:52:36.926268) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 05:52:36.926616) ========= 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=8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015276 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 05:52:36.983295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 05:52:36.983714) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 34fce7c12173bdd6dda54c2ebf6d344252f1ac48 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 34fce7c12173bdd6dda54c2ebf6d344252f1ac48 --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=8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-24 05:52:37,029 truncating revision to first 12 chars 2016-11-24 05:52:37,029 Setting DEBUG logging. 2016-11-24 05:52:37,029 attempt 1/10 2016-11-24 05:52:37,029 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/34fce7c12173?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-24 05:52:37,507 unpacking tar archive at: mozilla-central-34fce7c12173/testing/mozharness/ program finished with exit code 0 elapsedTime=0.794690 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 05:52:37.792123) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 05:52:37.792442) ========= script_repo_revision: 34fce7c12173bdd6dda54c2ebf6d344252f1ac48 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 05:52:37.792896) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 05:52:37.793226) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 05:52:37.803438) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-11-24 05:52:37.803816) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:52:37 INFO - MultiFileLogger online at 20161124 05:52:37 in /builds/slave/test 05:52:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:52:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:52:37 INFO - {'append_to_log': False, 05:52:37 INFO - 'base_work_dir': '/builds/slave/test', 05:52:37 INFO - 'blob_upload_branch': 'Firefox', 05:52:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:52:37 INFO - 'branch': 'Firefox', 05:52:37 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:37 INFO - 'config_files': ('talos/linux_config.py',), 05:52:37 INFO - 'default_actions': ('clobber', 05:52:37 INFO - 'read-buildbot-config', 05:52:37 INFO - 'download-and-extract', 05:52:37 INFO - 'populate-webroot', 05:52:37 INFO - 'create-virtualenv', 05:52:37 INFO - 'install', 05:52:37 INFO - 'run-tests'), 05:52:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:37 INFO - 'download_minidump_stackwalk': True, 05:52:37 INFO - 'download_symbols': 'ondemand', 05:52:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:37 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:37 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:37 INFO - 'installer_path': 'installer.exe', 05:52:37 INFO - 'log_level': 'info', 05:52:37 INFO - 'log_name': 'talos', 05:52:37 INFO - 'log_to_console': True, 05:52:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:52:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:52:37 INFO - 'opt_config_files': (), 05:52:37 INFO - 'pip_index': False, 05:52:37 INFO - 'sps_profile': False, 05:52:37 INFO - 'sps_profile_interval': 0, 05:52:37 INFO - 'suite': 'dromaeojs-e10s', 05:52:37 INFO - 'system_bits': '32', 05:52:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:37 INFO - 'title': 'talos-linux64-ix-038', 05:52:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:37 INFO - 'use_talos_json': True, 05:52:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:52:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:37 INFO - 'work_dir': 'build'} 05:52:37 INFO - [mozharness: 2016-11-24 13:52:37.945782Z] Running clobber step. 05:52:37 INFO - Running pre-action listener: _resource_record_pre_action 05:52:37 INFO - Running main action method: clobber 05:52:37 INFO - rmtree: /builds/slave/test/build 05:52:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:52:38 INFO - Running post-action listener: _resource_record_post_action 05:52:38 INFO - [mozharness: 2016-11-24 13:52:38.399428Z] Finished clobber step (success) 05:52:38 INFO - [mozharness: 2016-11-24 13:52:38.399527Z] Running read-buildbot-config step. 05:52:38 INFO - Running pre-action listener: _resource_record_pre_action 05:52:38 INFO - Running main action method: read_buildbot_config 05:52:38 INFO - Using buildbot properties: 05:52:38 INFO - { 05:52:38 INFO - "project": "", 05:52:38 INFO - "product": "firefox", 05:52:38 INFO - "script_repo_revision": "production", 05:52:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:52:38 INFO - "repository": "", 05:52:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:52:38 INFO - "buildid": "20161124030208", 05:52:38 INFO - "stage_platform": "linux64-pgo", 05:52:38 INFO - "basedir": "/builds/slave/test", 05:52:38 INFO - "nightly_build": "True", 05:52:38 INFO - "buildnumber": 204, 05:52:38 INFO - "slavename": "talos-linux64-ix-038", 05:52:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:52:38 INFO - "platform": "ubuntu64_hw", 05:52:38 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:52:38 INFO - "branch": "mozilla-central", 05:52:38 INFO - "repo_path": "mozilla-central", 05:52:38 INFO - "revision": "34fce7c12173bdd6dda54c2ebf6d344252f1ac48", 05:52:38 INFO - "pgo_build": "True", 05:52:38 INFO - "builduid": "cbbe1c5a40e9436abf03f44a750e068c", 05:52:38 INFO - "slavebuilddir": "test" 05:52:38 INFO - } 05:52:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 05:52:38 INFO - Running post-action listener: _resource_record_post_action 05:52:38 INFO - [mozharness: 2016-11-24 13:52:38.402453Z] Finished read-buildbot-config step (success) 05:52:38 INFO - [mozharness: 2016-11-24 13:52:38.402541Z] Running download-and-extract step. 05:52:38 INFO - Running pre-action listener: _resource_record_pre_action 05:52:38 INFO - Running main action method: download_and_extract 05:52:38 INFO - mkdir: /builds/slave/test/build/tests 05:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:38 INFO - trying https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:52:38 INFO - Downloading https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/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 05:52:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/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 05:52:38 INFO - Downloaded 1361 bytes. 05:52:38 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:52:38 INFO - Using the following test package requirements: 05:52:38 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:38 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:52:38 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:52:38 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:38 INFO - u'jsshell-linux-x86_64.zip'], 05:52:38 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:52:38 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:38 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:52:38 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:52:38 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:52:38 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:52:38 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:52:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:52:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:38 INFO - Fetch https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:52:39 INFO - Http code: 200 05:52:39 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 05:52:39 INFO - x-amz-cf-id: yn1s26-8j9YYgNxv7YU3uY0bKHlb9qcBslrOg2UdyfrF5J6RmQ0Elw== 05:52:39 INFO - x-amz-version-id: idiSI5elA7dGuWILj53qxt8LOa39nwrh 05:52:39 INFO - Expected file size: 21765416 05:52:39 INFO - Obtained file size: 21765416 05:52:43 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 05:52:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:52:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:43 INFO - Fetch https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:52:44 INFO - Http code: 200 05:52:44 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 05:52:44 INFO - x-amz-cf-id: rDNz_haDTrsbH0J8l5bWrvAgnDCNJatv4IKJsLtWOp7L8RO_e_AZMg== 05:52:44 INFO - x-amz-version-id: idiSI5elA7dGuWILj53qxt8LOa39nwrh 05:52:44 INFO - Expected file size: 21765416 05:52:44 INFO - Obtained file size: 21765416 05:52:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:52:49 INFO - Fetch https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:52:49 INFO - Http code: 200 05:52:49 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 05:52:49 INFO - x-amz-cf-id: xsIL2ORWu5vKhJ5CNBp78Ev___1g8TIO2SE8t89Xs5W05NzR1XnOFw== 05:52:49 INFO - x-amz-version-id: xiOvzL1G8jHJGZbTvuCK1zlub_fK3VKZ 05:52:49 INFO - Expected file size: 14409749 05:52:49 INFO - Obtained file size: 14409749 05:52:50 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')]} 05:52:50 INFO - trying https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:52:50 INFO - Downloading https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/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 05:52:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/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 05:52:51 INFO - Downloaded 59741871 bytes. 05:52:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:52:51 INFO - mkdir: /builds/slave/test/properties 05:52:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:52:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:52:51 INFO - Contents: 05:52:51 INFO - build_url:https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:52:51 INFO - Running post-action listener: _resource_record_post_action 05:52:51 INFO - Running post-action listener: set_extra_try_arguments 05:52:51 INFO - [mozharness: 2016-11-24 13:52:51.875025Z] Finished download-and-extract step (success) 05:52:51 INFO - [mozharness: 2016-11-24 13:52:51.875326Z] Running populate-webroot step. 05:52:51 INFO - Running pre-action listener: _resource_record_pre_action 05:52:51 INFO - Running main action method: populate_webroot 05:52:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:52:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:52:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:52:51 INFO - '--tppagecycles', 05:52:51 INFO - '7'], 05:52:51 INFO - 'tests': ['tsvgm']}}, 05:52:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:52:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:52:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:52:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:52:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:52:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:52:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:52:51 INFO - 'talos_options': ['--disable-e10s'], 05:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:52:51 INFO - 'talos_options': ['--disable-e10s'], 05:52:51 INFO - 'tests': ['damp', 'tps']}, 05:52:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:52:51 INFO - 'tests': ['damp', 'tps']}, 05:52:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:52:51 INFO - 'tests': ['dromaeo_dom']}, 05:52:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:52:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:52:51 INFO - 'tests': ['basic_compositor_video']}, 05:52:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:52:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:52:51 INFO - 'tests': ['a11yr', 05:52:51 INFO - 'ts_paint', 05:52:51 INFO - 'tpaint', 05:52:51 INFO - 'sessionrestore', 05:52:51 INFO - 'sessionrestore_no_auto_restore', 05:52:51 INFO - 'tabpaint']}, 05:52:51 INFO - 'other-e10s': {'tests': ['a11yr', 05:52:51 INFO - 'ts_paint', 05:52:51 INFO - 'tpaint', 05:52:51 INFO - 'sessionrestore', 05:52:51 INFO - 'sessionrestore_no_auto_restore', 05:52:51 INFO - 'tabpaint']}, 05:52:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:52:51 INFO - 'ts_paint', 05:52:51 INFO - 'tpaint', 05:52:51 INFO - 'sessionrestore', 05:52:51 INFO - 'sessionrestore_no_auto_restore', 05:52:51 INFO - 'tabpaint']}, 05:52:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:52:51 INFO - 'ts_paint', 05:52:51 INFO - 'tpaint', 05:52:51 INFO - 'sessionrestore', 05:52:51 INFO - 'sessionrestore_no_auto_restore', 05:52:51 INFO - 'tabpaint']}, 05:52:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:52:51 INFO - 'tests': ['a11yr', 05:52:51 INFO - 'ts_paint', 05:52:51 INFO - 'tpaint', 05:52:51 INFO - 'sessionrestore', 05:52:51 INFO - 'sessionrestore_no_auto_restore', 05:52:51 INFO - 'tabpaint']}, 05:52:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:52:51 INFO - 'tests': ['a11yr', 05:52:51 INFO - 'ts_paint', 05:52:51 INFO - 'tpaint', 05:52:51 INFO - 'sessionrestore', 05:52:51 INFO - 'sessionrestore_no_auto_restore', 05:52:51 INFO - 'tabpaint']}, 05:52:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:52:51 INFO - 'tests': ['tsvgx', 05:52:51 INFO - 'tsvgr_opacity', 05:52:51 INFO - 'tart', 05:52:51 INFO - 'tscrollx', 05:52:51 INFO - 'cart', 05:52:51 INFO - 'tsvg_static']}, 05:52:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:52:51 INFO - 'tsvgr_opacity', 05:52:51 INFO - 'tart', 05:52:51 INFO - 'tscrollx', 05:52:51 INFO - 'cart', 05:52:51 INFO - 'tsvg_static']}, 05:52:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:52:51 INFO - 'talos_options': ['--disable-e10s'], 05:52:51 INFO - 'tests': ['tp5o']}, 05:52:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:52:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:52:51 INFO - 'talos_options': ['--disable-e10s', 05:52:51 INFO - '--xperf_path', 05:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:51 INFO - 'tests': ['tp5n']}, 05:52:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:52:51 INFO - 'talos_options': ['--xperf_path', 05:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:51 INFO - 'tests': ['tp5n']}}, 05:52:51 INFO - 'talos.zip': {'path': '', 05:52:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:52:51 INFO - Running post-action listener: _resource_record_post_action 05:52:51 INFO - [mozharness: 2016-11-24 13:52:51.896252Z] Finished populate-webroot step (success) 05:52:51 INFO - [mozharness: 2016-11-24 13:52:51.896344Z] Running create-virtualenv step. 05:52:51 INFO - Running pre-action listener: _resource_record_pre_action 05:52:51 INFO - Running main action method: create_virtualenv 05:52:51 INFO - Creating virtualenv /builds/slave/test/build/venv 05:52:51 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 05:52:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:52:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:52:51 INFO - Using real prefix '/usr' 05:52:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:52:52 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:54 INFO - Installing pip.................done. 05:52:54 INFO - Return code: 0 05:52:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:52:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:52:54 INFO - Reading from file tmpfile_stdout 05:52:54 INFO - Output received: 05:52:54 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) 05:52:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:54 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 0x7f61fbdede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abafc0>, '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 0x1abbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc350>, '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': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', '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 05:52:54 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 05:52:54 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 05:52:54 INFO - Using env: {'DISPLAY': ':0', 05:52:54 INFO - 'HOME': '/home/cltbld', 05:52:54 INFO - 'LANG': 'en_US.UTF-8', 05:52:54 INFO - 'LANGUAGE': 'en_US:en', 05:52:54 INFO - 'LOGNAME': 'cltbld', 05:52:54 INFO - 'MAIL': '/var/mail/cltbld', 05:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:54 INFO - 'MOZ_NO_REMOTE': '1', 05:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:54 INFO - 'NO_EM_RESTART': '1', 05:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:54 INFO - 'PWD': '/builds/slave/test', 05:52:54 INFO - 'SHELL': '/bin/bash', 05:52:54 INFO - 'SHLVL': '1', 05:52:54 INFO - 'TERM': 'linux', 05:52:54 INFO - 'TMOUT': '86400', 05:52:54 INFO - 'USER': 'cltbld', 05:52:54 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', 05:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:54 INFO - '_': '/tools/buildbot/bin/python'} 05:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:54 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 05:52:54 INFO - Cleaning up... 05:52:54 INFO - Return code: 0 05:52:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:54 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 0x7f61fbdede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abafc0>, '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 0x1abbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc350>, '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': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', '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 05:52:54 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 05:52:54 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 05:52:54 INFO - Using env: {'DISPLAY': ':0', 05:52:54 INFO - 'HOME': '/home/cltbld', 05:52:54 INFO - 'LANG': 'en_US.UTF-8', 05:52:54 INFO - 'LANGUAGE': 'en_US:en', 05:52:54 INFO - 'LOGNAME': 'cltbld', 05:52:54 INFO - 'MAIL': '/var/mail/cltbld', 05:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:54 INFO - 'MOZ_NO_REMOTE': '1', 05:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:54 INFO - 'NO_EM_RESTART': '1', 05:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:54 INFO - 'PWD': '/builds/slave/test', 05:52:54 INFO - 'SHELL': '/bin/bash', 05:52:54 INFO - 'SHLVL': '1', 05:52:54 INFO - 'TERM': 'linux', 05:52:54 INFO - 'TMOUT': '86400', 05:52:54 INFO - 'USER': 'cltbld', 05:52:54 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', 05:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:54 INFO - '_': '/tools/buildbot/bin/python'} 05:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:55 INFO - Downloading/unpacking psutil>=3.1.1 05:52:55 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 05:52:55 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 05:52:55 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 05:52:55 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 05:52:55 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 05:52:55 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 05:52:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:52:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:57 INFO - Installing collected packages: psutil 05:52:57 INFO - Running setup.py install for psutil 05:52:57 INFO - building 'psutil._psutil_linux' extension 05:52:57 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 05:52:57 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 05:52:57 INFO - building 'psutil._psutil_posix' extension 05:52:57 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 05:52:57 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 05:52:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:57 INFO - Successfully installed psutil 05:52:57 INFO - Cleaning up... 05:52:57 INFO - Return code: 0 05:52:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:57 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 0x7f61fbdede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abafc0>, '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 0x1abbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc350>, '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': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', '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 05:52:57 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 05:52:57 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 05:52:57 INFO - Using env: {'DISPLAY': ':0', 05:52:57 INFO - 'HOME': '/home/cltbld', 05:52:57 INFO - 'LANG': 'en_US.UTF-8', 05:52:57 INFO - 'LANGUAGE': 'en_US:en', 05:52:57 INFO - 'LOGNAME': 'cltbld', 05:52:57 INFO - 'MAIL': '/var/mail/cltbld', 05:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:57 INFO - 'MOZ_NO_REMOTE': '1', 05:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:57 INFO - 'NO_EM_RESTART': '1', 05:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:57 INFO - 'PWD': '/builds/slave/test', 05:52:57 INFO - 'SHELL': '/bin/bash', 05:52:57 INFO - 'SHLVL': '1', 05:52:57 INFO - 'TERM': 'linux', 05:52:57 INFO - 'TMOUT': '86400', 05:52:57 INFO - 'USER': 'cltbld', 05:52:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', 05:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:57 INFO - '_': '/tools/buildbot/bin/python'} 05:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:52:58 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 05:52:58 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 05:52:58 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 05:52:58 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 05:52:58 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 05:52:58 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 05:53:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:53:00 INFO - Installing collected packages: mozsystemmonitor 05:53:00 INFO - Running setup.py install for mozsystemmonitor 05:53:00 INFO - Successfully installed mozsystemmonitor 05:53:00 INFO - Cleaning up... 05:53:00 INFO - Return code: 0 05:53:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:00 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 0x7f61fbdede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abafc0>, '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 0x1abbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc350>, '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': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', '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 05:53:00 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 05:53:00 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 05:53:00 INFO - Using env: {'DISPLAY': ':0', 05:53:00 INFO - 'HOME': '/home/cltbld', 05:53:00 INFO - 'LANG': 'en_US.UTF-8', 05:53:00 INFO - 'LANGUAGE': 'en_US:en', 05:53:00 INFO - 'LOGNAME': 'cltbld', 05:53:00 INFO - 'MAIL': '/var/mail/cltbld', 05:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:00 INFO - 'MOZ_NO_REMOTE': '1', 05:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:00 INFO - 'NO_EM_RESTART': '1', 05:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:00 INFO - 'PWD': '/builds/slave/test', 05:53:00 INFO - 'SHELL': '/bin/bash', 05:53:00 INFO - 'SHLVL': '1', 05:53:00 INFO - 'TERM': 'linux', 05:53:00 INFO - 'TMOUT': '86400', 05:53:00 INFO - 'USER': 'cltbld', 05:53:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', 05:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:00 INFO - '_': '/tools/buildbot/bin/python'} 05:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:00 INFO - Downloading/unpacking jsonschema==2.5.1 05:53:00 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 05:53:00 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 05:53:00 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 05:53:00 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 05:53:00 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 05:53:00 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 05:53:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:53:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:02 INFO - Downloading functools32-3.2.3-2.tar.gz 05:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:53:02 INFO - warning: no files found matching '*.txt' 05:53:02 INFO - no previously-included directories found matching 'build' 05:53:02 INFO - no previously-included directories found matching 'dist' 05:53:02 INFO - no previously-included directories found matching '.git*' 05:53:02 INFO - Installing collected packages: jsonschema, functools32 05:53:02 INFO - Running setup.py install for functools32 05:53:02 INFO - warning: no files found matching '*.txt' 05:53:02 INFO - no previously-included directories found matching 'build' 05:53:02 INFO - no previously-included directories found matching 'dist' 05:53:02 INFO - no previously-included directories found matching '.git*' 05:53:02 INFO - Successfully installed jsonschema functools32 05:53:02 INFO - Cleaning up... 05:53:02 INFO - Return code: 0 05:53:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f61fbdede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abafc0>, '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 0x1abbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc350>, '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': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', '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 05:53:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:53:02 INFO - Using env: {'DISPLAY': ':0', 05:53:02 INFO - 'HOME': '/home/cltbld', 05:53:02 INFO - 'LANG': 'en_US.UTF-8', 05:53:02 INFO - 'LANGUAGE': 'en_US:en', 05:53:02 INFO - 'LOGNAME': 'cltbld', 05:53:02 INFO - 'MAIL': '/var/mail/cltbld', 05:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:02 INFO - 'MOZ_NO_REMOTE': '1', 05:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:02 INFO - 'NO_EM_RESTART': '1', 05:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:02 INFO - 'PWD': '/builds/slave/test', 05:53:02 INFO - 'SHELL': '/bin/bash', 05:53:02 INFO - 'SHLVL': '1', 05:53:02 INFO - 'TERM': 'linux', 05:53:02 INFO - 'TMOUT': '86400', 05:53:02 INFO - 'USER': 'cltbld', 05:53:02 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', 05:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:02 INFO - '_': '/tools/buildbot/bin/python'} 05:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:53:03 INFO - Cleaning up... 05:53:03 INFO - Return code: 0 05:53:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:53:03 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')]} 05:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:03 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')]} 05:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:03 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 0x7f61fbdede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abafc0>, '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 0x1abbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc350>, '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': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', '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 05:53:03 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 05:53:03 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 05:53:03 INFO - Using env: {'DISPLAY': ':0', 05:53:03 INFO - 'HOME': '/home/cltbld', 05:53:03 INFO - 'LANG': 'en_US.UTF-8', 05:53:03 INFO - 'LANGUAGE': 'en_US:en', 05:53:03 INFO - 'LOGNAME': 'cltbld', 05:53:03 INFO - 'MAIL': '/var/mail/cltbld', 05:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:03 INFO - 'MOZ_NO_REMOTE': '1', 05:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:03 INFO - 'NO_EM_RESTART': '1', 05:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:03 INFO - 'PWD': '/builds/slave/test', 05:53:03 INFO - 'SHELL': '/bin/bash', 05:53:03 INFO - 'SHLVL': '1', 05:53:03 INFO - 'TERM': 'linux', 05:53:03 INFO - 'TMOUT': '86400', 05:53:03 INFO - 'USER': 'cltbld', 05:53:03 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', 05:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:03 INFO - '_': '/tools/buildbot/bin/python'} 05:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:03 INFO - Downloading/unpacking blobuploader==1.2.4 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53:05 INFO - Downloading blobuploader-1.2.4.tar.gz 05:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:53:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:53:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:06 INFO - Downloading docopt-0.6.1.tar.gz 05:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:53:06 INFO - Installing collected packages: blobuploader, requests, docopt 05:53:06 INFO - Running setup.py install for blobuploader 05:53:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:53:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:53:06 INFO - Running setup.py install for requests 05:53:06 INFO - Running setup.py install for docopt 05:53:06 INFO - Successfully installed blobuploader requests docopt 05:53:06 INFO - Cleaning up... 05:53:06 INFO - Return code: 0 05:53:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:06 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')]} 05:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:06 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')]} 05:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:06 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 0x7f61fbdede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abafc0>, '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 0x1abbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc350>, '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': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', '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 05:53:06 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 05:53:06 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 05:53:06 INFO - Using env: {'DISPLAY': ':0', 05:53:06 INFO - 'HOME': '/home/cltbld', 05:53:06 INFO - 'LANG': 'en_US.UTF-8', 05:53:06 INFO - 'LANGUAGE': 'en_US:en', 05:53:06 INFO - 'LOGNAME': 'cltbld', 05:53:06 INFO - 'MAIL': '/var/mail/cltbld', 05:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:06 INFO - 'MOZ_NO_REMOTE': '1', 05:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:06 INFO - 'NO_EM_RESTART': '1', 05:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:06 INFO - 'PWD': '/builds/slave/test', 05:53:06 INFO - 'SHELL': '/bin/bash', 05:53:06 INFO - 'SHLVL': '1', 05:53:06 INFO - 'TERM': 'linux', 05:53:06 INFO - 'TMOUT': '86400', 05:53:06 INFO - 'USER': 'cltbld', 05:53:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', 05:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:06 INFO - '_': '/tools/buildbot/bin/python'} 05:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:06 INFO - Running setup.py (path:/tmp/pip-A6EUpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:07 INFO - Running setup.py (path:/tmp/pip-lobb8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:07 INFO - Running setup.py (path:/tmp/pip-S9_Bfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:07 INFO - Running setup.py (path:/tmp/pip-eHD4T7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:07 INFO - Running setup.py (path:/tmp/pip-ukaBvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:07 INFO - Running setup.py (path:/tmp/pip-XZC04j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:07 INFO - Running setup.py (path:/tmp/pip-bp8l6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:07 INFO - Running setup.py (path:/tmp/pip-HmFYL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:07 INFO - Running setup.py (path:/tmp/pip-CChfxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:07 INFO - Running setup.py (path:/tmp/pip-7ScMbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:07 INFO - Running setup.py (path:/tmp/pip-7H0lYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:07 INFO - Running setup.py (path:/tmp/pip-bz4zoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:07 INFO - Running setup.py (path:/tmp/pip-fzcivS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:07 INFO - Running setup.py (path:/tmp/pip-YHfytA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:08 INFO - Running setup.py (path:/tmp/pip-A7ZtlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:08 INFO - Running setup.py (path:/tmp/pip-oNjWGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:08 INFO - Running setup.py (path:/tmp/pip-e6o342-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:53:08 INFO - Running setup.py install for manifestparser 05:53:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:53:08 INFO - Running setup.py install for mozcrash 05:53:08 INFO - Running setup.py install for mozdebug 05:53:08 INFO - Running setup.py install for mozdevice 05:53:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:53:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:53:08 INFO - Running setup.py install for mozfile 05:53:08 INFO - Running setup.py install for mozhttpd 05:53:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:53:08 INFO - Running setup.py install for mozinfo 05:53:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:53:08 INFO - Running setup.py install for mozInstall 05:53:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:53:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:53:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:53:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:53:09 INFO - Running setup.py install for mozleak 05:53:09 INFO - Running setup.py install for mozlog 05:53:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:53:09 INFO - Running setup.py install for moznetwork 05:53:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:53:09 INFO - Running setup.py install for mozprocess 05:53:09 INFO - Running setup.py install for mozprofile 05:53:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:53:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:53:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:53:09 INFO - Running setup.py install for mozrunner 05:53:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:53:09 INFO - Running setup.py install for mozscreenshot 05:53:09 INFO - Running setup.py install for moztest 05:53:09 INFO - Running setup.py install for mozversion 05:53:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:53:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:53:10 INFO - Cleaning up... 05:53:10 INFO - Return code: 0 05:53:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:10 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 0x7f61fbdede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abafc0>, '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 0x1abbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc350>, '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': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', '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 05:53:10 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 05:53:10 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 05:53:10 INFO - Using env: {'DISPLAY': ':0', 05:53:10 INFO - 'HOME': '/home/cltbld', 05:53:10 INFO - 'LANG': 'en_US.UTF-8', 05:53:10 INFO - 'LANGUAGE': 'en_US:en', 05:53:10 INFO - 'LOGNAME': 'cltbld', 05:53:10 INFO - 'MAIL': '/var/mail/cltbld', 05:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:10 INFO - 'MOZ_NO_REMOTE': '1', 05:53:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:10 INFO - 'NO_EM_RESTART': '1', 05:53:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:10 INFO - 'PWD': '/builds/slave/test', 05:53:10 INFO - 'SHELL': '/bin/bash', 05:53:10 INFO - 'SHLVL': '1', 05:53:10 INFO - 'TERM': 'linux', 05:53:10 INFO - 'TMOUT': '86400', 05:53:10 INFO - 'USER': 'cltbld', 05:53:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', 05:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:10 INFO - '_': '/tools/buildbot/bin/python'} 05:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:10 INFO - Running setup.py (path:/tmp/pip-PE3lU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:10 INFO - Running setup.py (path:/tmp/pip-cyasui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:10 INFO - Running setup.py (path:/tmp/pip-vdzdQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:10 INFO - Running setup.py (path:/tmp/pip-SUNNvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:10 INFO - Running setup.py (path:/tmp/pip-yDvFA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:10 INFO - Running setup.py (path:/tmp/pip-OlRfro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:10 INFO - Running setup.py (path:/tmp/pip-h9dMwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:10 INFO - Running setup.py (path:/tmp/pip-ZIuvde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:10 INFO - Running setup.py (path:/tmp/pip-taStNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:10 INFO - Running setup.py (path:/tmp/pip-v4NbC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:11 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)) 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:11 INFO - Running setup.py (path:/tmp/pip-YvqjNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:11 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)) 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:11 INFO - Running setup.py (path:/tmp/pip-OHHhnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:11 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)) 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:11 INFO - Running setup.py (path:/tmp/pip-kKCyoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:11 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)) 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:11 INFO - Running setup.py (path:/tmp/pip-GdNudT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:11 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)) 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:11 INFO - Running setup.py (path:/tmp/pip-Zme4rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:11 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)) 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:11 INFO - Running setup.py (path:/tmp/pip-xNiQhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:11 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)) 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:11 INFO - Running setup.py (path:/tmp/pip-fej3Im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:11 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)) 05:53:11 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)) 05:53:11 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)) 05:53:11 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)) 05:53:11 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)) 05:53:11 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)) 05:53:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:53:11 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 05:53:11 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 05:53:11 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 05:53:11 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 05:53:11 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 05:53:11 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 05:53:13 INFO - Downloading blessings-1.6.tar.gz 05:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:53:13 INFO - Installing collected packages: blessings 05:53:13 INFO - Running setup.py install for blessings 05:53:13 INFO - Successfully installed blessings 05:53:13 INFO - Cleaning up... 05:53:13 INFO - Return code: 0 05:53:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:53:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:13 INFO - Reading from file tmpfile_stdout 05:53:13 INFO - Current package versions: 05:53:13 INFO - argparse == 1.2.1 05:53:13 INFO - blessings == 1.6 05:53:13 INFO - blobuploader == 1.2.4 05:53:13 INFO - docopt == 0.6.1 05:53:13 INFO - functools32 == 3.2.3-2 05:53:13 INFO - jsonschema == 2.5.1 05:53:13 INFO - manifestparser == 1.1 05:53:13 INFO - mozInstall == 1.12 05:53:13 INFO - mozcrash == 1.0 05:53:13 INFO - mozdebug == 0.1 05:53:13 INFO - mozdevice == 0.49 05:53:13 INFO - mozfile == 1.2 05:53:13 INFO - mozhttpd == 0.7 05:53:13 INFO - mozinfo == 0.9 05:53:13 INFO - mozleak == 0.1 05:53:13 INFO - mozlog == 3.4 05:53:14 INFO - moznetwork == 0.27 05:53:14 INFO - mozprocess == 0.23 05:53:14 INFO - mozprofile == 0.28 05:53:14 INFO - mozrunner == 6.13 05:53:14 INFO - mozscreenshot == 0.1 05:53:14 INFO - mozsystemmonitor == 0.3 05:53:14 INFO - moztest == 0.7 05:53:14 INFO - mozversion == 1.4 05:53:14 INFO - psutil == 3.1.1 05:53:14 INFO - requests == 1.2.3 05:53:14 INFO - wsgiref == 0.1.2 05:53:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:14 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')]} 05:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:14 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')]} 05:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:14 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 0x7f61fbdede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abafc0>, '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 0x1abbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc350>, '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': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', '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 05:53:14 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 05:53:14 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 05:53:14 INFO - Using env: {'DISPLAY': ':0', 05:53:14 INFO - 'HOME': '/home/cltbld', 05:53:14 INFO - 'LANG': 'en_US.UTF-8', 05:53:14 INFO - 'LANGUAGE': 'en_US:en', 05:53:14 INFO - 'LOGNAME': 'cltbld', 05:53:14 INFO - 'MAIL': '/var/mail/cltbld', 05:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:14 INFO - 'MOZ_NO_REMOTE': '1', 05:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:14 INFO - 'NO_EM_RESTART': '1', 05:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:14 INFO - 'PWD': '/builds/slave/test', 05:53:14 INFO - 'SHELL': '/bin/bash', 05:53:14 INFO - 'SHLVL': '1', 05:53:14 INFO - 'TERM': 'linux', 05:53:14 INFO - 'TMOUT': '86400', 05:53:14 INFO - 'USER': 'cltbld', 05:53:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', 05:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:14 INFO - '_': '/tools/buildbot/bin/python'} 05:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:14 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)) 05:53:14 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)) 05:53:14 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)) 05:53:14 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)) 05:53:14 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)) 05:53:14 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)) 05:53:14 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)) 05:53:14 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)) 05:53:14 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)) 05:53:14 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)) 05:53:14 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)) 05:53:14 INFO - Cleaning up... 05:53:14 INFO - Return code: 0 05:53:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:53:14 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')]} 05:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:14 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')]} 05:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:14 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 0x7f61fbdede30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abafc0>, '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 0x1abbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc350>, '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': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', '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 05:53:14 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 05:53:14 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 05:53:14 INFO - Using env: {'DISPLAY': ':0', 05:53:14 INFO - 'HOME': '/home/cltbld', 05:53:14 INFO - 'LANG': 'en_US.UTF-8', 05:53:14 INFO - 'LANGUAGE': 'en_US:en', 05:53:14 INFO - 'LOGNAME': 'cltbld', 05:53:14 INFO - 'MAIL': '/var/mail/cltbld', 05:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:14 INFO - 'MOZ_NO_REMOTE': '1', 05:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:14 INFO - 'NO_EM_RESTART': '1', 05:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:14 INFO - 'PWD': '/builds/slave/test', 05:53:14 INFO - 'SHELL': '/bin/bash', 05:53:14 INFO - 'SHLVL': '1', 05:53:14 INFO - 'TERM': 'linux', 05:53:14 INFO - 'TMOUT': '86400', 05:53:14 INFO - 'USER': 'cltbld', 05:53:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', 05:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:14 INFO - '_': '/tools/buildbot/bin/python'} 05:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:53:14 INFO - Cleaning up... 05:53:14 INFO - Return code: 0 05:53:14 INFO - Running post-action listener: _resource_record_post_action 05:53:14 INFO - Running post-action listener: _start_resource_monitoring 05:53:14 INFO - Starting resource monitoring. 05:53:14 INFO - [mozharness: 2016-11-24 13:53:14.486862Z] Finished create-virtualenv step (success) 05:53:14 INFO - [mozharness: 2016-11-24 13:53:14.487382Z] Running install step. 05:53:14 INFO - Running pre-action listener: _resource_record_pre_action 05:53:14 INFO - Running main action method: install 05:53:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:14 INFO - Reading from file tmpfile_stdout 05:53:14 INFO - Detecting whether we're running mozinstall >=1.0... 05:53:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:53:14 INFO - Reading from file tmpfile_stdout 05:53:14 INFO - Output received: 05:53:14 INFO - Usage: mozinstall [options] installer 05:53:14 INFO - Options: 05:53:14 INFO - -h, --help show this help message and exit 05:53:14 INFO - -d DEST, --destination=DEST 05:53:14 INFO - Directory to install application into. [default: 05:53:14 INFO - "/builds/slave/test"] 05:53:14 INFO - --app=APP Application being installed. [default: firefox] 05:53:14 INFO - mkdir: /builds/slave/test/build/application 05:53:14 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'] 05:53:14 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 05:53:32 INFO - Reading from file tmpfile_stdout 05:53:32 INFO - Output received: 05:53:32 INFO - /builds/slave/test/build/application/firefox/firefox 05:53:32 INFO - Running post-action listener: _resource_record_post_action 05:53:32 INFO - [mozharness: 2016-11-24 13:53:32.913808Z] Finished install step (success) 05:53:32 INFO - [mozharness: 2016-11-24 13:53:32.914050Z] Running run-tests step. 05:53:32 INFO - Running pre-action listener: _resource_record_pre_action 05:53:32 INFO - Running main action method: run_tests 05:53:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:53:32 INFO - Python 2.7.3 05:53:32 INFO - Return code: 0 05:53:32 INFO - grabbing minidump binary from tooltool 05:53: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')]} 05:53: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 0x1abafc0>, '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 0x1abbec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abc350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:53: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 05:53: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 05:53: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 05:53:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:32 INFO - Return code: 0 05:53:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:53:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:53:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:53:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:53:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:53:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:53:32 INFO - Using env: {'DISPLAY': ':0', 05:53:32 INFO - 'HOME': '/home/cltbld', 05:53:32 INFO - 'LANG': 'en_US.UTF-8', 05:53:32 INFO - 'LANGUAGE': 'en_US:en', 05:53:32 INFO - 'LOGNAME': 'cltbld', 05:53:32 INFO - 'MAIL': '/var/mail/cltbld', 05:53:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:53:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:32 INFO - 'MOZ_NO_REMOTE': '1', 05:53:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:32 INFO - 'NO_EM_RESTART': '1', 05:53:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:33 INFO - 'PWD': '/builds/slave/test', 05:53:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:53:33 INFO - 'SHELL': '/bin/bash', 05:53:33 INFO - 'SHLVL': '1', 05:53:33 INFO - 'TERM': 'linux', 05:53:33 INFO - 'TMOUT': '86400', 05:53:33 INFO - 'USER': 'cltbld', 05:53:33 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171', 05:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:33 INFO - '_': '/tools/buildbot/bin/python'} 05:53:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:53:33 INFO - mozversion application_buildid: 20161124030208 05:53:33 INFO - mozversion application_changeset: 34fce7c12173bdd6dda54c2ebf6d344252f1ac48 05:53:33 INFO - mozversion application_display_name: Nightly 05:53:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:33 INFO - mozversion application_name: Firefox 05:53:33 INFO - mozversion application_remotingname: firefox 05:53:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:53:33 INFO - mozversion application_vendor: Mozilla 05:53:33 INFO - mozversion application_version: 53.0a1 05:53:33 INFO - mozversion platform_buildid: 20161124030208 05:53:33 INFO - mozversion platform_changeset: 34fce7c12173bdd6dda54c2ebf6d344252f1ac48 05:53:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:53:33 INFO - mozversion platform_version: 53.0a1 05:53:33 INFO - using testdate: 1479995613 05:53:33 INFO - actual date: 1479995613 05:53:33 INFO - starting webserver on 'localhost:59916' 05:53:33 INFO - SUITE-START | Running 2 tests 05:53:33 INFO - TEST-START | dromaeo_css 05:53:33 INFO - operating with platform_type : linux_ 05:53:33 INFO - Initialising browser for dromaeo_css test... 05:53:33 INFO - TEST-INFO | started process 27936 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTAt8DX/profile http://localhost:59916/getInfo.html) 05:53:38 INFO - PROCESS | 27936 | __metrics Screen width/height:1600/1200 05:53:38 INFO - PROCESS | 27936 | colorDepth:24 05:53:38 INFO - PROCESS | 27936 | Browser inner width/height: 1024/697 05:53:38 INFO - PROCESS | 27936 | __metrics 05:53:38 ERROR - PROCESS | 27936 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 05:53:39 INFO - TEST-INFO | 27936: exit 0 05:53:39 INFO - Browser initialized. 05:53:39 INFO - Running cycle 1/1 for dromaeo_css test... 05:53:39 INFO - TEST-INFO | started process 28063 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTAt8DX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:52 INFO - PROCESS | 28063 | RSS: Main: 185901056 05:53:52 INFO - PROCESS | 28063 | 05:54:41 INFO - PROCESS | 28063 | 1479995681766 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] 05:56:53 INFO - PROCESS | 28063 | Cycle 1(1): loaded http://localhost:59916/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59916/tests/dromaeo/cssquery-ext.html) 05:56:55 INFO - PROCESS | 28063 | RSS: Main: 196673536 05:56:55 INFO - PROCESS | 28063 | 05:59:57 INFO - PROCESS | 28063 | Cycle 1(1): loaded http://localhost:59916/tests/dromaeo/cssquery-ext.html (next: http://localhost:59916/tests/dromaeo/cssquery-jquery.html) 05:59:58 INFO - PROCESS | 28063 | RSS: Main: 196829184 05:59:58 INFO - PROCESS | 28063 | 06:03:00 INFO - PROCESS | 28063 | Cycle 1(1): loaded http://localhost:59916/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59916/tests/dromaeo/cssquery-mootools.html) 06:03:00 INFO - PROCESS | 28063 | RSS: Main: 198987776 06:03:00 INFO - PROCESS | 28063 | 06:06:02 INFO - PROCESS | 28063 | Cycle 1(1): loaded http://localhost:59916/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59916/tests/dromaeo/cssquery-prototype.html) 06:06:03 INFO - PROCESS | 28063 | RSS: Main: 195792896 06:06:03 INFO - PROCESS | 28063 | 06:09:05 INFO - PROCESS | 28063 | Cycle 1(1): loaded http://localhost:59916/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59916/tests/dromaeo/cssquery-yui.html) 06:09:06 INFO - PROCESS | 28063 | RSS: Main: 199348224 06:09:06 INFO - PROCESS | 28063 | 06:12:09 INFO - PROCESS | 28063 | Cycle 1(1): loaded http://localhost:59916/tests/dromaeo/cssquery-yui.html (next: http://localhost:59916/tests/dromaeo/cssquery-dojo.html) 06:12:09 INFO - PROCESS | 28063 | RSS: Main: 199434240 06:12:09 INFO - PROCESS | 28063 | 06:12:09 INFO - PROCESS | 28063 | __start_tp_report 06:12:09 INFO - PROCESS | 28063 | _x_x_mozilla_page_load 06:12:09 INFO - PROCESS | 28063 | _x_x_mozilla_page_load_details 06:12:09 INFO - PROCESS | 28063 | |i|pagename|runs| 06:12:09 INFO - PROCESS | 28063 | |0;dojo.html;3026.243439140215;3035.195673146618;3043.254402671346;3065.8467076646175;3082.907512774617;5410.404855465906;5429.809956651518;5454.154606036066;5464.808731694387;5590.02174619442;5430.70131142787;5517.944820551793;5537.778488860441;5538.335399752035;5555.722213889299;4936.136176169156;4945.678530895499;4999.575036121916;5043.546080852722;5168.689878607277;4885.804567817283;5025.221090730943;5025.522575355354;5070.771815268304;5077.822276220333;4956.405231372222;5023.7236951967625;5054.747262636872;5074.543291103819;5110;5054;5086.92369614456;5108.2848401223855;5131.076406246874;5172.094883395391;4833.10587541306;4858.101251268491;4863.902721945577;4949.084419382426;4959.404871415417;5297.47025297471;5381.569474442035;5390.110631745757;5515.393306736296;5544.91682624761;5836.766529338822;5849.795257165979;5853.180554722342;5861.618994765369;5872.412758724094;5939.406059394069;5951.196588460589;5956.880862382772;5957.987142185839;5968.343482216953;5311.840644780663;5335.119705248668;5362.088444964365;5445.673259604437;5479.945200548023;6022.307434644984;6098.250697042149;6101.550206743937;6108.342071131513;6110.467630727307;5811;5849.590528663038;5869.9434101861225;5871.647701137946;5906.616069955525;5705.657660540381;5756.597038207286;5925.318588362394;5943.197668314722;5943.613665111754;5814.854628634233;5822.592418530747;5841.503472204825;5869.06095024794;5918.852028699317;5757.798477053283;5768.596198266165;5803.361630220672;5855.033919403336;5936.7328470218945;4357.520672725997;4359.193549193409;4402.669799765031;4405.427294451701;4418.7127836690515;3949.5458022327225;3956.841726330972;3987.0829709167056;4049.3521036633997;4094.303968325392;5651.2935883014625;5666.376698563155;5667.716614169275;5672.149177623307;5685.914711279334;5802.912956305659;5842.298924129132;5846.473817356458;5850.3564607893095;6032.577719559588;5524.530414914697;5557.5553955683445;5558.6942718150085;5560.360558535739;5563.916541251884;4884.511548845158;4925.187344088257;4933.827316043921;4935.457099719028;4950.232713929347;6136.7852125175405;6141.96929015361;6171.876562468815;6173.444390004921;6186.443220110212;5965.492933100735;5970.582059255984;5976.671283079472;5993.460588547052;5994.790182343597;6000.159977603226;6042.607230530001;6050.9394906050375;6107.552954153702;6153.815385538441;5754.992876246723;5780.5953583248765;5797.710114494174;5830.154627579062;5846.94153058464;5903.468687818117;5969.432903874125;5971.193888825127;5973.193618861572;5976.760929562769;5633.1831884375715;5851.21008663842;5851.531877449879;5853.326867410302;5861.853453663693;5630.18362337467;5713.685747283939;5723.542116630576;5725.570582206435;5727.541796656341;5757.9424205757405;5763.567732420169;5785.074388097884;5811.622244554091;5830.737616807169;5797.913031304618;5803.158542011469;5844.883102338014;5848.53211743068;5856.150858125633;5615.326160860723;5697.145428185805;5715.8571035724435;5719.2279042328755;5723.055695810144 06:12:09 INFO - PROCESS | 28063 | |1;ext.html;542.2449853730554;576.8154190658989;591.1723586978233;595.6039233909449;595.6872641863018;39901.4014789778;41327;41460.58539414605;43886.78056609721;43909.341359879625;42615;42759.57240427595;42771.14457710844;43136.352954705624;43150.7842460788;8401.41190116692;8595.914040859574;8606.698765543208;10188.286819922609;10494.580216791319;10155.086042256195;10235.181185505142;10245.231607629421;10260.384376937407;10265.127464165518;10208.234382421311;10252.487375631226;10280.22898282628;10305.381677099398;10321;10172.135368493688;10233.334833235816;10251.026152515537;10262;10318.58725650973;10287.17702583799;10343.586256549728;10356.17150627948;10374.118199953013;10396.428196449193;41239.58760412387;41309.79345103255;41437;41533;41615;3271.705546500826;3289.917752056194;3296.1594793327786;3394.456886898109;3486.9476957845654;30346.696533034607;30860.84569577138;30937.69062309393;31164.376712465622;32313.353732925443;4193.245215861144;4197.496300443966;4278.4010238566625;4298.18334516444;4390.495093064274;330922;331787;331815;332642.33678831696;333301;58195;58233;58268.125978110365;58365.41634583685;58556.70721646365;61961.690191548754;62171.445713856614;62345.68827155835;62573.37426625766;62638.686806565674;12593.87406125927;12868.806967895489;12871.163374380636;12884.098113132179;12980.35098245084;9767.804643907082;9894;9917;10092.697219083439;10098.192144628412;18488.35290764817;18642.44072677822;18645.440636780917;18739.718904216446;18754;6887.311268873173;6891.793246202622;6954.65226738661;7067.151941766918;7245.311695388929;890.2610833008588;995.8605795188679;1055.5830446973403;1076.8169411200115;1086.983695244572;31318;32150.517742233886;32408.513872291933;32544.674553254164;32570.674293257238;1107.191750022472;1119.8768135505088;1125.5047778977223;1128.1707944660668;1143.1312202725987;15840.050058848909;16857.747133793004;17035;17058.317667293417;17163.742543861852;492970;499498;500262;500379;500928;56246.43753562412;57258;57721.13418298729;57741.71129144327;57825.71087144537;1292.8254685617321;1312.954046608364;1349.963608809652;1352.6618345413647;1361.5642994241946;30612;31243;32013;32275.838620806746;32531.18672033218;50666.493335066174;50991.23513147231;51009.744951275;51054;51095.48904511056;349944;350292;351233;351295;355686;24462.510749785262;25218.24345269645;26432.735672643797;27434.314142146606;27520.17439476819;44262.83196379598;45557.31664025108;45738.54261457343;46393;47118.29322560096;39697.206055878145;40113.598864010986;40114.79942600268;40644.39033414442;41170.794146029075;39250.6074939247;39282.803585981885;39616.20767584575;39649;40515.594844051186;39282.60717392789;40255.396169058076;40266.79866600766;40516.797416012734;40710.79644601758;33841.10827254897;35690.28619427649;36125;36597.26805463929;36745.265094698494;27835.721642784123;28063.71936280611;28106.43787124287;28385.574216387184;28572.85713571419 06:12:09 INFO - PROCESS | 28063 | |2;jquery.html;392.22731219497615;394.4261100099352;405.09461353874093;407.2445613387166;426.62883291536366;13444.3950022249;15557.455489057886;17685.911570442146;19392.806071939278;19442.805571944275;16280.534751872328;16906;17258.568535786613;19240.615187696272;19377.32179373722;5480;5533.142362933741;5674.943250567503;5687.090065589507;5787.160861675055;5631.521320687726;5724.570657200706;5725.427457254283;5726.7422965966425;5751.223584816038;5279.604029697769;5558.221848941152;5602.943970560283;5669.149627555879;5713.971430142843;5601.831945041656;5620.325560932693;5652.378238393753;5657.462541058593;5691.601587888849;5551.333839939233;5598.524125449301;5600.1599760035915;5601.235610782591;5601.3558440779425;13848.723025539433;14011.369488372946;19060.904695476434;22885.31344059681;23157.305280841603;2349.7180338359335;2355.988220058906;2537.8857951392233;2700.3249187703072;2741.2050505353423;9098;9266.721998340061;10047.547860346229;10294.17646588271;10693;1880.8213219744102;1883.331417346836;1940.3596813051659;1943.3684052682934;1986.5728868293243;81488.18511814866;85974;87961;88460.11539884582;89919.55040224822;10345.482725863676;10376.636817711495;10579.84130238047;11205.327680339205;11333.716657083638;15439.30523126462;15476.613084672974;15538.456154034555;15555.455559055605;15595;6807.591544507345;7074.292570742885;7135.6432178391915;7280.8179795504475;7334.3032411920785;6411.711472983634;6424.486041116699;6649.966750166218;6658.167729033871;6679.9332006679315;4545.6136228420955;4719.174144524694;4786.976065119722;4787.61699064074;4862.80548778052;1959.9902000490192;2032.4817171621437;2035.2571311471206;2049.374940643118;2066.163203902422;886.827068721606;918.5131880103422;960.596549449233;1033.9793204135874;1053.9043723596496;17968.91015544914;18796.81203187978;19206.61586768285;19464.416067517996;19892.70160947587;926.5737760630186;944.3531181140941;958.3962103874514;965.1892410375318;971.6550624528332;10168.440735759455;10188.745281368025;10254.230932680079;10260.281780275458;10884.564617415215;328634;332307;335489;429620;432702;56859.43140568624;75382;99181.50409248052;101593;104783.4760826191;1007.7228762090338;1017.5217647705715;1056.984145237822;1056.984145237822;1057.6086847866338;16827.326906923587;17147.742783858503;17679.38122165718;18056.63886722232;18349.266029358678;35181;38422.80788596039;41219.38170927379;41572.79213603913;42010.36984445174;54920.25398729968;58440.415595845196;59478.40521594902;59964.70017649884;60667.69666151641;8015.238552337519;8148.796280093045;8299.875501867356;8326.333893288644;8354.248117669196;11158.55365785392;12209.328486933304;12701.93649031749;13079.869201308245;13093.148945318524;10901.781964360509;11573.132015098732;11663.650090497298;11693.707657308636;11964.461599227881;11111;11219.943900280447;11303.491342889425;11327.433628318386;11329.206955513035;11294.60468883585;11484.138689598482;11694.88305116938;11883.524659013543;11922.76154476923;7959.204079591995;8008.359331253602;8113.35093192555;8275.95862020686;8422.83154336922;8733.519656418704;11135.610253641084;11319;11649.525217660766;11960.401979900797 06:12:09 INFO - PROCESS | 28063 | |3;mootools.html;1431.1699214455614;1456.5193486149572;1541.2216830500595;1661.9252133653983;1683.5791052236941;7869.76390708279;8155.592220388987;8350.457220280678;8468.703595374163;8526.062133165355;8406.159384061591;8496.107908669594;8543.35924805639;8554.401191916568;8569.614367353468;2287.942801429969;2325.4883925536355;2334.8482348647367;2337.3221765688013;2337.6610391493223;2316.6061769499224;2334.1947028275217;2378.714554253492;2379.7144342678903;2383.4160630645515;2286.2341115726254;2303.389601755536;2319.7912187903084;2322.6632138339933;2338.8362814602983;2259.7175353080866;2273.5986695016063;2277.271273192579;2277.9886100569556;2289.164454973931;2295.5064661097945;2302.815774738017;2315.8263130265295;2316.513532158249;2318.7797159269844;7907.920920790776;7926.8810967835525;7938.087119981218;8433.40966132371;8474.364422668263;5099.286099946011;5184.948150518484;5198.870028249286;5217.556507696812;5226.8693282667855;2932.736053755172;2943.146487518617;3224.0327901629653;3257.5113732940013;3266.1181481;987.5506644476818;1005.2309982863115;1024.6311327921942;1031.046282188972;1040.9323393979366;10668.093212076983;10957.342559446459;11054.336739795637;11316.886831131666;11406.885931140665;4404.581564751344;4563.037893705672;4591.1965406053805;4680.789364478538;4685.1332503486965;8917.152870477294;9023.954880225558;9035.683751068682;9038.909610903938;9104.499252541042;5039.974800125976;5062.620303477254;5075.492450754895;5081.136206844845;5082.237664350377;4059.512858457004;4161.313383291784;4721.952780472151;4755.096531658974;4782.95217047832;3588.2105936693883;3691.501647277637;3692.796896170683;3704.166437613345;3775.2638235543805;1133.659902029388;1141.4806263150247;1146.5929594993825;1154.1228666213738;1166.6849950513483;879.7448739865496;889.7706137631742;895.3150839607705;910.5720311453606;912.5665308978182;5471.835844924659;5543.364707411323;5653.943460565341;5693;5755.021646320136;907.1246247371319;917.8026724254318;925.5788616179622;949.6059135458845;990.4849478271259;3698.907527311785;3721.627837216311;3782.111203867089;3825.8087095645105;3833.099221682902;10145.442000690033;10505.947470262752;10521.52653130611;10525.052745252964;10542.736431589272;10236.925122862142;10337.896621033844;10340.327878687862;10363.170946324275;10395.740106497247;7386.741464048732;7752.496087754278;7903.288704016666;7924.841503169904;7928.048634163937;5273.868153296198;5423.457654234545;5536.086545719912;5583.804566840141;5670.829875103754;9061.592228349871;9089.681861135094;9207.17135457812;9324.627014919328;9365.859512107187;9472.431654100501;9510.714678559654;9514.38156519824;9593.616255349707;9725.270604704818;7216.170140433917;7418.109826820816;7472.663730132048;7488.737894173678;7515.962420187864;7704.845903081795;7708.845823083395;7761.689532418866;7790.766277011699;7820.530768153929;7208.243134470805;7271.3455788979245;7345.816354591178;7428.33145016951;7440.73957411488;7102.431805455448;7177.712891484282;7206.459515536251;7222.205557388788;7222.927770722225;6209.2548894133;6378.52161087911;6398.1362516059735;6424.196975378078;6446.387593178641;4784.64115191369;4803.375561177025;4852.781624826962;4856.781444835062;4857.465678775403;4952.5542701157065;4954.8761280968265;5031.195008798574;5082.593392528515;5110.48895110486 06:12:09 INFO - PROCESS | 28063 | |4;prototype.html;315.21511436523065;326.75003622228996;333.25351213282255;334.7823914455602;338.7222477568394;5442.91835622465;5504.80733174339;5513.44865513449;5561.58288128391;5572.219889215508;5426.62013659044;5487.368952570456;5515.972420137894;5528.834134975947;5546;4294.67789915756;4300.677449191323;4302.247106756305;4302.61276485117;4323.962249060234;4247.299195632717;4274.572542745716;4302.70918724383;4330.437043184397;4369.781510924441;4247.362895565659;4265.210935976838;4265.87202383929;4274.957250427487;4294.871153865389;4272.786360681969;4278.486581610211;4293.53121954874;4347.347897815353;4350.847720329805;3678.8896333109783;3807.2385522895256;3808.90477738056;3816.790076545789;3821.7898015609408;5323.281357016792;5332.866678333034;5340.679559226459;5365.919511207335;5386.380566234855;4872.756362181876;4874.488178741252;4892.63305252104;4898.926516102261;4924.975375123137;5519.806806761744;5712.200291959129;5731.197632331477;5736.56975726818;5759.1937128802;4150.252954468195;4152.91694166115;4158.4178215049915;4181.184668989548;4193.454850869398;6103.725332360054;6128.17269668598;6130.908036379458;6134.662593557353;6134.723937422782;4110.835566577363;4236.703430759879;4271.829126834954;4289.849855255114;4297.097609501977;4277.615014648634;4322.978385108117;4324.848630297987;4328.523862375137;4337.457817772778;4957.20684690455;4972.825951091694;4977.203647416396;4987.077390682735;4998.350214472095;5569.081101618269;5825.621334613236;5840.88318233633;5846.532277417797;5853.385394533598;1423.3239211374514;1428.7856821476653;1429.3139293139352;1436.7485690004207;1443.2927865345905;921.4195057114109;944.763809047738;965.1603105298435;972.182019623309;972.2707969023232;5312.123499622597;5314.70769107695;5353.491418315254;5386.622936394415;5412.702301373462;5731.398203188689;5750.389890830575;5754.4533269339345;5776;5783.59514833966;5060.493950604984;5264.499872512105;5289.47105289468;5343.412224655285;5384.219288203267;3026.9243268918453;3044.2389402649337;3048.4665183593224;3059.9541006884915;3082.3681145365144;5837.3287071986415;5896.643771932394;5930.309861689398;6014.278286605635;6052.636841789506;5753.942460575341;5831.562632802556;5839.773647534065;5892.263467066617;5915.585908986416;5880.588358814927;5884.47039766423;5894.528437724972;5899.233099697098;5980.372060933626;5519.2824932758485;5728.794414150499;5769.94230057694;5771.538276937918;5863.384344643921;5668.234788303691;5679.716014199191;5694.629849059798;5709.802510594081;5711.543076553782;5735.799247026334;5884.999550076583;5900.262467191601;5921.822345329647;5947.286325640951;4010.6764767626028;4020.577839326829;4025.329488262338;4043.402855871973;4048.9797551012057;5793.188953546591;5869.383714710065;5880.411958804086;5883.2057672215415;5890.381509941566;5475.342958844964;5629.493345598916;5660.943390566206;5697.7151142443545;5750.239884855209;5766.596338256281;5770.971145144247;5778.797742079007;5806.622569532967;5813.157092221689;5822.76708931655;5836.912446313224;5846.018530549535;5873.23647925784;5883.676172861072;5695.8860822784145;5810.477057064884;5824.388439213822;5876.529877609695;5893.675847828411;5744.482996530165;5745.2818397700285;5747.683877386784;5753.4246575343805;5761.56788240892 06:12:09 INFO - PROCESS | 28063 | |5;yui.html;760.8782594784832;767.3362541401688;770.4876257288903;784.937205023598;819.9631016604252;14738.926305368484;15302.464413745522;15318.693626127499;15328.923355383235;15344.309506072226;14131.434742610283;14286.142831430121;14299.639584697614;14312.570622881303;14332;660.2638058564689;676.7462201674372;758.7723682895137;763.4617594595796;777.933875620573;782.6399856066216;784.1961988961303;789.3014682006408;789.356674310438;789.7591234673422;844.3878188313485;844.9788755281106;845.7293666026874;845.8266055458647;845.9974929708316;839.5046922315832;841.9621117049747;842;842.1957031035347;842.6966292134827;610.6397225636852;612.7242740766628;614.2690198663621;614.9661768602725;615.9692015399257;13774.517891873837;13960.58118256454;14076.366563504667;14131.222782746945;14142.92928535361;12448.875511244862;13638.181709097486;13759;13821.239831809247;13878.791818122736;11302.773944521063;11329.490172942238;11431.714207144805;11488.77022459546;11986.101042421853;3573.446115852047;3603.1892824114625;3654.6162652921325;3665.4135338345736;3806.695464362872;59452.40547594512;59999.80000400011;60565.39434605642;62210;62856.37143628597;10390.636327728493;10752.623658172082;10878;10916.836247456295;10961.068309193808;16710.6657866842;16813.41153059637;16956.23696933641;16957.321707131578;16982.06598637062;7432.85134297311;7442.479026468095;7503.287187717158;7545.320921117126;7562.924370756332;4431.091626216617;4469.234756948591;4531.18438681034;4586.97706511472;4668.856130248111;3419.5212670226188;3514.332276867387;3531.841067151984;3544.617599136339;3548.7870727756417;617.1822335405606;620.8137558732362;641.8908785506475;642.9067785171123;660.8281846719888;667.5727534378002;682.2631557917537;683.8222062263748;694.4340362604461;713.1940906775311;8322.750317490485;8608.78478038054;8612.65549378018;8662.87005694915;9204.95397523008;563.9887202255932;610.5359926455836;640.9839754006094;672.2504407585507;680.5916450129981;3919.451276821247;3949.9012524687114;4128.318827393447;4189.036521600049;4247.4265974093105;88057;88076;90576;91311;94376.52811735898;46598.301025484645;58380;72089.63955180296;75229.62385188039;75886.24113758902;45176;70515.29484705087;72039.63980180066;72265;74782.25217747752;7907;8241.629126689193;8262.462939908886;8295.247141670774;8333.2916702081;46802.29796553122;47525.52474475211;48230;48332.516674832805;48783.75608121937;60443.39556604378;64351;65343;66137.66931165314;67208.91866220106;10999.23005389615;11066.612668556561;11305;11477.62268527782;11792.646220613395;11524.711882203012;11876.093752336954;11979.520819167485;12175.14773965814;12320.383980801103;11387.202895797214;11715.531378745096;11765;12107.81838272409;12339.259644421363;11822.063350213415;12139;12278.815817762563;12622.936885315514;12642.367881606067;11239.606613768807;11378;11613.159331117022;11758.764824703287;12212.938935305267;9351.812963740551;9429.387089839138;9753.414795112032;9803.950980245054;10209.642662506776;8307.418480706534;8627.82744345097;9699.70900872975;9846.359986600848;9867.309288349747 06:12:09 INFO - PROCESS | 28063 | __end_tp_report 06:12:09 INFO - PROCESS | 28063 | __start_cc_report 06:12:09 INFO - PROCESS | 28063 | _x_x_mozilla_cycle_collect,314 06:12:09 INFO - PROCESS | 28063 | __end_cc_report 06:12:09 INFO - PROCESS | 28063 | __startTimestamp1479996729634__endTimestamp 06:12:09 INFO - PROCESS | 28063 | 06:12:09 INFO - PROCESS | 28063 | ------- Summary: start ------- 06:12:09 INFO - PROCESS | 28063 | Number of tests: 6 06:12:09 INFO - PROCESS | 28063 | 06:12:09 INFO - PROCESS | 28063 | [#0] dojo.html Cycles:165 Average:5468.04 Median:5719.23 stddev:654.68 (11.4%) stddev-sans-first:628.04 06:12:09 INFO - PROCESS | 28063 | Values: 3026.2 3035.2 3043.3 3065.8 3082.9 5410.4 5429.8 5454.2 5464.8 5590.0 5430.7 5517.9 5537.8 5538.3 5555.7 4936.1 4945.7 4999.6 5043.5 5168.7 4885.8 5025.2 5025.5 5070.8 5077.8 4956.4 5023.7 5054.7 5074.5 5110.0 5054.0 5086.9 5108.3 5131.1 5172.1 4833.1 4858.1 4863.9 4949.1 4959.4 5297.5 5381.6 5390.1 5515.4 5544.9 5836.8 5849.8 5853.2 5861.6 5872.4 5939.4 5951.2 5956.9 5958.0 5968.3 5311.8 5335.1 5362.1 5445.7 5479.9 6022.3 6098.3 6101.6 6108.3 6110.5 5811.0 5849.6 5869.9 5871.6 5906.6 5705.7 5756.6 5925.3 5943.2 5943.6 5814.9 5822.6 5841.5 5869.1 5918.9 5757.8 5768.6 5803.4 5855.0 5936.7 4357.5 4359.2 4402.7 4405.4 4418.7 3949.5 3956.8 3987.1 4049.4 4094.3 5651.3 5666.4 5667.7 5672.1 5685.9 5802.9 5842.3 5846.5 5850.4 6032.6 5524.5 5557.6 5558.7 5560.4 5563.9 4884.5 4925.2 4933.8 4935.5 4950.2 6136.8 6142.0 6171.9 6173.4 6186.4 5965.5 5970.6 5976.7 5993.5 5994.8 6000.2 6042.6 6050.9 6107.6 6153.8 5755.0 5780.6 5797.7 5830.2 5846.9 5903.5 5969.4 5971.2 5973.2 5976.8 5633.2 5851.2 5851.5 5853.3 5861.9 5630.2 5713.7 5723.5 5725.6 5727.5 5757.9 5763.6 5785.1 5811.6 5830.7 5797.9 5803.2 5844.9 5848.5 5856.2 5615.3 5697.1 5715.9 5719.2 5723.1 06:12:09 INFO - PROCESS | 28063 | 06:12:09 INFO - PROCESS | 28063 | [#1] ext.html Cycles:180 Average:56015.84 Median:351264.00 stddev:106036.30 (30.2%) stddev-sans-first:106251.96 06:12:09 INFO - PROCESS | 28063 | Values: 542.2 576.8 591.2 595.6 595.7 39901.4 41327.0 41460.6 43886.8 43909.3 42615.0 42759.6 42771.1 43136.4 43150.8 8401.4 8595.9 8606.7 10188.3 10494.6 10155.1 10235.2 10245.2 10260.4 10265.1 10208.2 10252.5 10280.2 10305.4 10321.0 10172.1 10233.3 10251.0 10262.0 10318.6 10287.2 10343.6 10356.2 10374.1 10396.4 41239.6 41309.8 41437.0 41533.0 41615.0 3271.7 3289.9 3296.2 3394.5 3486.9 30346.7 30860.8 30937.7 31164.4 32313.4 4193.2 4197.5 4278.4 4298.2 4390.5 330922.0 331787.0 331815.0 332642.3 333301.0 58195.0 58233.0 58268.1 58365.4 58556.7 61961.7 62171.4 62345.7 62573.4 62638.7 12593.9 12868.8 12871.2 12884.1 12980.4 9767.8 9894.0 9917.0 10092.7 10098.2 18488.4 18642.4 18645.4 18739.7 18754.0 6887.3 6891.8 6954.7 7067.2 7245.3 890.3 995.9 1055.6 1076.8 1087.0 31318.0 32150.5 32408.5 32544.7 32570.7 1107.2 1119.9 1125.5 1128.2 1143.1 15840.1 16857.7 17035.0 17058.3 17163.7 492970.0 499498.0 500262.0 500379.0 500928.0 56246.4 57258.0 57721.1 57741.7 57825.7 1292.8 1313.0 1350.0 1352.7 1361.6 30612.0 31243.0 32013.0 32275.8 32531.2 50666.5 50991.2 51009.7 51054.0 51095.5 349944.0 350292.0 351233.0 351295.0 355686.0 24462.5 25218.2 26432.7 27434.3 27520.2 44262.8 45557.3 45738.5 46393.0 47118.3 39697.2 40113.6 40114.8 40644.4 41170.8 39250.6 39282.8 39616.2 39649.0 40515.6 39282.6 40255.4 40266.8 40516.8 40710.8 33841.1 35690.3 36125.0 36597.3 36745.3 27835.7 28063.7 28106.4 28385.6 28572.9 06:12:09 INFO - PROCESS | 28063 | 06:12:09 INFO - PROCESS | 28063 | [#2] jquery.html Cycles:180 Average:25329.40 Median:165687.60 stddev:62836.33 (37.9%) stddev-sans-first:62984.70 06:12:09 INFO - PROCESS | 28063 | Values: 392.2 394.4 405.1 407.2 426.6 13444.4 15557.5 17685.9 19392.8 19442.8 16280.5 16906.0 17258.6 19240.6 19377.3 5480.0 5533.1 5674.9 5687.1 5787.2 5631.5 5724.6 5725.4 5726.7 5751.2 5279.6 5558.2 5602.9 5669.1 5714.0 5601.8 5620.3 5652.4 5657.5 5691.6 5551.3 5598.5 5600.2 5601.2 5601.4 13848.7 14011.4 19060.9 22885.3 23157.3 2349.7 2356.0 2537.9 2700.3 2741.2 9098.0 9266.7 10047.5 10294.2 10693.0 1880.8 1883.3 1940.4 1943.4 1986.6 81488.2 85974.0 87961.0 88460.1 89919.6 10345.5 10376.6 10579.8 11205.3 11333.7 15439.3 15476.6 15538.5 15555.5 15595.0 6807.6 7074.3 7135.6 7280.8 7334.3 6411.7 6424.5 6650.0 6658.2 6679.9 4545.6 4719.2 4787.0 4787.6 4862.8 1960.0 2032.5 2035.3 2049.4 2066.2 886.8 918.5 960.6 1034.0 1053.9 17968.9 18796.8 19206.6 19464.4 19892.7 926.6 944.4 958.4 965.2 971.7 10168.4 10188.7 10254.2 10260.3 10884.6 328634.0 332307.0 335489.0 429620.0 432702.0 56859.4 75382.0 99181.5 101593.0 104783.5 1007.7 1017.5 1057.0 1057.0 1057.6 16827.3 17147.7 17679.4 18056.6 18349.3 35181.0 38422.8 41219.4 41572.8 42010.4 54920.3 58440.4 59478.4 59964.7 60667.7 8015.2 8148.8 8299.9 8326.3 8354.2 11158.6 12209.3 12701.9 13079.9 13093.1 10901.8 11573.1 11663.7 11693.7 11964.5 11111.0 11219.9 11303.5 11327.4 11329.2 11294.6 11484.1 11694.9 11883.5 11922.8 7959.2 8008.4 8113.4 8276.0 8422.8 8733.5 11135.6 11319.0 11649.5 11960.4 06:12:09 INFO - PROCESS | 28063 | 06:12:09 INFO - PROCESS | 28063 | [#3] mootools.html Cycles:180 Average:5457.80 Median:5081.69 stddev:3030.67 (59.6%) stddev-sans-first:3024.06 06:12:09 INFO - PROCESS | 28063 | Values: 1431.2 1456.5 1541.2 1661.9 1683.6 7869.8 8155.6 8350.5 8468.7 8526.1 8406.2 8496.1 8543.4 8554.4 8569.6 2287.9 2325.5 2334.8 2337.3 2337.7 2316.6 2334.2 2378.7 2379.7 2383.4 2286.2 2303.4 2319.8 2322.7 2338.8 2259.7 2273.6 2277.3 2278.0 2289.2 2295.5 2302.8 2315.8 2316.5 2318.8 7907.9 7926.9 7938.1 8433.4 8474.4 5099.3 5184.9 5198.9 5217.6 5226.9 2932.7 2943.1 3224.0 3257.5 3266.1 987.6 1005.2 1024.6 1031.0 1040.9 10668.1 10957.3 11054.3 11316.9 11406.9 4404.6 4563.0 4591.2 4680.8 4685.1 8917.2 9024.0 9035.7 9038.9 9104.5 5040.0 5062.6 5075.5 5081.1 5082.2 4059.5 4161.3 4722.0 4755.1 4783.0 3588.2 3691.5 3692.8 3704.2 3775.3 1133.7 1141.5 1146.6 1154.1 1166.7 879.7 889.8 895.3 910.6 912.6 5471.8 5543.4 5653.9 5693.0 5755.0 907.1 917.8 925.6 949.6 990.5 3698.9 3721.6 3782.1 3825.8 3833.1 10145.4 10505.9 10521.5 10525.1 10542.7 10236.9 10337.9 10340.3 10363.2 10395.7 7386.7 7752.5 7903.3 7924.8 7928.0 5273.9 5423.5 5536.1 5583.8 5670.8 9061.6 9089.7 9207.2 9324.6 9365.9 9472.4 9510.7 9514.4 9593.6 9725.3 7216.2 7418.1 7472.7 7488.7 7516.0 7704.8 7708.8 7761.7 7790.8 7820.5 7208.2 7271.3 7345.8 7428.3 7440.7 7102.4 7177.7 7206.5 7222.2 7222.9 6209.3 6378.5 6398.1 6424.2 6446.4 4784.6 4803.4 4852.8 4856.8 4857.5 4952.6 4954.9 5031.2 5082.6 5110.5 06:12:09 INFO - PROCESS | 28063 | 06:12:09 INFO - PROCESS | 28063 | [#4] prototype.html Cycles:180 Average:4818.04 Median:5514.71 stddev:1413.05 (25.6%) stddev-sans-first:1376.00 06:12:09 INFO - PROCESS | 28063 | Values: 315.2 326.8 333.3 334.8 338.7 5442.9 5504.8 5513.4 5561.6 5572.2 5426.6 5487.4 5516.0 5528.8 5546.0 4294.7 4300.7 4302.2 4302.6 4324.0 4247.3 4274.6 4302.7 4330.4 4369.8 4247.4 4265.2 4265.9 4275.0 4294.9 4272.8 4278.5 4293.5 4347.3 4350.8 3678.9 3807.2 3808.9 3816.8 3821.8 5323.3 5332.9 5340.7 5365.9 5386.4 4872.8 4874.5 4892.6 4898.9 4925.0 5519.8 5712.2 5731.2 5736.6 5759.2 4150.3 4152.9 4158.4 4181.2 4193.5 6103.7 6128.2 6130.9 6134.7 6134.7 4110.8 4236.7 4271.8 4289.8 4297.1 4277.6 4323.0 4324.8 4328.5 4337.5 4957.2 4972.8 4977.2 4987.1 4998.4 5569.1 5825.6 5840.9 5846.5 5853.4 1423.3 1428.8 1429.3 1436.7 1443.3 921.4 944.8 965.2 972.2 972.3 5312.1 5314.7 5353.5 5386.6 5412.7 5731.4 5750.4 5754.5 5776.0 5783.6 5060.5 5264.5 5289.5 5343.4 5384.2 3026.9 3044.2 3048.5 3060.0 3082.4 5837.3 5896.6 5930.3 6014.3 6052.6 5753.9 5831.6 5839.8 5892.3 5915.6 5880.6 5884.5 5894.5 5899.2 5980.4 5519.3 5728.8 5769.9 5771.5 5863.4 5668.2 5679.7 5694.6 5709.8 5711.5 5735.8 5885.0 5900.3 5921.8 5947.3 4010.7 4020.6 4025.3 4043.4 4049.0 5793.2 5869.4 5880.4 5883.2 5890.4 5475.3 5629.5 5660.9 5697.7 5750.2 5766.6 5771.0 5778.8 5806.6 5813.2 5822.8 5836.9 5846.0 5873.2 5883.7 5695.9 5810.5 5824.4 5876.5 5893.7 5744.5 5745.3 5747.7 5753.4 5761.6 06:12:09 INFO - PROCESS | 28063 | 06:12:09 INFO - PROCESS | 28063 | [#5] yui.html Cycles:180 Average:17158.98 Median:59726.10 stddev:23245.48 (38.9%) stddev-sans-first:23278.08 06:12:09 INFO - PROCESS | 28063 | Values: 760.9 767.3 770.5 784.9 820.0 14738.9 15302.5 15318.7 15328.9 15344.3 14131.4 14286.1 14299.6 14312.6 14332.0 660.3 676.7 758.8 763.5 777.9 782.6 784.2 789.3 789.4 789.8 844.4 845.0 845.7 845.8 846.0 839.5 842.0 842.0 842.2 842.7 610.6 612.7 614.3 615.0 616.0 13774.5 13960.6 14076.4 14131.2 14142.9 12448.9 13638.2 13759.0 13821.2 13878.8 11302.8 11329.5 11431.7 11488.8 11986.1 3573.4 3603.2 3654.6 3665.4 3806.7 59452.4 59999.8 60565.4 62210.0 62856.4 10390.6 10752.6 10878.0 10916.8 10961.1 16710.7 16813.4 16956.2 16957.3 16982.1 7432.9 7442.5 7503.3 7545.3 7562.9 4431.1 4469.2 4531.2 4587.0 4668.9 3419.5 3514.3 3531.8 3544.6 3548.8 617.2 620.8 641.9 642.9 660.8 667.6 682.3 683.8 694.4 713.2 8322.8 8608.8 8612.7 8662.9 9205.0 564.0 610.5 641.0 672.3 680.6 3919.5 3949.9 4128.3 4189.0 4247.4 88057.0 88076.0 90576.0 91311.0 94376.5 46598.3 58380.0 72089.6 75229.6 75886.2 45176.0 70515.3 72039.6 72265.0 74782.3 7907.0 8241.6 8262.5 8295.2 8333.3 46802.3 47525.5 48230.0 48332.5 48783.8 60443.4 64351.0 65343.0 66137.7 67208.9 10999.2 11066.6 11305.0 11477.6 11792.6 11524.7 11876.1 11979.5 12175.1 12320.4 11387.2 11715.5 11765.0 12107.8 12339.3 11822.1 12139.0 12278.8 12622.9 12642.4 11239.6 11378.0 11613.2 11758.8 12212.9 9351.8 9429.4 9753.4 9804.0 10209.6 8307.4 8627.8 9699.7 9846.4 9867.3 06:12:09 INFO - PROCESS | 28063 | -------- Summary: end -------- 06:12:09 INFO - PROCESS | 28063 | 06:12:10 INFO - TEST-INFO | 28063: exit 0 06:12:10 INFO - TEST-OK | dromaeo_css | took 1117522ms 06:12:10 INFO - TEST-START | kraken 06:12:10 INFO - operating with platform_type : linux_ 06:12:10 INFO - Initialising browser for kraken test... 06:12:10 INFO - TEST-INFO | started process 28419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt3bzlR/profile http://localhost:59916/getInfo.html) 06:12:15 INFO - PROCESS | 28419 | __metrics Screen width/height:1600/1200 06:12:15 INFO - PROCESS | 28419 | colorDepth:24 06:12:15 INFO - PROCESS | 28419 | Browser inner width/height: 1024/697 06:12:15 INFO - PROCESS | 28419 | __metrics 06:12:16 ERROR - PROCESS | 28419 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 06:12:17 INFO - TEST-INFO | 28419: exit 0 06:12:17 INFO - Browser initialized. 06:12:17 INFO - Running cycle 1/1 for kraken test... 06:12:17 INFO - TEST-INFO | started process 28544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt3bzlR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:29 INFO - PROCESS | 28544 | RSS: Main: 185417728 06:12:29 INFO - PROCESS | 28544 | 06:12:31 INFO - PROCESS | 28544 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59916/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:32 INFO - PROCESS | 28544 | RSS: Main: 198270976 06:12:32 INFO - PROCESS | 28544 | 06:12:35 INFO - PROCESS | 28544 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59916/tests/kraken/driver.html?testName=audio-dft) 06:12:36 INFO - PROCESS | 28544 | RSS: Main: 196415488 06:12:36 INFO - PROCESS | 28544 | 06:12:39 INFO - PROCESS | 28544 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59916/tests/kraken/driver.html?testName=audio-fft) 06:12:39 INFO - PROCESS | 28544 | RSS: Main: 192675840 06:12:39 INFO - PROCESS | 28544 | 06:12:41 INFO - PROCESS | 28544 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59916/tests/kraken/driver.html?testName=audio-oscillator) 06:12:42 INFO - PROCESS | 28544 | RSS: Main: 192872448 06:12:42 INFO - PROCESS | 28544 | 06:12:44 INFO - PROCESS | 28544 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59916/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:12:45 INFO - PROCESS | 28544 | RSS: Main: 193601536 06:12:45 INFO - PROCESS | 28544 | 06:12:48 INFO - PROCESS | 28544 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59916/tests/kraken/driver.html?testName=imaging-darkroom) 06:12:48 INFO - PROCESS | 28544 | RSS: Main: 198877184 06:12:48 INFO - PROCESS | 28544 | 06:12:52 INFO - PROCESS | 28544 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59916/tests/kraken/driver.html?testName=imaging-desaturate) 06:12:52 INFO - PROCESS | 28544 | RSS: Main: 195510272 06:12:52 INFO - PROCESS | 28544 | 06:12:55 INFO - PROCESS | 28544 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59916/tests/kraken/driver.html?testName=json-parse-financial) 06:12:56 INFO - PROCESS | 28544 | RSS: Main: 196849664 06:12:56 INFO - PROCESS | 28544 | 06:12:57 INFO - PROCESS | 28544 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59916/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:12:58 INFO - PROCESS | 28544 | RSS: Main: 196984832 06:12:58 INFO - PROCESS | 28544 | 06:13:00 INFO - PROCESS | 28544 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59916/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:13:00 INFO - PROCESS | 28544 | RSS: Main: 197201920 06:13:00 INFO - PROCESS | 28544 | 06:13:03 INFO - PROCESS | 28544 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59916/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:13:03 INFO - PROCESS | 28544 | RSS: Main: 197136384 06:13:03 INFO - PROCESS | 28544 | 06:13:06 INFO - PROCESS | 28544 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59916/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:13:07 INFO - PROCESS | 28544 | RSS: Main: 197427200 06:13:07 INFO - PROCESS | 28544 | 06:13:10 INFO - PROCESS | 28544 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59916/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:13:10 INFO - PROCESS | 28544 | RSS: Main: 197390336 06:13:10 INFO - PROCESS | 28544 | 06:13:12 INFO - PROCESS | 28544 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59916/tests/kraken/driver.html?testName=ai-astar) 06:13:12 INFO - PROCESS | 28544 | RSS: Main: 199172096 06:13:12 INFO - PROCESS | 28544 | 06:13:12 INFO - PROCESS | 28544 | __start_tp_report 06:13:12 INFO - PROCESS | 28544 | _x_x_mozilla_page_load 06:13:12 INFO - PROCESS | 28544 | _x_x_mozilla_page_load_details 06:13:12 INFO - PROCESS | 28544 | |i|pagename|runs| 06:13:12 INFO - PROCESS | 28544 | |0;ai-astar;104;113;113;113;113;112;115;113;114;114 06:13:12 INFO - PROCESS | 28544 | |1;audio-beat-detection;151;124;124;180;124;126;123;125;142;124 06:13:12 INFO - PROCESS | 28544 | |2;audio-dft;163;163;163;171;171;162;164;164;164;161 06:13:12 INFO - PROCESS | 28544 | |3;audio-fft;77;76;75;113;76;76;77;75;90;76 06:13:12 INFO - PROCESS | 28544 | |4;audio-oscillator;83;83;105;84;83;83;96;84;83;104 06:13:12 INFO - PROCESS | 28544 | |5;imaging-gaussian-blur;117;118;118;118;119;117;119;122;119;117 06:13:12 INFO - PROCESS | 28544 | |6;imaging-darkroom;147;147;150;147;147;147;148;147;147;147 06:13:12 INFO - PROCESS | 28544 | |7;imaging-desaturate;96;98;96;95;96;96;96;96;96;97 06:13:12 INFO - PROCESS | 28544 | |8;json-parse-financial;56;54;53;54;54;55;55;54;55;59 06:13:12 INFO - PROCESS | 28544 | |9;json-stringify-tinderbox;63;62;62;64;63;63;63;63;67;62 06:13:12 INFO - PROCESS | 28544 | |10;stanford-crypto-aes;88;83;81;88;83;82;86;81;81;81 06:13:12 INFO - PROCESS | 28544 | |11;stanford-crypto-ccm;144;133;145;152;132;146;135;134;175;149 06:13:12 INFO - PROCESS | 28544 | |12;stanford-crypto-pbkdf2;171;170;170;172;170;173;168;168;169;172 06:13:12 INFO - PROCESS | 28544 | |13;stanford-crypto-sha256-iterative;68;67;68;69;66;65;67;65;65;65 06:13:12 INFO - PROCESS | 28544 | __end_tp_report 06:13:12 INFO - PROCESS | 28544 | __start_cc_report 06:13:12 INFO - PROCESS | 28544 | _x_x_mozilla_cycle_collect,805 06:13:12 INFO - PROCESS | 28544 | __end_cc_report 06:13:12 INFO - PROCESS | 28544 | __startTimestamp1479996792641__endTimestamp 06:13:12 INFO - PROCESS | 28544 | 06:13:12 INFO - PROCESS | 28544 | ------- Summary: start ------- 06:13:12 INFO - PROCESS | 28544 | Number of tests: 14 06:13:12 INFO - PROCESS | 28544 | 06:13:12 INFO - PROCESS | 28544 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:3.06 (2.7%) stddev-sans-first:0.87 06:13:12 INFO - PROCESS | 28544 | Values: 104.0 113.0 113.0 113.0 113.0 112.0 115.0 113.0 114.0 114.0 06:13:12 INFO - PROCESS | 28544 | 06:13:12 INFO - PROCESS | 28544 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:125.50 stddev:18.66 (14.9%) stddev-sans-first:18.79 06:13:12 INFO - PROCESS | 28544 | Values: 151.0 124.0 124.0 180.0 124.0 126.0 123.0 125.0 142.0 124.0 06:13:12 INFO - PROCESS | 28544 | 06:13:12 INFO - PROCESS | 28544 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:3.50 (2.1%) stddev-sans-first:3.67 06:13:12 INFO - PROCESS | 28544 | Values: 163.0 163.0 163.0 171.0 171.0 162.0 164.0 164.0 164.0 161.0 06:13:12 INFO - PROCESS | 28544 | 06:13:12 INFO - PROCESS | 28544 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:12.06 (15.9%) stddev-sans-first:12.70 06:13:12 INFO - PROCESS | 28544 | Values: 77.0 76.0 75.0 113.0 76.0 76.0 77.0 75.0 90.0 76.0 06:13:12 INFO - PROCESS | 28544 | 06:13:12 INFO - PROCESS | 28544 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:83.00 stddev:9.19 (11.1%) stddev-sans-first:9.50 06:13:12 INFO - PROCESS | 28544 | Values: 83.0 83.0 105.0 84.0 83.0 83.0 96.0 84.0 83.0 104.0 06:13:12 INFO - PROCESS | 28544 | 06:13:12 INFO - PROCESS | 28544 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.50 stddev:1.51 (1.3%) stddev-sans-first:1.51 06:13:12 INFO - PROCESS | 28544 | Values: 117.0 118.0 118.0 118.0 119.0 117.0 119.0 122.0 119.0 117.0 06:13:12 INFO - PROCESS | 28544 | 06:13:12 INFO - PROCESS | 28544 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 06:13:12 INFO - PROCESS | 28544 | Values: 147.0 147.0 150.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 06:13:12 INFO - PROCESS | 28544 | 06:13:12 INFO - PROCESS | 28544 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 06:13:12 INFO - PROCESS | 28544 | Values: 96.0 98.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 97.0 06:13:12 INFO - PROCESS | 28544 | 06:13:12 INFO - PROCESS | 28544 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.66 (3.0%) stddev-sans-first:1.72 06:13:12 INFO - PROCESS | 28544 | Values: 56.0 54.0 53.0 54.0 54.0 55.0 55.0 54.0 55.0 59.0 06:13:12 INFO - PROCESS | 28544 | 06:13:12 INFO - PROCESS | 28544 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:1.48 (2.3%) stddev-sans-first:1.56 06:13:12 INFO - PROCESS | 28544 | Values: 63.0 62.0 62.0 64.0 63.0 63.0 63.0 63.0 67.0 62.0 06:13:12 INFO - PROCESS | 28544 | 06:13:12 INFO - PROCESS | 28544 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:2.88 (3.5%) stddev-sans-first:2.52 06:13:12 INFO - PROCESS | 28544 | Values: 88.0 83.0 81.0 88.0 83.0 82.0 86.0 81.0 81.0 81.0 06:13:12 INFO - PROCESS | 28544 | 06:13:12 INFO - PROCESS | 28544 | [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:145.50 stddev:12.90 (8.9%) stddev-sans-first:13.68 06:13:12 INFO - PROCESS | 28544 | Values: 144.0 133.0 145.0 152.0 132.0 146.0 135.0 134.0 175.0 149.0 06:13:12 INFO - PROCESS | 28544 | 06:13:12 INFO - PROCESS | 28544 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:170.50 stddev:1.70 (1.0%) stddev-sans-first:1.79 06:13:12 INFO - PROCESS | 28544 | Values: 171.0 170.0 170.0 172.0 170.0 173.0 168.0 168.0 169.0 172.0 06:13:12 INFO - PROCESS | 28544 | 06:13:12 INFO - PROCESS | 28544 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.51 (2.3%) stddev-sans-first:1.50 06:13:12 INFO - PROCESS | 28544 | Values: 68.0 67.0 68.0 69.0 66.0 65.0 67.0 65.0 65.0 65.0 06:13:12 INFO - PROCESS | 28544 | -------- Summary: end -------- 06:13:12 INFO - PROCESS | 28544 | 06:13:13 INFO - TEST-INFO | 28544: exit 0 06:13:13 INFO - TEST-OK | kraken | took 63199ms 06:13:13 INFO - SUITE-END | took 1180s 06:13:14 INFO - Completed test suite (00:19:41) 06:13:14 INFO - javascript benchmark 06:13:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7062.984027536518, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3026.243439140215, 3035.195673146618, 3043.254402671346, 3065.8467076646175, 3082.907512774617, 5410.404855465906, 5429.809956651518, 5454.154606036066, 5464.808731694387, 5590.02174619442, 5430.70131142787, 5517.944820551793, 5537.778488860441, 5538.335399752035, 5555.722213889299, 4936.136176169156, 4945.678530895499, 4999.575036121916, 5043.546080852722, 5168.689878607277, 4885.804567817283, 5025.221090730943, 5025.522575355354, 5070.771815268304, 5077.822276220333, 4956.405231372222, 5023.7236951967625, 5054.747262636872, 5074.543291103819, 5110.0, 5054.0, 5086.92369614456, 5108.2848401223855, 5131.076406246874, 5172.094883395391, 4833.10587541306, 4858.101251268491, 4863.902721945577, 4949.084419382426, 4959.404871415417, 5297.47025297471, 5381.569474442035, 5390.110631745757, 5515.393306736296, 5544.91682624761, 5836.766529338822, 5849.795257165979, 5853.180554722342, 5861.618994765369, 5872.412758724094, 5939.406059394069, 5951.196588460589, 5956.880862382772, 5957.987142185839, 5968.343482216953, 5311.840644780663, 5335.119705248668, 5362.088444964365, 5445.673259604437, 5479.945200548023, 6022.307434644984, 6098.250697042149, 6101.550206743937, 6108.342071131513, 6110.467630727307, 5811.0, 5849.590528663038, 5869.9434101861225, 5871.647701137946, 5906.616069955525, 5705.657660540381, 5756.597038207286, 5925.318588362394, 5943.197668314722, 5943.613665111754, 5814.854628634233, 5822.592418530747, 5841.503472204825, 5869.06095024794, 5918.852028699317, 5757.798477053283, 5768.596198266165, 5803.361630220672, 5855.033919403336, 5936.7328470218945, 4357.520672725997, 4359.193549193409, 4402.669799765031, 4405.427294451701, 4418.7127836690515, 3949.5458022327225, 3956.841726330972, 3987.0829709167056, 4049.3521036633997, 4094.303968325392, 5651.2935883014625, 5666.376698563155, 5667.716614169275, 5672.149177623307, 5685.914711279334, 5802.912956305659, 5842.298924129132, 5846.473817356458, 5850.3564607893095, 6032.577719559588, 5524.530414914697, 5557.5553955683445, 5558.6942718150085, 5560.360558535739, 5563.916541251884, 4884.511548845158, 4925.187344088257, 4933.827316043921, 4935.457099719028, 4950.232713929347, 6136.7852125175405, 6141.96929015361, 6171.876562468815, 6173.444390004921, 6186.443220110212, 5965.492933100735, 5970.582059255984, 5976.671283079472, 5993.460588547052, 5994.790182343597, 6000.159977603226, 6042.607230530001, 6050.9394906050375, 6107.552954153702, 6153.815385538441, 5754.992876246723, 5780.5953583248765, 5797.710114494174, 5830.154627579062, 5846.94153058464, 5903.468687818117, 5969.432903874125, 5971.193888825127, 5973.193618861572, 5976.760929562769, 5633.1831884375715, 5851.21008663842, 5851.531877449879, 5853.326867410302, 5861.853453663693, 5630.18362337467, 5713.685747283939, 5723.542116630576, 5725.570582206435, 5727.541796656341, 5757.9424205757405, 5763.567732420169, 5785.074388097884, 5811.622244554091, 5830.737616807169, 5797.913031304618, 5803.158542011469, 5844.883102338014, 5848.53211743068, 5856.150858125633, 5615.326160860723, 5697.145428185805, 5715.8571035724435, 5719.2279042328755, 5723.055695810144], "value": 5420.77014222091, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.2449853730554, 576.8154190658989, 591.1723586978233, 595.6039233909449, 595.6872641863018, 39901.4014789778, 41327.0, 41460.58539414605, 43886.78056609721, 43909.341359879625, 42615.0, 42759.57240427595, 42771.14457710844, 43136.352954705624, 43150.7842460788, 8401.41190116692, 8595.914040859574, 8606.698765543208, 10188.286819922609, 10494.580216791319, 10155.086042256195, 10235.181185505142, 10245.231607629421, 10260.384376937407, 10265.127464165518, 10208.234382421311, 10252.487375631226, 10280.22898282628, 10305.381677099398, 10321.0, 10172.135368493688, 10233.334833235816, 10251.026152515537, 10262.0, 10318.58725650973, 10287.17702583799, 10343.586256549728, 10356.17150627948, 10374.118199953013, 10396.428196449193, 41239.58760412387, 41309.79345103255, 41437.0, 41533.0, 41615.0, 3271.705546500826, 3289.917752056194, 3296.1594793327786, 3394.456886898109, 3486.9476957845654, 30346.696533034607, 30860.84569577138, 30937.69062309393, 31164.376712465622, 32313.353732925443, 4193.245215861144, 4197.496300443966, 4278.4010238566625, 4298.18334516444, 4390.495093064274, 330922.0, 331787.0, 331815.0, 332642.33678831696, 333301.0, 58195.0, 58233.0, 58268.125978110365, 58365.41634583685, 58556.70721646365, 61961.690191548754, 62171.445713856614, 62345.68827155835, 62573.37426625766, 62638.686806565674, 12593.87406125927, 12868.806967895489, 12871.163374380636, 12884.098113132179, 12980.35098245084, 9767.804643907082, 9894.0, 9917.0, 10092.697219083439, 10098.192144628412, 18488.35290764817, 18642.44072677822, 18645.440636780917, 18739.718904216446, 18754.0, 6887.311268873173, 6891.793246202622, 6954.65226738661, 7067.151941766918, 7245.311695388929, 890.2610833008588, 995.8605795188679, 1055.5830446973403, 1076.8169411200115, 1086.983695244572, 31318.0, 32150.517742233886, 32408.513872291933, 32544.674553254164, 32570.674293257238, 1107.191750022472, 1119.8768135505088, 1125.5047778977223, 1128.1707944660668, 1143.1312202725987, 15840.050058848909, 16857.747133793004, 17035.0, 17058.317667293417, 17163.742543861852, 492970.0, 499498.0, 500262.0, 500379.0, 500928.0, 56246.43753562412, 57258.0, 57721.13418298729, 57741.71129144327, 57825.71087144537, 1292.8254685617321, 1312.954046608364, 1349.963608809652, 1352.6618345413647, 1361.5642994241946, 30612.0, 31243.0, 32013.0, 32275.838620806746, 32531.18672033218, 50666.493335066174, 50991.23513147231, 51009.744951275, 51054.0, 51095.48904511056, 349944.0, 350292.0, 351233.0, 351295.0, 355686.0, 24462.510749785262, 25218.24345269645, 26432.735672643797, 27434.314142146606, 27520.17439476819, 44262.83196379598, 45557.31664025108, 45738.54261457343, 46393.0, 47118.29322560096, 39697.206055878145, 40113.598864010986, 40114.79942600268, 40644.39033414442, 41170.794146029075, 39250.6074939247, 39282.803585981885, 39616.20767584575, 39649.0, 40515.594844051186, 39282.60717392789, 40255.396169058076, 40266.79866600766, 40516.797416012734, 40710.79644601758, 33841.10827254897, 35690.28619427649, 36125.0, 36597.26805463929, 36745.265094698494, 27835.721642784123, 28063.71936280611, 28106.43787124287, 28385.574216387184, 28572.85713571419], "value": 19734.655561747106, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.22731219497615, 394.4261100099352, 405.09461353874093, 407.2445613387166, 426.62883291536366, 13444.3950022249, 15557.455489057886, 17685.911570442146, 19392.806071939278, 19442.805571944275, 16280.534751872328, 16906.0, 17258.568535786613, 19240.615187696272, 19377.32179373722, 5480.0, 5533.142362933741, 5674.943250567503, 5687.090065589507, 5787.160861675055, 5631.521320687726, 5724.570657200706, 5725.427457254283, 5726.7422965966425, 5751.223584816038, 5279.604029697769, 5558.221848941152, 5602.943970560283, 5669.149627555879, 5713.971430142843, 5601.831945041656, 5620.325560932693, 5652.378238393753, 5657.462541058593, 5691.601587888849, 5551.333839939233, 5598.524125449301, 5600.1599760035915, 5601.235610782591, 5601.3558440779425, 13848.723025539433, 14011.369488372946, 19060.904695476434, 22885.31344059681, 23157.305280841603, 2349.7180338359335, 2355.988220058906, 2537.8857951392233, 2700.3249187703072, 2741.2050505353423, 9098.0, 9266.721998340061, 10047.547860346229, 10294.17646588271, 10693.0, 1880.8213219744102, 1883.331417346836, 1940.3596813051659, 1943.3684052682934, 1986.5728868293243, 81488.18511814866, 85974.0, 87961.0, 88460.11539884582, 89919.55040224822, 10345.482725863676, 10376.636817711495, 10579.84130238047, 11205.327680339205, 11333.716657083638, 15439.30523126462, 15476.613084672974, 15538.456154034555, 15555.455559055605, 15595.0, 6807.591544507345, 7074.292570742885, 7135.6432178391915, 7280.8179795504475, 7334.3032411920785, 6411.711472983634, 6424.486041116699, 6649.966750166218, 6658.167729033871, 6679.9332006679315, 4545.6136228420955, 4719.174144524694, 4786.976065119722, 4787.61699064074, 4862.80548778052, 1959.9902000490192, 2032.4817171621437, 2035.2571311471206, 2049.374940643118, 2066.163203902422, 886.827068721606, 918.5131880103422, 960.596549449233, 1033.9793204135874, 1053.9043723596496, 17968.91015544914, 18796.81203187978, 19206.61586768285, 19464.416067517996, 19892.70160947587, 926.5737760630186, 944.3531181140941, 958.3962103874514, 965.1892410375318, 971.6550624528332, 10168.440735759455, 10188.745281368025, 10254.230932680079, 10260.281780275458, 10884.564617415215, 328634.0, 332307.0, 335489.0, 429620.0, 432702.0, 56859.43140568624, 75382.0, 99181.50409248052, 101593.0, 104783.4760826191, 1007.7228762090338, 1017.5217647705715, 1056.984145237822, 1056.984145237822, 1057.6086847866338, 16827.326906923587, 17147.742783858503, 17679.38122165718, 18056.63886722232, 18349.266029358678, 35181.0, 38422.80788596039, 41219.38170927379, 41572.79213603913, 42010.36984445174, 54920.25398729968, 58440.415595845196, 59478.40521594902, 59964.70017649884, 60667.69666151641, 8015.238552337519, 8148.796280093045, 8299.875501867356, 8326.333893288644, 8354.248117669196, 11158.55365785392, 12209.328486933304, 12701.93649031749, 13079.869201308245, 13093.148945318524, 10901.781964360509, 11573.132015098732, 11663.650090497298, 11693.707657308636, 11964.461599227881, 11111.0, 11219.943900280447, 11303.491342889425, 11327.433628318386, 11329.206955513035, 11294.60468883585, 11484.138689598482, 11694.88305116938, 11883.524659013543, 11922.76154476923, 7959.204079591995, 8008.359331253602, 8113.35093192555, 8275.95862020686, 8422.83154336922, 8733.519656418704, 11135.610253641084, 11319.0, 11649.525217660766, 11960.401979900797], "value": 8889.87837565719, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.1699214455614, 1456.5193486149572, 1541.2216830500595, 1661.9252133653983, 1683.5791052236941, 7869.76390708279, 8155.592220388987, 8350.457220280678, 8468.703595374163, 8526.062133165355, 8406.159384061591, 8496.107908669594, 8543.35924805639, 8554.401191916568, 8569.614367353468, 2287.942801429969, 2325.4883925536355, 2334.8482348647367, 2337.3221765688013, 2337.6610391493223, 2316.6061769499224, 2334.1947028275217, 2378.714554253492, 2379.7144342678903, 2383.4160630645515, 2286.2341115726254, 2303.389601755536, 2319.7912187903084, 2322.6632138339933, 2338.8362814602983, 2259.7175353080866, 2273.5986695016063, 2277.271273192579, 2277.9886100569556, 2289.164454973931, 2295.5064661097945, 2302.815774738017, 2315.8263130265295, 2316.513532158249, 2318.7797159269844, 7907.920920790776, 7926.8810967835525, 7938.087119981218, 8433.40966132371, 8474.364422668263, 5099.286099946011, 5184.948150518484, 5198.870028249286, 5217.556507696812, 5226.8693282667855, 2932.736053755172, 2943.146487518617, 3224.0327901629653, 3257.5113732940013, 3266.1181481, 987.5506644476818, 1005.2309982863115, 1024.6311327921942, 1031.046282188972, 1040.9323393979366, 10668.093212076983, 10957.342559446459, 11054.336739795637, 11316.886831131666, 11406.885931140665, 4404.581564751344, 4563.037893705672, 4591.1965406053805, 4680.789364478538, 4685.1332503486965, 8917.152870477294, 9023.954880225558, 9035.683751068682, 9038.909610903938, 9104.499252541042, 5039.974800125976, 5062.620303477254, 5075.492450754895, 5081.136206844845, 5082.237664350377, 4059.512858457004, 4161.313383291784, 4721.952780472151, 4755.096531658974, 4782.95217047832, 3588.2105936693883, 3691.501647277637, 3692.796896170683, 3704.166437613345, 3775.2638235543805, 1133.659902029388, 1141.4806263150247, 1146.5929594993825, 1154.1228666213738, 1166.6849950513483, 879.7448739865496, 889.7706137631742, 895.3150839607705, 910.5720311453606, 912.5665308978182, 5471.835844924659, 5543.364707411323, 5653.943460565341, 5693.0, 5755.021646320136, 907.1246247371319, 917.8026724254318, 925.5788616179622, 949.6059135458845, 990.4849478271259, 3698.907527311785, 3721.627837216311, 3782.111203867089, 3825.8087095645105, 3833.099221682902, 10145.442000690033, 10505.947470262752, 10521.52653130611, 10525.052745252964, 10542.736431589272, 10236.925122862142, 10337.896621033844, 10340.327878687862, 10363.170946324275, 10395.740106497247, 7386.741464048732, 7752.496087754278, 7903.288704016666, 7924.841503169904, 7928.048634163937, 5273.868153296198, 5423.457654234545, 5536.086545719912, 5583.804566840141, 5670.829875103754, 9061.592228349871, 9089.681861135094, 9207.17135457812, 9324.627014919328, 9365.859512107187, 9472.431654100501, 9510.714678559654, 9514.38156519824, 9593.616255349707, 9725.270604704818, 7216.170140433917, 7418.109826820816, 7472.663730132048, 7488.737894173678, 7515.962420187864, 7704.845903081795, 7708.845823083395, 7761.689532418866, 7790.766277011699, 7820.530768153929, 7208.243134470805, 7271.3455788979245, 7345.816354591178, 7428.33145016951, 7440.73957411488, 7102.431805455448, 7177.712891484282, 7206.459515536251, 7222.205557388788, 7222.927770722225, 6209.2548894133, 6378.52161087911, 6398.1362516059735, 6424.196975378078, 6446.387593178641, 4784.64115191369, 4803.375561177025, 4852.781624826962, 4856.781444835062, 4857.465678775403, 4952.5542701157065, 4954.8761280968265, 5031.195008798574, 5082.593392528515, 5110.48895110486], "value": 4402.15935562053, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.21511436523065, 326.75003622228996, 333.25351213282255, 334.7823914455602, 338.7222477568394, 5442.91835622465, 5504.80733174339, 5513.44865513449, 5561.58288128391, 5572.219889215508, 5426.62013659044, 5487.368952570456, 5515.972420137894, 5528.834134975947, 5546.0, 4294.67789915756, 4300.677449191323, 4302.247106756305, 4302.61276485117, 4323.962249060234, 4247.299195632717, 4274.572542745716, 4302.70918724383, 4330.437043184397, 4369.781510924441, 4247.362895565659, 4265.210935976838, 4265.87202383929, 4274.957250427487, 4294.871153865389, 4272.786360681969, 4278.486581610211, 4293.53121954874, 4347.347897815353, 4350.847720329805, 3678.8896333109783, 3807.2385522895256, 3808.90477738056, 3816.790076545789, 3821.7898015609408, 5323.281357016792, 5332.866678333034, 5340.679559226459, 5365.919511207335, 5386.380566234855, 4872.756362181876, 4874.488178741252, 4892.63305252104, 4898.926516102261, 4924.975375123137, 5519.806806761744, 5712.200291959129, 5731.197632331477, 5736.56975726818, 5759.1937128802, 4150.252954468195, 4152.91694166115, 4158.4178215049915, 4181.184668989548, 4193.454850869398, 6103.725332360054, 6128.17269668598, 6130.908036379458, 6134.662593557353, 6134.723937422782, 4110.835566577363, 4236.703430759879, 4271.829126834954, 4289.849855255114, 4297.097609501977, 4277.615014648634, 4322.978385108117, 4324.848630297987, 4328.523862375137, 4337.457817772778, 4957.20684690455, 4972.825951091694, 4977.203647416396, 4987.077390682735, 4998.350214472095, 5569.081101618269, 5825.621334613236, 5840.88318233633, 5846.532277417797, 5853.385394533598, 1423.3239211374514, 1428.7856821476653, 1429.3139293139352, 1436.7485690004207, 1443.2927865345905, 921.4195057114109, 944.763809047738, 965.1603105298435, 972.182019623309, 972.2707969023232, 5312.123499622597, 5314.70769107695, 5353.491418315254, 5386.622936394415, 5412.702301373462, 5731.398203188689, 5750.389890830575, 5754.4533269339345, 5776.0, 5783.59514833966, 5060.493950604984, 5264.499872512105, 5289.47105289468, 5343.412224655285, 5384.219288203267, 3026.9243268918453, 3044.2389402649337, 3048.4665183593224, 3059.9541006884915, 3082.3681145365144, 5837.3287071986415, 5896.643771932394, 5930.309861689398, 6014.278286605635, 6052.636841789506, 5753.942460575341, 5831.562632802556, 5839.773647534065, 5892.263467066617, 5915.585908986416, 5880.588358814927, 5884.47039766423, 5894.528437724972, 5899.233099697098, 5980.372060933626, 5519.2824932758485, 5728.794414150499, 5769.94230057694, 5771.538276937918, 5863.384344643921, 5668.234788303691, 5679.716014199191, 5694.629849059798, 5709.802510594081, 5711.543076553782, 5735.799247026334, 5884.999550076583, 5900.262467191601, 5921.822345329647, 5947.286325640951, 4010.6764767626028, 4020.577839326829, 4025.329488262338, 4043.402855871973, 4048.9797551012057, 5793.188953546591, 5869.383714710065, 5880.411958804086, 5883.2057672215415, 5890.381509941566, 5475.342958844964, 5629.493345598916, 5660.943390566206, 5697.7151142443545, 5750.239884855209, 5766.596338256281, 5770.971145144247, 5778.797742079007, 5806.622569532967, 5813.157092221689, 5822.76708931655, 5836.912446313224, 5846.018530549535, 5873.23647925784, 5883.676172861072, 5695.8860822784145, 5810.477057064884, 5824.388439213822, 5876.529877609695, 5893.675847828411, 5744.482996530165, 5745.2818397700285, 5747.683877386784, 5753.4246575343805, 5761.56788240892], "value": 4360.031405196773, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.8782594784832, 767.3362541401688, 770.4876257288903, 784.937205023598, 819.9631016604252, 14738.926305368484, 15302.464413745522, 15318.693626127499, 15328.923355383235, 15344.309506072226, 14131.434742610283, 14286.142831430121, 14299.639584697614, 14312.570622881303, 14332.0, 660.2638058564689, 676.7462201674372, 758.7723682895137, 763.4617594595796, 777.933875620573, 782.6399856066216, 784.1961988961303, 789.3014682006408, 789.356674310438, 789.7591234673422, 844.3878188313485, 844.9788755281106, 845.7293666026874, 845.8266055458647, 845.9974929708316, 839.5046922315832, 841.9621117049747, 842.0, 842.1957031035347, 842.6966292134827, 610.6397225636852, 612.7242740766628, 614.2690198663621, 614.9661768602725, 615.9692015399257, 13774.517891873837, 13960.58118256454, 14076.366563504667, 14131.222782746945, 14142.92928535361, 12448.875511244862, 13638.181709097486, 13759.0, 13821.239831809247, 13878.791818122736, 11302.773944521063, 11329.490172942238, 11431.714207144805, 11488.77022459546, 11986.101042421853, 3573.446115852047, 3603.1892824114625, 3654.6162652921325, 3665.4135338345736, 3806.695464362872, 59452.40547594512, 59999.80000400011, 60565.39434605642, 62210.0, 62856.37143628597, 10390.636327728493, 10752.623658172082, 10878.0, 10916.836247456295, 10961.068309193808, 16710.6657866842, 16813.41153059637, 16956.23696933641, 16957.321707131578, 16982.06598637062, 7432.85134297311, 7442.479026468095, 7503.287187717158, 7545.320921117126, 7562.924370756332, 4431.091626216617, 4469.234756948591, 4531.18438681034, 4586.97706511472, 4668.856130248111, 3419.5212670226188, 3514.332276867387, 3531.841067151984, 3544.617599136339, 3548.7870727756417, 617.1822335405606, 620.8137558732362, 641.8908785506475, 642.9067785171123, 660.8281846719888, 667.5727534378002, 682.2631557917537, 683.8222062263748, 694.4340362604461, 713.1940906775311, 8322.750317490485, 8608.78478038054, 8612.65549378018, 8662.87005694915, 9204.95397523008, 563.9887202255932, 610.5359926455836, 640.9839754006094, 672.2504407585507, 680.5916450129981, 3919.451276821247, 3949.9012524687114, 4128.318827393447, 4189.036521600049, 4247.4265974093105, 88057.0, 88076.0, 90576.0, 91311.0, 94376.52811735898, 46598.301025484645, 58380.0, 72089.63955180296, 75229.62385188039, 75886.24113758902, 45176.0, 70515.29484705087, 72039.63980180066, 72265.0, 74782.25217747752, 7907.0, 8241.629126689193, 8262.462939908886, 8295.247141670774, 8333.2916702081, 46802.29796553122, 47525.52474475211, 48230.0, 48332.516674832805, 48783.75608121937, 60443.39556604378, 64351.0, 65343.0, 66137.66931165314, 67208.91866220106, 10999.23005389615, 11066.612668556561, 11305.0, 11477.62268527782, 11792.646220613395, 11524.711882203012, 11876.093752336954, 11979.520819167485, 12175.14773965814, 12320.383980801103, 11387.202895797214, 11715.531378745096, 11765.0, 12107.81838272409, 12339.259644421363, 11822.063350213415, 12139.0, 12278.815817762563, 12622.936885315514, 12642.367881606067, 11239.606613768807, 11378.0, 11613.159331117022, 11758.764824703287, 12212.938935305267, 9351.812963740551, 9429.387089839138, 9753.414795112032, 9803.950980245054, 10209.642662506776, 8307.418480706534, 8627.82744345097, 9699.70900872975, 9846.359986600848, 9867.309288349747], "value": 6800.540776715231, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 113.0, 113.0, 113.0, 112.0, 115.0, 113.0, 114.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 124.0, 180.0, 124.0, 126.0, 123.0, 125.0, 142.0, 124.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 171.0, 171.0, 162.0, 164.0, 164.0, 164.0, 161.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 113.0, 76.0, 76.0, 77.0, 75.0, 90.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 105.0, 84.0, 83.0, 83.0, 96.0, 84.0, 83.0, 104.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 119.0, 117.0, 119.0, 122.0, 119.0, 117.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 150.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 53.0, 54.0, 54.0, 55.0, 55.0, 54.0, 55.0, 59.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 64.0, 63.0, 63.0, 63.0, 63.0, 67.0, 62.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 81.0, 88.0, 83.0, 82.0, 86.0, 81.0, 81.0, 81.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 133.0, 145.0, 152.0, 132.0, 146.0, 135.0, 134.0, 175.0, 149.0], "value": 144.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 170.0, 172.0, 170.0, 173.0, 168.0, 168.0, 169.0, 172.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 69.0, 66.0, 65.0, 67.0, 65.0, 65.0, 65.0], "value": 66.5, "unit": "score"}]}]} 06:13:14 INFO - Return code: 0 06:13:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:13:14 ERROR - # TBPL SUCCESS # 06:13:14 INFO - Running post-action listener: _resource_record_post_action 06:13:14 INFO - [mozharness: 2016-11-24 14:13:14.453500Z] Finished run-tests step (success) 06:13:14 INFO - Running post-run listener: _resource_record_post_run 06:13:14 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 12288; Write bytes: 404344832; Read time: 344; Write time: 473084 06:13:14 INFO - TinderboxPrint: CPU usage
13.5% 06:13:14 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 344 06:13:14 INFO - TinderboxPrint: I/O write bytes / time
404,344,832 / 473,084 06:13:14 INFO - TinderboxPrint: CPU idle
8,270.6 (86.5%) 06:13:14 INFO - TinderboxPrint: CPU user
1,225.8 (12.8%) 06:13:14 INFO - TinderboxPrint: Swap in / out
0 / 0 06:13:14 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 115298304; Read time: 0; Write time: 117608 06:13:14 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289046528; Read time: 340; Write time: 355476 06:13:15 INFO - Running post-run listener: _upload_blobber_files 06:13:15 INFO - Blob upload gear active. 06:13:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:13:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:13:15 INFO - (blobuploader) - INFO - Open directory for files ... 06:13:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:13:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:13:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:16 INFO - (blobuploader) - INFO - Done attempting. 06:13:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:13:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:13:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:19 INFO - (blobuploader) - INFO - Done attempting. 06:13:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:13:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:13:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:20 INFO - (blobuploader) - INFO - Done attempting. 06:13:20 INFO - (blobuploader) - INFO - Iteration through files over. 06:13:20 INFO - Return code: 0 06:13:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:13:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:13:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e2e527c491a26122e6abf18b080a4a2d6214b5694a0ac7e08afe4d29e8d7bd26a690930634acf3b0eca4d1b2d0d71a31425573e2e81aba1c9cdae24943d8349", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd55cb3b892c303833dd26d09c6e5ac765b158780c24ead88a15bed0a62b2b110c2c8dd5f8022c42bf26187548f6ccb9f99993818c787091b228260a7f519a5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf100e609e1330772aa89ff4b4976073501d6c02c31997f17ac0a34736bf4455c073cf35195f5e9e8abc80740774185c46302a0cfba21554e1ae7e85bbed5b31"} 06:13:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:13:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:13:20 INFO - Contents: 06:13:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e2e527c491a26122e6abf18b080a4a2d6214b5694a0ac7e08afe4d29e8d7bd26a690930634acf3b0eca4d1b2d0d71a31425573e2e81aba1c9cdae24943d8349", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd55cb3b892c303833dd26d09c6e5ac765b158780c24ead88a15bed0a62b2b110c2c8dd5f8022c42bf26187548f6ccb9f99993818c787091b228260a7f519a5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf100e609e1330772aa89ff4b4976073501d6c02c31997f17ac0a34736bf4455c073cf35195f5e9e8abc80740774185c46302a0cfba21554e1ae7e85bbed5b31"} 06:13:20 INFO - Running post-run listener: copy_logs_to_upload_dir 06:13:20 INFO - Copying logs to upload dir... 06:13:20 INFO - mkdir: /builds/slave/test/build/upload/logs 06:13:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.663331 ========= master_lag: 1.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-11-24 06:13:21.485091) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 06:13:21.490066) ========= 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=8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e2e527c491a26122e6abf18b080a4a2d6214b5694a0ac7e08afe4d29e8d7bd26a690930634acf3b0eca4d1b2d0d71a31425573e2e81aba1c9cdae24943d8349", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd55cb3b892c303833dd26d09c6e5ac765b158780c24ead88a15bed0a62b2b110c2c8dd5f8022c42bf26187548f6ccb9f99993818c787091b228260a7f519a5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf100e609e1330772aa89ff4b4976073501d6c02c31997f17ac0a34736bf4455c073cf35195f5e9e8abc80740774185c46302a0cfba21554e1ae7e85bbed5b31"} build_url:https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011807 build_url: 'https://queue.taskcluster.net/v1/task/VrZ2jrnhSpWhQIYmrrzp_g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e2e527c491a26122e6abf18b080a4a2d6214b5694a0ac7e08afe4d29e8d7bd26a690930634acf3b0eca4d1b2d0d71a31425573e2e81aba1c9cdae24943d8349", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd55cb3b892c303833dd26d09c6e5ac765b158780c24ead88a15bed0a62b2b110c2c8dd5f8022c42bf26187548f6ccb9f99993818c787091b228260a7f519a5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf100e609e1330772aa89ff4b4976073501d6c02c31997f17ac0a34736bf4455c073cf35195f5e9e8abc80740774185c46302a0cfba21554e1ae7e85bbed5b31"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 06:13:21.526664) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 06:13:21.527052) ========= 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=8783db0840cc980e80bb0bd400000236-1479993894.22489-1470732171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 06:13:21.580199) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 06:13:21.580841) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 06:13:21.581489) ========= ========= Total master_lag: 1.16 =========