builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1476552403.6 results: success (0) buildid: 20161015073001 builduid: a526a775d5e04625829ccb85e18fda8c revision: a1768c915756429b74f73fac2e8dd4e7b4919730 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-15 10:26:43.607065) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-15 10:26:43.607618) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-15 10:26:43.607944) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-15 10:26:43.657107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 10:26:43.657435) ========= 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=0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-15 10:26:44-- 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% 95.7M=0s 2016-10-15 10:26:44 (95.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122204 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 10:26:43.801562) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 10:26:43.802132) ========= 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=0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015695 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 10:26:43.866941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 10:26:43.867304) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a1768c915756429b74f73fac2e8dd4e7b4919730 --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 a1768c915756429b74f73fac2e8dd4e7b4919730 --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=0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-15 10:26:44,295 truncating revision to first 12 chars 2016-10-15 10:26:44,295 Setting DEBUG logging. 2016-10-15 10:26:44,296 attempt 1/10 2016-10-15 10:26:44,296 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a1768c915756?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-15 10:26:44,778 unpacking tar archive at: mozilla-central-a1768c915756/testing/mozharness/ program finished with exit code 0 elapsedTime=0.876064 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 10:26:44.770407) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-15 10:26:44.770739) ========= script_repo_revision: a1768c915756429b74f73fac2e8dd4e7b4919730 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-15 10:26:44.771207) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-15 10:26:44.771513) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-15 10:26:44.809967) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-15 10:26:44.810273) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:26:45 INFO - MultiFileLogger online at 20161015 10:26:45 in /builds/slave/test 10:26:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:26:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:26:45 INFO - {'append_to_log': False, 10:26:45 INFO - 'base_work_dir': '/builds/slave/test', 10:26:45 INFO - 'blob_upload_branch': 'Firefox', 10:26:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:26:45 INFO - 'branch': 'Firefox', 10:26:45 INFO - 'buildbot_json_path': 'buildprops.json', 10:26:45 INFO - 'config_files': ('talos/linux_config.py',), 10:26:45 INFO - 'default_actions': ('clobber', 10:26:45 INFO - 'read-buildbot-config', 10:26:45 INFO - 'download-and-extract', 10:26:45 INFO - 'populate-webroot', 10:26:45 INFO - 'create-virtualenv', 10:26:45 INFO - 'install', 10:26:45 INFO - 'run-tests'), 10:26:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:26:45 INFO - 'download_minidump_stackwalk': True, 10:26:45 INFO - 'download_symbols': 'ondemand', 10:26:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:26:45 INFO - 'tooltool.py': '/tools/tooltool.py', 10:26:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:26:45 INFO - '/tools/misc-python/virtualenv.py')}, 10:26:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:26:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:26:45 INFO - 'installer_path': 'installer.exe', 10:26:45 INFO - 'log_level': 'info', 10:26:45 INFO - 'log_name': 'talos', 10:26:45 INFO - 'log_to_console': True, 10:26:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:26:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:26:45 INFO - 'opt_config_files': (), 10:26:45 INFO - 'pip_index': False, 10:26:45 INFO - 'sps_profile': False, 10:26:45 INFO - 'sps_profile_interval': 0, 10:26:45 INFO - 'suite': 'dromaeojs', 10:26:45 INFO - 'system_bits': '32', 10:26:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:26:45 INFO - 'title': 'talos-linux64-ix-017', 10:26:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:26:45 INFO - 'use_talos_json': True, 10:26:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:26:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:26:45 INFO - 'work_dir': 'build'} 10:26:45 INFO - [mozharness: 2016-10-15 17:26:45.334717Z] Running clobber step. 10:26:45 INFO - Running pre-action listener: _resource_record_pre_action 10:26:45 INFO - Running main action method: clobber 10:26:45 INFO - rmtree: /builds/slave/test/build 10:26:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:26:46 INFO - Running post-action listener: _resource_record_post_action 10:26:46 INFO - [mozharness: 2016-10-15 17:26:46.313564Z] Finished clobber step (success) 10:26:46 INFO - [mozharness: 2016-10-15 17:26:46.313662Z] Running read-buildbot-config step. 10:26:46 INFO - Running pre-action listener: _resource_record_pre_action 10:26:46 INFO - Running main action method: read_buildbot_config 10:26:46 INFO - Using buildbot properties: 10:26:46 INFO - { 10:26:46 INFO - "project": "", 10:26:46 INFO - "product": "firefox", 10:26:46 INFO - "script_repo_revision": "production", 10:26:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:26:46 INFO - "repository": "", 10:26:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:26:46 INFO - "buildid": "20161015073001", 10:26:46 INFO - "pgo_build": "True", 10:26:46 INFO - "basedir": "/builds/slave/test", 10:26:46 INFO - "buildnumber": 10, 10:26:46 INFO - "slavename": "talos-linux64-ix-017", 10:26:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:26:46 INFO - "platform": "ubuntu64_hw", 10:26:46 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:26:46 INFO - "branch": "mozilla-central", 10:26:46 INFO - "repo_path": "mozilla-central", 10:26:46 INFO - "revision": "a1768c915756429b74f73fac2e8dd4e7b4919730", 10:26:46 INFO - "stage_platform": "linux64-pgo", 10:26:46 INFO - "builduid": "a526a775d5e04625829ccb85e18fda8c", 10:26:46 INFO - "slavebuilddir": "test" 10:26:46 INFO - } 10:26:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:26:46 INFO - Running post-action listener: _resource_record_post_action 10:26:46 INFO - [mozharness: 2016-10-15 17:26:46.316071Z] Finished read-buildbot-config step (success) 10:26:46 INFO - [mozharness: 2016-10-15 17:26:46.316159Z] Running download-and-extract step. 10:26:46 INFO - Running pre-action listener: _resource_record_pre_action 10:26:46 INFO - Running main action method: download_and_extract 10:26:46 INFO - mkdir: /builds/slave/test/build/tests 10:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:46 INFO - trying https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:26:46 INFO - Downloading https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:26:46 INFO - Downloaded 1361 bytes. 10:26:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:26:46 INFO - Using the following test package requirements: 10:26:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:26:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:26:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:26:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:26:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:26:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:26:46 INFO - u'jsshell-linux-x86_64.zip'], 10:26:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:26:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:26:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:26:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:26:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:26:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:26:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:26:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:26:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:26:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:26:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:26:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:26:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:26:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:26:46 INFO - Fetch https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:26:47 INFO - Http code: 200 10:26:47 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 10:26:47 INFO - x-amz-cf-id: 1edpY3ekwhNe89-tiVxJW0MJMD87GXw7xGR7Vf_0FBcKtpRgg0oI0w== 10:26:47 INFO - x-amz-version-id: Ig0apPId_lvZve0kF8IJFP46w3mifp9M 10:26:48 INFO - Expected file size: 22123251 10:26:48 INFO - Obtained file size: 22123251 10:26:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:26:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:26:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:26:52 INFO - Fetch https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:26:52 INFO - Http code: 200 10:26:52 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 10:26:52 INFO - x-amz-cf-id: jWFnzCR9vuXDb54ncGZcEFaDenQASt_BtdPUiwqxGEQPqeMd4Z0kLg== 10:26:52 INFO - x-amz-version-id: Ig0apPId_lvZve0kF8IJFP46w3mifp9M 10:26:53 INFO - Expected file size: 22123251 10:26:53 INFO - Obtained file size: 22123251 10:26:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:26:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:26:57 INFO - Fetch https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:26:58 INFO - Http code: 200 10:26:58 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 10:26:58 INFO - x-amz-cf-id: -xeHxRk_sR3r5RIwdVdRCcpzgEjrTiwwxgxx963PMqqs6fpvxpM8MQ== 10:26:58 INFO - x-amz-version-id: gd2.HQgYUS29cqwloQt9.zsZGZAESw1. 10:26:58 INFO - Expected file size: 14409028 10:26:58 INFO - Obtained file size: 14409028 10:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:59 INFO - trying https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:26:59 INFO - Downloading https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:26:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:27:01 INFO - Downloaded 59596419 bytes. 10:27:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:27:01 INFO - mkdir: /builds/slave/test/properties 10:27:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:27:01 INFO - Writing to file /builds/slave/test/properties/build_url 10:27:01 INFO - Contents: 10:27:01 INFO - build_url:https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:27:01 INFO - Running post-action listener: _resource_record_post_action 10:27:01 INFO - Running post-action listener: set_extra_try_arguments 10:27:01 INFO - [mozharness: 2016-10-15 17:27:01.969973Z] Finished download-and-extract step (success) 10:27:01 INFO - [mozharness: 2016-10-15 17:27:01.970200Z] Running populate-webroot step. 10:27:01 INFO - Running pre-action listener: _resource_record_pre_action 10:27:01 INFO - Running main action method: populate_webroot 10:27:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:27:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:27:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:27:01 INFO - '--tppagecycles', 10:27:01 INFO - '7'], 10:27:01 INFO - 'tests': ['tsvgm']}}, 10:27:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:27:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:27:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:27:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:27:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:27:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:27:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:01 INFO - 'talos_options': ['--disable-e10s'], 10:27:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:27:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:27:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:01 INFO - 'talos_options': ['--disable-e10s'], 10:27:01 INFO - 'tests': ['damp', 'tps']}, 10:27:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:01 INFO - 'tests': ['damp', 'tps']}, 10:27:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:27:01 INFO - 'tests': ['dromaeo_dom']}, 10:27:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:27:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:27:01 INFO - 'tests': ['basic_compositor_video']}, 10:27:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:27:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:27:01 INFO - 'tests': ['a11yr', 10:27:01 INFO - 'ts_paint', 10:27:01 INFO - 'tpaint', 10:27:01 INFO - 'sessionrestore', 10:27:01 INFO - 'sessionrestore_no_auto_restore', 10:27:01 INFO - 'tabpaint']}, 10:27:01 INFO - 'other-e10s': {'tests': ['a11yr', 10:27:01 INFO - 'ts_paint', 10:27:01 INFO - 'tpaint', 10:27:01 INFO - 'sessionrestore', 10:27:01 INFO - 'sessionrestore_no_auto_restore', 10:27:01 INFO - 'tabpaint']}, 10:27:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:27:01 INFO - 'ts_paint', 10:27:01 INFO - 'tpaint', 10:27:01 INFO - 'sessionrestore', 10:27:01 INFO - 'sessionrestore_no_auto_restore', 10:27:01 INFO - 'tabpaint']}, 10:27:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:27:01 INFO - 'ts_paint', 10:27:01 INFO - 'tpaint', 10:27:01 INFO - 'sessionrestore', 10:27:01 INFO - 'sessionrestore_no_auto_restore', 10:27:01 INFO - 'tabpaint']}, 10:27:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:27:01 INFO - 'tests': ['a11yr', 10:27:01 INFO - 'ts_paint', 10:27:01 INFO - 'tpaint', 10:27:01 INFO - 'sessionrestore', 10:27:01 INFO - 'sessionrestore_no_auto_restore', 10:27:01 INFO - 'tabpaint']}, 10:27:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:27:01 INFO - 'tests': ['a11yr', 10:27:01 INFO - 'ts_paint', 10:27:01 INFO - 'tpaint', 10:27:01 INFO - 'sessionrestore', 10:27:01 INFO - 'sessionrestore_no_auto_restore', 10:27:01 INFO - 'tabpaint']}, 10:27:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:27:01 INFO - 'tests': ['tsvgx', 10:27:01 INFO - 'tsvgr_opacity', 10:27:01 INFO - 'tart', 10:27:01 INFO - 'tscrollx', 10:27:01 INFO - 'cart']}, 10:27:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:27:01 INFO - 'tsvgr_opacity', 10:27:01 INFO - 'tart', 10:27:01 INFO - 'tscrollx', 10:27:01 INFO - 'cart']}, 10:27:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:01 INFO - 'talos_options': ['--disable-e10s'], 10:27:01 INFO - 'tests': ['tp5o']}, 10:27:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:01 INFO - 'tests': ['tp5o']}, 10:27:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:01 INFO - 'talos_options': ['--disable-e10s', 10:27:01 INFO - '--xperf_path', 10:27:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:27:01 INFO - 'tests': ['tp5n']}, 10:27:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:01 INFO - 'talos_options': ['--xperf_path', 10:27:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:27:01 INFO - 'tests': ['tp5n']}}, 10:27:01 INFO - 'talos.zip': {'path': '', 10:27:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:27:01 INFO - Running post-action listener: _resource_record_post_action 10:27:01 INFO - [mozharness: 2016-10-15 17:27:01.985511Z] Finished populate-webroot step (success) 10:27:01 INFO - [mozharness: 2016-10-15 17:27:01.985599Z] Running create-virtualenv step. 10:27:01 INFO - Running pre-action listener: _resource_record_pre_action 10:27:01 INFO - Running main action method: create_virtualenv 10:27:01 INFO - Creating virtualenv /builds/slave/test/build/venv 10:27:01 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 10:27:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:27:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:27:02 INFO - Using real prefix '/usr' 10:27:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:27:02 INFO - Installing distribute.............................................................................................................................................................................................done. 10:27:04 INFO - Installing pip.................done. 10:27:04 INFO - Return code: 0 10:27:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:27:04 INFO - Reading from file tmpfile_stdout 10:27:04 INFO - Output received: 10:27:04 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) 10:27:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0eacb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e790>, '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 0x278f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278fb20>, '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': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', '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 10:27:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:27:04 INFO - Using env: {'DISPLAY': ':0', 10:27:04 INFO - 'HOME': '/home/cltbld', 10:27:04 INFO - 'LANG': 'en_US.UTF-8', 10:27:04 INFO - 'LANGUAGE': 'en_US:en', 10:27:04 INFO - 'LOGNAME': 'cltbld', 10:27:04 INFO - 'MAIL': '/var/mail/cltbld', 10:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:04 INFO - 'MOZ_NO_REMOTE': '1', 10:27:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:04 INFO - 'NO_EM_RESTART': '1', 10:27:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:04 INFO - 'PWD': '/builds/slave/test', 10:27:04 INFO - 'SHELL': '/bin/bash', 10:27:04 INFO - 'SHLVL': '1', 10:27:04 INFO - 'TERM': 'linux', 10:27:04 INFO - 'TMOUT': '86400', 10:27:04 INFO - 'USER': 'cltbld', 10:27:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', 10:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:04 INFO - '_': '/tools/buildbot/bin/python'} 10:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:04 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 10:27:04 INFO - Cleaning up... 10:27:04 INFO - Return code: 0 10:27:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:05 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 0x7f0eacb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e790>, '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 0x278f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278fb20>, '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': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', '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 10:27:05 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 10:27:05 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 10:27:05 INFO - Using env: {'DISPLAY': ':0', 10:27:05 INFO - 'HOME': '/home/cltbld', 10:27:05 INFO - 'LANG': 'en_US.UTF-8', 10:27:05 INFO - 'LANGUAGE': 'en_US:en', 10:27:05 INFO - 'LOGNAME': 'cltbld', 10:27:05 INFO - 'MAIL': '/var/mail/cltbld', 10:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:05 INFO - 'MOZ_NO_REMOTE': '1', 10:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:05 INFO - 'NO_EM_RESTART': '1', 10:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:05 INFO - 'PWD': '/builds/slave/test', 10:27:05 INFO - 'SHELL': '/bin/bash', 10:27:05 INFO - 'SHLVL': '1', 10:27:05 INFO - 'TERM': 'linux', 10:27:05 INFO - 'TMOUT': '86400', 10:27:05 INFO - 'USER': 'cltbld', 10:27:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', 10:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:05 INFO - '_': '/tools/buildbot/bin/python'} 10:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:05 INFO - Downloading/unpacking psutil>=3.1.1 10:27: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 10:27: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 10:27: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 10:27: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 10:27: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 10:27: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 10:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:27:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:27:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:27:07 INFO - Installing collected packages: psutil 10:27:07 INFO - Running setup.py install for psutil 10:27:07 INFO - building 'psutil._psutil_linux' extension 10:27:07 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 10:27:07 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 10:27:07 INFO - building 'psutil._psutil_posix' extension 10:27:07 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 10:27:07 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 10:27:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:27:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:27:07 INFO - Successfully installed psutil 10:27:07 INFO - Cleaning up... 10:27:07 INFO - Return code: 0 10:27:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0eacb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e790>, '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 0x278f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278fb20>, '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': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', '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 10:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:27:07 INFO - Using env: {'DISPLAY': ':0', 10:27:07 INFO - 'HOME': '/home/cltbld', 10:27:07 INFO - 'LANG': 'en_US.UTF-8', 10:27:07 INFO - 'LANGUAGE': 'en_US:en', 10:27:07 INFO - 'LOGNAME': 'cltbld', 10:27:07 INFO - 'MAIL': '/var/mail/cltbld', 10:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:07 INFO - 'MOZ_NO_REMOTE': '1', 10:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:07 INFO - 'NO_EM_RESTART': '1', 10:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:07 INFO - 'PWD': '/builds/slave/test', 10:27:07 INFO - 'SHELL': '/bin/bash', 10:27:07 INFO - 'SHLVL': '1', 10:27:07 INFO - 'TERM': 'linux', 10:27:07 INFO - 'TMOUT': '86400', 10:27:07 INFO - 'USER': 'cltbld', 10:27:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', 10:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:07 INFO - '_': '/tools/buildbot/bin/python'} 10:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:27:08 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 10:27:08 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 10:27:08 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 10:27:08 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 10:27:08 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 10:27:08 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 10:27:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:27:09 INFO - Installing collected packages: mozsystemmonitor 10:27:09 INFO - Running setup.py install for mozsystemmonitor 10:27:10 INFO - Successfully installed mozsystemmonitor 10:27:10 INFO - Cleaning up... 10:27:10 INFO - Return code: 0 10:27:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:27: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')]} 10:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27: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')]} 10:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0eacb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e790>, '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 0x278f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278fb20>, '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': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', '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 10:27:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:27:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:27:10 INFO - Using env: {'DISPLAY': ':0', 10:27:10 INFO - 'HOME': '/home/cltbld', 10:27:10 INFO - 'LANG': 'en_US.UTF-8', 10:27:10 INFO - 'LANGUAGE': 'en_US:en', 10:27:10 INFO - 'LOGNAME': 'cltbld', 10:27:10 INFO - 'MAIL': '/var/mail/cltbld', 10:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:10 INFO - 'MOZ_NO_REMOTE': '1', 10:27:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:10 INFO - 'NO_EM_RESTART': '1', 10:27:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:10 INFO - 'PWD': '/builds/slave/test', 10:27:10 INFO - 'SHELL': '/bin/bash', 10:27:10 INFO - 'SHLVL': '1', 10:27:10 INFO - 'TERM': 'linux', 10:27:10 INFO - 'TMOUT': '86400', 10:27:10 INFO - 'USER': 'cltbld', 10:27:10 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', 10:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:10 INFO - '_': '/tools/buildbot/bin/python'} 10:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:10 INFO - Downloading/unpacking jsonschema==2.5.1 10:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:27:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:12 INFO - Downloading functools32-3.2.3-2.tar.gz 10:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:27:12 INFO - warning: no files found matching '*.txt' 10:27:12 INFO - no previously-included directories found matching 'build' 10:27:12 INFO - no previously-included directories found matching 'dist' 10:27:12 INFO - no previously-included directories found matching '.git*' 10:27:12 INFO - Installing collected packages: jsonschema, functools32 10:27:12 INFO - Running setup.py install for functools32 10:27:12 INFO - warning: no files found matching '*.txt' 10:27:12 INFO - no previously-included directories found matching 'build' 10:27:12 INFO - no previously-included directories found matching 'dist' 10:27:12 INFO - no previously-included directories found matching '.git*' 10:27:12 INFO - Successfully installed jsonschema functools32 10:27:12 INFO - Cleaning up... 10:27:12 INFO - Return code: 0 10:27:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:27:12 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')]} 10:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:12 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')]} 10:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:12 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 0x7f0eacb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e790>, '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 0x278f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278fb20>, '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': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', '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 10:27:12 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 10:27:12 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 10:27:12 INFO - Using env: {'DISPLAY': ':0', 10:27:12 INFO - 'HOME': '/home/cltbld', 10:27:12 INFO - 'LANG': 'en_US.UTF-8', 10:27:12 INFO - 'LANGUAGE': 'en_US:en', 10:27:12 INFO - 'LOGNAME': 'cltbld', 10:27:12 INFO - 'MAIL': '/var/mail/cltbld', 10:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:12 INFO - 'MOZ_NO_REMOTE': '1', 10:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:12 INFO - 'NO_EM_RESTART': '1', 10:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:12 INFO - 'PWD': '/builds/slave/test', 10:27:12 INFO - 'SHELL': '/bin/bash', 10:27:12 INFO - 'SHLVL': '1', 10:27:12 INFO - 'TERM': 'linux', 10:27:12 INFO - 'TMOUT': '86400', 10:27:12 INFO - 'USER': 'cltbld', 10:27:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', 10:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:12 INFO - '_': '/tools/buildbot/bin/python'} 10:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:27:12 INFO - Cleaning up... 10:27:12 INFO - Return code: 0 10:27:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:27:12 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')]} 10:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:12 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')]} 10:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:12 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 0x7f0eacb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e790>, '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 0x278f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278fb20>, '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': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', '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 10:27:12 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 10:27:12 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 10:27:12 INFO - Using env: {'DISPLAY': ':0', 10:27:12 INFO - 'HOME': '/home/cltbld', 10:27:12 INFO - 'LANG': 'en_US.UTF-8', 10:27:12 INFO - 'LANGUAGE': 'en_US:en', 10:27:12 INFO - 'LOGNAME': 'cltbld', 10:27:12 INFO - 'MAIL': '/var/mail/cltbld', 10:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:12 INFO - 'MOZ_NO_REMOTE': '1', 10:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:12 INFO - 'NO_EM_RESTART': '1', 10:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:12 INFO - 'PWD': '/builds/slave/test', 10:27:12 INFO - 'SHELL': '/bin/bash', 10:27:12 INFO - 'SHLVL': '1', 10:27:12 INFO - 'TERM': 'linux', 10:27:12 INFO - 'TMOUT': '86400', 10:27:12 INFO - 'USER': 'cltbld', 10:27:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', 10:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:12 INFO - '_': '/tools/buildbot/bin/python'} 10:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:13 INFO - Downloading/unpacking blobuploader==1.2.4 10:27:13 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 10:27:13 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 10:27:13 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 10:27:13 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 10:27:13 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 10:27:13 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 10:27:15 INFO - Downloading blobuploader-1.2.4.tar.gz 10:27:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:27:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:27:15 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 10:27:15 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 10:27:15 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 10:27:15 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 10:27:15 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 10:27:15 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 10:27:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:27:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:27:15 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 10:27:15 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 10:27:15 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 10:27:15 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 10:27:15 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 10:27:15 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 10:27:15 INFO - Downloading docopt-0.6.1.tar.gz 10:27:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:27:15 INFO - Installing collected packages: blobuploader, requests, docopt 10:27:15 INFO - Running setup.py install for blobuploader 10:27:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:27:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:27:15 INFO - Running setup.py install for requests 10:27:16 INFO - Running setup.py install for docopt 10:27:16 INFO - Successfully installed blobuploader requests docopt 10:27:16 INFO - Cleaning up... 10:27:16 INFO - Return code: 0 10:27:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:16 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 0x7f0eacb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e790>, '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 0x278f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278fb20>, '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': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', '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 10:27:16 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 10:27:16 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 10:27:16 INFO - Using env: {'DISPLAY': ':0', 10:27:16 INFO - 'HOME': '/home/cltbld', 10:27:16 INFO - 'LANG': 'en_US.UTF-8', 10:27:16 INFO - 'LANGUAGE': 'en_US:en', 10:27:16 INFO - 'LOGNAME': 'cltbld', 10:27:16 INFO - 'MAIL': '/var/mail/cltbld', 10:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:16 INFO - 'MOZ_NO_REMOTE': '1', 10:27:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:16 INFO - 'NO_EM_RESTART': '1', 10:27:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:16 INFO - 'PWD': '/builds/slave/test', 10:27:16 INFO - 'SHELL': '/bin/bash', 10:27:16 INFO - 'SHLVL': '1', 10:27:16 INFO - 'TERM': 'linux', 10:27:16 INFO - 'TMOUT': '86400', 10:27:16 INFO - 'USER': 'cltbld', 10:27:16 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', 10:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:16 INFO - '_': '/tools/buildbot/bin/python'} 10:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:27:16 INFO - Running setup.py (path:/tmp/pip-NLK8cX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:27:16 INFO - Running setup.py (path:/tmp/pip-L_vYGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:27:16 INFO - Running setup.py (path:/tmp/pip-wYE9yW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:27:16 INFO - Running setup.py (path:/tmp/pip-Le4hik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:27:17 INFO - Running setup.py (path:/tmp/pip-i6pKOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:27:17 INFO - Running setup.py (path:/tmp/pip-eabjbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:27:17 INFO - Running setup.py (path:/tmp/pip-NbGzKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:27:17 INFO - Running setup.py (path:/tmp/pip-qK9Z4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:27:17 INFO - Running setup.py (path:/tmp/pip-qcW7C2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:27:17 INFO - Running setup.py (path:/tmp/pip-a2vRW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:27:17 INFO - Running setup.py (path:/tmp/pip-Y9_q02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:27:17 INFO - Running setup.py (path:/tmp/pip-4zO_oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:27:17 INFO - Running setup.py (path:/tmp/pip-UJb9X0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:27:17 INFO - Running setup.py (path:/tmp/pip-ViMjgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:27:17 INFO - Running setup.py (path:/tmp/pip-FAci51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:27:17 INFO - Running setup.py (path:/tmp/pip-N97D5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:27:17 INFO - Running setup.py (path:/tmp/pip-POgoYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:27:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:27:17 INFO - Running setup.py install for manifestparser 10:27:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:27:18 INFO - Running setup.py install for mozcrash 10:27:18 INFO - Running setup.py install for mozdebug 10:27:18 INFO - Running setup.py install for mozdevice 10:27:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:27:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:27:18 INFO - Running setup.py install for mozfile 10:27:18 INFO - Running setup.py install for mozhttpd 10:27:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:27:18 INFO - Running setup.py install for mozinfo 10:27:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:27:18 INFO - Running setup.py install for mozInstall 10:27:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:27:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:27:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:27:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:27:18 INFO - Running setup.py install for mozleak 10:27:18 INFO - Running setup.py install for mozlog 10:27:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:27:18 INFO - Running setup.py install for moznetwork 10:27:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:27:19 INFO - Running setup.py install for mozprocess 10:27:19 INFO - Running setup.py install for mozprofile 10:27:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:27:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:27:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:27:19 INFO - Running setup.py install for mozrunner 10:27:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:27:19 INFO - Running setup.py install for mozscreenshot 10:27:19 INFO - Running setup.py install for moztest 10:27:19 INFO - Running setup.py install for mozversion 10:27:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:27:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:27:19 INFO - Cleaning up... 10:27:19 INFO - Return code: 0 10:27:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:27:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:19 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 0x7f0eacb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e790>, '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 0x278f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278fb20>, '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': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', '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 10:27:19 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 10:27:19 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 10:27:19 INFO - Using env: {'DISPLAY': ':0', 10:27:19 INFO - 'HOME': '/home/cltbld', 10:27:19 INFO - 'LANG': 'en_US.UTF-8', 10:27:19 INFO - 'LANGUAGE': 'en_US:en', 10:27:19 INFO - 'LOGNAME': 'cltbld', 10:27:19 INFO - 'MAIL': '/var/mail/cltbld', 10:27:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:19 INFO - 'MOZ_NO_REMOTE': '1', 10:27:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:19 INFO - 'NO_EM_RESTART': '1', 10:27:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:19 INFO - 'PWD': '/builds/slave/test', 10:27:19 INFO - 'SHELL': '/bin/bash', 10:27:19 INFO - 'SHLVL': '1', 10:27:19 INFO - 'TERM': 'linux', 10:27:19 INFO - 'TMOUT': '86400', 10:27:19 INFO - 'USER': 'cltbld', 10:27:19 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', 10:27:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:19 INFO - '_': '/tools/buildbot/bin/python'} 10:27:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:27:19 INFO - Running setup.py (path:/tmp/pip-jQ3r_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:27:20 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)) 10:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:27:20 INFO - Running setup.py (path:/tmp/pip-e_LH5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:27:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:27:20 INFO - Running setup.py (path:/tmp/pip-X5pub6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:27:20 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)) 10:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:27:20 INFO - Running setup.py (path:/tmp/pip-1yxyfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:27:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:27:20 INFO - Running setup.py (path:/tmp/pip-0rrEsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:27:20 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)) 10:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:27:20 INFO - Running setup.py (path:/tmp/pip-UM05iN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:27:20 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)) 10:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:27:20 INFO - Running setup.py (path:/tmp/pip-dRJyaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:27:20 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)) 10:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:27:20 INFO - Running setup.py (path:/tmp/pip-_VbcsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:27:20 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)) 10:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:27:20 INFO - Running setup.py (path:/tmp/pip-agibF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:27:20 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)) 10:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:27:20 INFO - Running setup.py (path:/tmp/pip-35oAO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:27:20 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)) 10:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:27:20 INFO - Running setup.py (path:/tmp/pip-pCqJvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:27:20 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)) 10:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:27:20 INFO - Running setup.py (path:/tmp/pip-bEAqHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:27:20 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)) 10:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:27:20 INFO - Running setup.py (path:/tmp/pip-GDubAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:27:20 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)) 10:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:27:20 INFO - Running setup.py (path:/tmp/pip-Y_0DDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:27:21 INFO - Running setup.py (path:/tmp/pip-5LXf6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:27:21 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)) 10:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:27:21 INFO - Running setup.py (path:/tmp/pip-3aAgFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:27:21 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)) 10:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:27:21 INFO - Running setup.py (path:/tmp/pip-8UWEgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:27:21 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)) 10:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:27:21 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)) 10:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:27:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:27:21 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 10:27:21 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 10:27:21 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 10:27:21 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 10:27:21 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 10:27:21 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 10:27:23 INFO - Downloading blessings-1.6.tar.gz 10:27:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:27:23 INFO - Installing collected packages: blessings 10:27:23 INFO - Running setup.py install for blessings 10:27:23 INFO - Successfully installed blessings 10:27:23 INFO - Cleaning up... 10:27:23 INFO - Return code: 0 10:27:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:27:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:27:23 INFO - Reading from file tmpfile_stdout 10:27:23 INFO - Current package versions: 10:27:23 INFO - argparse == 1.2.1 10:27:23 INFO - blessings == 1.6 10:27:23 INFO - blobuploader == 1.2.4 10:27:23 INFO - docopt == 0.6.1 10:27:23 INFO - functools32 == 3.2.3-2 10:27:23 INFO - jsonschema == 2.5.1 10:27:23 INFO - manifestparser == 1.1 10:27:23 INFO - mozInstall == 1.12 10:27:23 INFO - mozcrash == 0.17 10:27:23 INFO - mozdebug == 0.1 10:27:23 INFO - mozdevice == 0.48 10:27:23 INFO - mozfile == 1.2 10:27:23 INFO - mozhttpd == 0.7 10:27:23 INFO - mozinfo == 0.9 10:27:23 INFO - mozleak == 0.1 10:27:23 INFO - mozlog == 3.4 10:27:23 INFO - moznetwork == 0.27 10:27:23 INFO - mozprocess == 0.23 10:27:23 INFO - mozprofile == 0.28 10:27:23 INFO - mozrunner == 6.12 10:27:23 INFO - mozscreenshot == 0.1 10:27:23 INFO - mozsystemmonitor == 0.3 10:27:23 INFO - moztest == 0.7 10:27:23 INFO - mozversion == 1.4 10:27:23 INFO - psutil == 3.1.1 10:27:23 INFO - requests == 1.2.3 10:27:23 INFO - wsgiref == 0.1.2 10:27:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:27:23 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')]} 10:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:23 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')]} 10:27:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:23 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 0x7f0eacb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e790>, '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 0x278f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278fb20>, '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': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', '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 10:27:23 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 10:27:23 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 10:27:23 INFO - Using env: {'DISPLAY': ':0', 10:27:23 INFO - 'HOME': '/home/cltbld', 10:27:23 INFO - 'LANG': 'en_US.UTF-8', 10:27:23 INFO - 'LANGUAGE': 'en_US:en', 10:27:23 INFO - 'LOGNAME': 'cltbld', 10:27:23 INFO - 'MAIL': '/var/mail/cltbld', 10:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:23 INFO - 'MOZ_NO_REMOTE': '1', 10:27:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:23 INFO - 'NO_EM_RESTART': '1', 10:27:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:23 INFO - 'PWD': '/builds/slave/test', 10:27:23 INFO - 'SHELL': '/bin/bash', 10:27:23 INFO - 'SHLVL': '1', 10:27:23 INFO - 'TERM': 'linux', 10:27:23 INFO - 'TMOUT': '86400', 10:27:23 INFO - 'USER': 'cltbld', 10:27:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', 10:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:23 INFO - '_': '/tools/buildbot/bin/python'} 10:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:23 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)) 10:27:23 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)) 10:27:23 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)) 10:27:23 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)) 10:27:23 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)) 10:27:23 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)) 10:27:23 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)) 10:27:23 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)) 10:27:23 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)) 10:27:23 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)) 10:27:23 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)) 10:27:23 INFO - Cleaning up... 10:27:23 INFO - Return code: 0 10:27:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:27:23 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')]} 10:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:23 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')]} 10:27:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:23 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 0x7f0eacb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e790>, '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 0x278f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278fb20>, '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': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', '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 10:27:23 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 10:27:23 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 10:27:23 INFO - Using env: {'DISPLAY': ':0', 10:27:23 INFO - 'HOME': '/home/cltbld', 10:27:23 INFO - 'LANG': 'en_US.UTF-8', 10:27:23 INFO - 'LANGUAGE': 'en_US:en', 10:27:23 INFO - 'LOGNAME': 'cltbld', 10:27:23 INFO - 'MAIL': '/var/mail/cltbld', 10:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:23 INFO - 'MOZ_NO_REMOTE': '1', 10:27:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:23 INFO - 'NO_EM_RESTART': '1', 10:27:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:23 INFO - 'PWD': '/builds/slave/test', 10:27:23 INFO - 'SHELL': '/bin/bash', 10:27:23 INFO - 'SHLVL': '1', 10:27:23 INFO - 'TERM': 'linux', 10:27:23 INFO - 'TMOUT': '86400', 10:27:23 INFO - 'USER': 'cltbld', 10:27:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', 10:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:23 INFO - '_': '/tools/buildbot/bin/python'} 10:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:27:24 INFO - Cleaning up... 10:27:24 INFO - Return code: 0 10:27:24 INFO - Running post-action listener: _resource_record_post_action 10:27:24 INFO - Running post-action listener: _start_resource_monitoring 10:27:24 INFO - Starting resource monitoring. 10:27:24 INFO - [mozharness: 2016-10-15 17:27:24.105932Z] Finished create-virtualenv step (success) 10:27:24 INFO - [mozharness: 2016-10-15 17:27:24.106442Z] Running install step. 10:27:24 INFO - Running pre-action listener: _resource_record_pre_action 10:27:24 INFO - Running main action method: install 10:27:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:27:24 INFO - Reading from file tmpfile_stdout 10:27:24 INFO - Detecting whether we're running mozinstall >=1.0... 10:27:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:27:24 INFO - Reading from file tmpfile_stdout 10:27:24 INFO - Output received: 10:27:24 INFO - Usage: mozinstall [options] installer 10:27:24 INFO - Options: 10:27:24 INFO - -h, --help show this help message and exit 10:27:24 INFO - -d DEST, --destination=DEST 10:27:24 INFO - Directory to install application into. [default: 10:27:24 INFO - "/builds/slave/test"] 10:27:24 INFO - --app=APP Application being installed. [default: firefox] 10:27:24 INFO - mkdir: /builds/slave/test/build/application 10:27:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:27:41 INFO - Reading from file tmpfile_stdout 10:27:41 INFO - Output received: 10:27:41 INFO - /builds/slave/test/build/application/firefox/firefox 10:27:41 INFO - Running post-action listener: _resource_record_post_action 10:27:41 INFO - [mozharness: 2016-10-15 17:27:41.405816Z] Finished install step (success) 10:27:41 INFO - [mozharness: 2016-10-15 17:27:41.406059Z] Running run-tests step. 10:27:41 INFO - Running pre-action listener: _resource_record_pre_action 10:27:41 INFO - Running main action method: run_tests 10:27:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:27:41 INFO - Python 2.7.3 10:27:41 INFO - Return code: 0 10:27:41 INFO - grabbing minidump binary from tooltool 10:27:41 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')]} 10:27:41 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 0x278e790>, '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 0x278f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:27:41 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 10:27:41 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 10:27:41 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 10:27:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:27:41 INFO - Return code: 0 10:27:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:27:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:27:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:27:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:27:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:27:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:27:41 INFO - Using env: {'DISPLAY': ':0', 10:27:41 INFO - 'HOME': '/home/cltbld', 10:27:41 INFO - 'LANG': 'en_US.UTF-8', 10:27:41 INFO - 'LANGUAGE': 'en_US:en', 10:27:41 INFO - 'LOGNAME': 'cltbld', 10:27:41 INFO - 'MAIL': '/var/mail/cltbld', 10:27:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:27:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:41 INFO - 'MOZ_NO_REMOTE': '1', 10:27:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:41 INFO - 'NO_EM_RESTART': '1', 10:27:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:41 INFO - 'PWD': '/builds/slave/test', 10:27:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:27:41 INFO - 'SHELL': '/bin/bash', 10:27:41 INFO - 'SHLVL': '1', 10:27:41 INFO - 'TERM': 'linux', 10:27:41 INFO - 'TMOUT': '86400', 10:27:41 INFO - 'USER': 'cltbld', 10:27:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436', 10:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:41 INFO - '_': '/tools/buildbot/bin/python'} 10:27:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:27:41 INFO - mozversion application_buildid: 20161015073001 10:27:41 INFO - mozversion application_changeset: a1768c915756429b74f73fac2e8dd4e7b4919730 10:27:41 INFO - mozversion application_display_name: Nightly 10:27:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:27:41 INFO - mozversion application_name: Firefox 10:27:41 INFO - mozversion application_remotingname: firefox 10:27:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:27:41 INFO - mozversion application_vendor: Mozilla 10:27:41 INFO - mozversion application_version: 52.0a1 10:27:41 INFO - mozversion platform_buildid: 20161015073001 10:27:41 INFO - mozversion platform_changeset: a1768c915756429b74f73fac2e8dd4e7b4919730 10:27:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:27:41 INFO - mozversion platform_version: 52.0a1 10:27:41 INFO - using testdate: 1476552461 10:27:41 INFO - actual date: 1476552461 10:27:41 INFO - starting webserver on 'localhost:32786' 10:27:41 INFO - SUITE-START | Running 2 tests 10:27:41 INFO - TEST-START | dromaeo_css 10:27:41 INFO - operating with platform_type : linux_ 10:27:41 INFO - Initialising browser for dromaeo_css test... 10:27:41 INFO - TEST-INFO | started process 30177 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxt0dk5/profile http://localhost:32786/getInfo.html) 10:27:45 INFO - PROCESS | 30177 | __metrics Screen width/height:1600/1200 10:27:45 INFO - PROCESS | 30177 | colorDepth:24 10:27:45 INFO - PROCESS | 30177 | Browser inner width/height: 1024/697 10:27:45 INFO - PROCESS | 30177 | __metrics 10:27:45 INFO - PROCESS | 30177 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:27:45 INFO - PROCESS | 30177 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:27:47 INFO - TEST-INFO | 30177: exit 0 10:27:47 INFO - Browser initialized. 10:27:47 INFO - Running cycle 1/1 for dromaeo_css test... 10:27:47 INFO - TEST-INFO | started process 30256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxt0dk5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:27:59 INFO - PROCESS | 30256 | RSS: Main: 172417024 10:27:59 INFO - PROCESS | 30256 | 10:28:50 INFO - PROCESS | 30256 | 1476552530834 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] 10:31:00 INFO - PROCESS | 30256 | Cycle 1(1): loaded http://localhost:32786/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32786/tests/dromaeo/cssquery-ext.html) 10:31:02 INFO - PROCESS | 30256 | RSS: Main: 309817344 10:31:02 INFO - PROCESS | 30256 | 10:34:04 INFO - PROCESS | 30256 | Cycle 1(1): loaded http://localhost:32786/tests/dromaeo/cssquery-ext.html (next: http://localhost:32786/tests/dromaeo/cssquery-jquery.html) 10:34:05 INFO - PROCESS | 30256 | RSS: Main: 274481152 10:34:05 INFO - PROCESS | 30256 | 10:37:07 INFO - PROCESS | 30256 | Cycle 1(1): loaded http://localhost:32786/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32786/tests/dromaeo/cssquery-mootools.html) 10:37:08 INFO - PROCESS | 30256 | RSS: Main: 214716416 10:37:08 INFO - PROCESS | 30256 | 10:40:10 INFO - PROCESS | 30256 | Cycle 1(1): loaded http://localhost:32786/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32786/tests/dromaeo/cssquery-prototype.html) 10:40:10 INFO - PROCESS | 30256 | RSS: Main: 247336960 10:40:10 INFO - PROCESS | 30256 | 10:43:13 INFO - PROCESS | 30256 | Cycle 1(1): loaded http://localhost:32786/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32786/tests/dromaeo/cssquery-yui.html) 10:43:14 INFO - PROCESS | 30256 | RSS: Main: 214159360 10:43:14 INFO - PROCESS | 30256 | 10:46:16 INFO - PROCESS | 30256 | Cycle 1(1): loaded http://localhost:32786/tests/dromaeo/cssquery-yui.html (next: http://localhost:32786/tests/dromaeo/cssquery-dojo.html) 10:46:17 INFO - PROCESS | 30256 | RSS: Main: 307494912 10:46:17 INFO - PROCESS | 30256 | 10:46:17 INFO - PROCESS | 30256 | __start_tp_report 10:46:17 INFO - PROCESS | 30256 | _x_x_mozilla_page_load 10:46:17 INFO - PROCESS | 30256 | _x_x_mozilla_page_load_details 10:46:17 INFO - PROCESS | 30256 | |i|pagename|runs| 10:46:17 INFO - PROCESS | 30256 | |0;dojo.html;2983.9104826855196;3004.18886900537;3036.605241318628;3038.407510535446;3054.282243672738;4942.233953737167;5029.798808047673;5155.355580552431;5202.661826981243;5314.867128321789;5047.04106219818;5155.561777248939;5266.947330526694;5272.103742363798;5296.311479507659;4676;4694.765261736917;4731.290306454025;4742.834000809972;4752.691075080126;4744.383230180072;4763.047390521892;4837.588804951583;4840.56434920857;4899.191633380488;4556.54434556545;4791.041791641651;4812.446568644581;4824.107540105074;4914.926276105862;4588.24293991491;4640.5127461616385;4667.183242932507;4733.077049975256;4739.289106633998;4693.061387722435;4699.530046995307;4703.294505824154;4739;4775.785089670973;5103.872403189913;5153.381594208681;5159.329287192679;5163.199704045879;5172.456892026358;5306.8407947761625;5337.5196232338885;5471.890562188773;5532.723363831792;5571.777128914839;5577.721113944327;5584.106542953108;5584.972075139598;5633.661980281156;5656.151577263402;5187.766550505236;5194.298769666047;5195.610329225286;5197.324347834795;5258;5398.379186393537;5446.537044351196;5563.13771365439;5674.773009079673;5680.801171958961;5410.594205434608;5418.078926582491;5423.864403389868;5487.917681234785;5491.560675145979;5445.646033007842;5485.780568777204;5493.23094766733;5495.587830912697;5499.890002199933;5201.271821944931;5469.371022332403;5482.424345443751;5483.945160548423;5495.945040549624;5277.868053298622;5463.972680136574;5522.447755224445;5541.002619528524;5605.579581531401;4198.727082739612;4199.4120823084795;4215.97892010538;4244.045089854758;4295.37717031035;3789.9431508527396;3794.905127371838;3805.809709514513;3837.347650899354;3858.7105967052585;5069.138246498031;5120;5210.583153347723;5242.68543887368;5254.0805359062015;5561.610687251854;5564.8330550083565;5566.944330556724;5569.275994120739;5606.439356064361;5215.713135777569;5278.947210527922;5280.788768449219;5284.471552844761;5337.546308563816;4672.369230153954;4715.339852420664;4798.592119669797;4850.781714822841;4854.466008739036;5784.479396854304;5811.476967072984;5812.447817457335;5865.384134665798;5878.118282257696;5606.18710286998;5620.297462817148;5620.831375058755;5622.634528755618;5626.690532020614;5399.541039011728;5502.862428439321;5811.215485909517;5813.6221145625395;5816.563757718103;5353.411124776349;5372.355317361941;5396.406395296593;5419.241306217212;5480.890382192413;5460.290162279037;5463.562914966873;5492.862678433071;5508.697021663847;5516.420775818481;5211.348581427322;5368.114261146867;5370.704611246263;5382.381026182039;5389.407165211902;5252.816151434834;5379.327584051994;5427;5449.6730196188355;5530.308711411074;5449.482299181572;5450.2369668247275;5452.727363631882;5455.754491047833;5456.290682211287;5517.2275881377445;5539.861503462445;5540.7783688652;5541.307336582927;5614.6631202128;5167.974160129325;5240.764165612481;5241.790328386975;5256.816011439581;5302.602304827076 10:46:17 INFO - PROCESS | 30256 | |1;ext.html;551.1415458301021;588.2529187931327;610.0391882784612;612.4977518434882;628.1708145248274;31088;41419;42304;42389.788051059775;45481;43408.34887476682;43861.342079868824;43879.78060109703;43892.78053609728;43919.78040109803;7967.16344783798;8176.509409435424;8764.517951512664;8918.777030574223;8928.15182557656;10576.418296993701;10880.075193608553;10905.83641245378;10910.563577456933;10921.83617245738;10790.5683772649;10878.075363594104;10887.782244355149;10891;10901.618443354484;10605;10653;10665.573377064908;10674.839877401846;10700.678979630624;10550.683479495627;10611.522481488351;10616.62841800541;10622.25644204906;10629.255952083357;42435.15129697389;42726.786366068285;42755;42836.57163428388;42850.78574607107;3555.1112221944513;3744.776759446726;3828.942565861514;3832.9835964251993;4080.2451546463703;31012.844935775403;31135.22161945947;31206.375872482422;31732.524012139835;31919.361612767847;4224.366345048267;4250.787460626987;4397.978010109961;4465.665075119379;4479.148961697267;343893;344378;348432;349152.2542387297;350200;54998.45001549933;55470.44529554653;55594.72202638961;55605.72197138988;55669.72165139148;34659.653403466145;35322.64677353194;35410;37613.623863761015;59186.40813591809;16025.599360016093;16036.518904432885;16096.11471369086;16109.19454027294;16112.838871611368;11999.460024298927;12277.570285039981;12870.48518059286;13247.470101195844;13305.866941330656;18113.45659630213;18945.147468363957;19123;19176.520586985436;19281.950790334187;6814.659267036628;7076.292370762985;7104.964475177694;7145.8928116078305;7171.426285897116;882.4220135811054;931.3527098666361;938.2454809506266;1014.4826138669332;1096.8793432722393;31165.532517012263;33267.833660831544;33590;34035;34129.31741365159;966.7341481092756;975.8292298847673;982.4940155819759;1022.9208185364512;1064.302881612545;15343;15825.366985320457;15943.282552285174;16283.918580407022;16320.83679163217;540984;804723;816199;820700;823843;56363.71818140965;57349.71325143431;57371.426285736605;57415.42584574184;57418.42581574214;1213.672308476724;1251.9248845069326;1324.761542922264;1338.3508998135896;1347.6496111011209;27266.454670906074;29845;31891.6810831898;32004.35991280208;32524.349513009132;50429.74785126051;51705;51736.482635174674;51750.741246293524;51846;465647;469612;475639;476312;477009;40991.26122342934;42825.78587107169;43211.598550181225;43351.34972975471;43410.78294608507;46866;47788.7610561945;47854.760726196146;47970;48073;39269.803650981565;40305.596944030185;40417.79791101025;40466.59533404746;41381.1723765517;39563.40654890236;39665.60334396619;40347.19305613812;41501.37747933723;41885.79057104695;38714.22571548609;39293.803530982164;39465;39833.80083099566;40223.59776402316;34193;36268.637313626525;36564.525487356914;37107.44338834973;37118.62881371152;25939;25989.220323390327;26151;26421.207363779118;26976 10:46:17 INFO - PROCESS | 30256 | |2;jquery.html;359.2868156708934;373.78507358268985;376.2625254501176;380.3970706430308;403.80213695289297;14287.78568321476;18226.362077327296;19486.99999999998;20128.899355503203;20317.59364812703;18743.43769686908;19688.606227875433;19790.802091979076;19889.50276243091;19898.10458529366;5442;5725.398833122525;5730.541556675476;5733.627314224562;5735.340435849868;5443.591730620199;5608.635438696471;5635.830925072254;5664.291963504562;5668.97165514174;5636.15457681347;5638.718064096779;5639.407862174474;5639.492445679888;5643.209950606918;5385.3268341457315;5560.7219639017885;5583;5585.3297604287545;5633.63381380211;4978.228374601942;4987.47631498691;4989.700617962933;4991.051700176955;4991.475895031006;23233.186838460573;23418.882905585535;23453.530929381315;23471.76528234713;23718.644220336708;2178.2920550821045;2276.3512398966213;2281.897314620846;2295.483516208856;2341.1220792202926;13584;14011;14590.489332873298;14736.55790326292;15073.47242846506;1871.5804789571764;1912.0592598512521;1914.6457905287566;1951.6096780643927;1981.900904954761;82831.58584207101;83819;84134.57932710358;84532.57733711292;86705.99999999937;9916.603335866628;10072.496375181358;10311.329763565343;10476.109530689824;10478.266521343432;14472.27638618086;14487.855121448862;14489;14506.782398264035;14568.271586420637;7860.606969651494;7961.785030804832;8013.19868013194;8174.468659537111;8238.629261683238;7709.267619576131;7780.2219778021745;8046.758597242092;8061.959690201512;8078;6266.561340706198;6286.654234017082;6415.358464153641;6452.290248072708;6452.870942581122;1592.5938885584333;1801.8918365205304;1826.4611939477886;1843.1429385335616;1870.1584287070873;873.3711727556149;931.6552875435997;943.6272672294406;944.1408318430196;983.233078199006;18550.628987420176;19207.61584768297;19486.317978870673;19575.412737617895;19753.308634197732;819.5779173725537;884.9734507964771;893.9284857211408;907.4011152639226;909.2771246858763;8343.95828020856;10259.692209233735;10979.890201098047;11128.221024528368;11132.276402033842;475628;478043.85429894587;480619.59690201323;492196;492351;93019.53490232506;96482.51758741161;97928;98626.5068674652;99820.50089749505;991.613270824379;1009.8232809258351;1037.9221558383001;1038.4496217004848;1047.418682631147;16338.611218046599;16622;17084;17306.48080557585;17500;40774.38838417367;42079.36880946849;42479;42479.3628095585;42863.134349223554;58544;58546.7072664651;59230.930741774864;59563.40436595579;60159;7954.880676789969;8426.41015128935;8496.70261540843;8524.360672949677;8631.352648551509;11216.943915280372;12162.574309899112;12617.116801823784;13201.933990329986;13436.39536220892;11558.190926635054;11598.768024639292;11834.585789497327;12165.939170304091;12187.268763874195;11504.82742758876;11514.596989105341;11703.882961170279;11704.531818727155;12070.45682944252;10380.480975951323;10771.138308935424;11538.480768365276;11565.421728913352;11848.881511184778;7649.923500764921;7732.497387669783;7974.282314591715;8004.879926801219;8014.19858014194;9393.436393816393;11110.777844430984;11204.327740335606;11358.829617555908;11788.646340609796 10:46:17 INFO - PROCESS | 30256 | |3;mootools.html;1316.012990257307;1404.992975035125;1467.6697743007824;1585.0927463801727;1771.1764029726166;7176.354128128467;8685.131486851311;8894.733158005254;8948.507832069234;9213.802205713248;9004.414713043647;9056.049114842945;9063.546822658873;9069.13843184898;9073.909260907389;2216.645336746121;2244.4513285832722;2244.8540844845115;2246.3710161154904;2249.1902914950606;2192.7368715754133;2226.5101677630896;2234.9329520114425;2241.540484200735;2249.156566287642;2208.2602328220064;2210.425289424745;2216.2686313516583;2224.6218142915745;2240.6863039174527;2137.0810551462864;2151.8816465094337;2154.2890846020778;2154.396768904709;2157.9460513487134;2174.5759576882515;2175.6083904897114;2176.1404245323165;2179;2183.268605017321;8914.286857051486;8944.418612790148;9008.549572521348;9009.684661036898;9119.908800911971;5090.2110172922885;5298.496642818926;5300.416954135042;5300.575953923677;5317.813876514342;3300.6369299377047;3451.6548345165534;3474.0099071764425;3479.565054368204;3539.805310707936;1082.9458527073614;1126.2679258481971;1136.431784107946;1151.205668089016;1153.9942300288528;12311.876881231252;12385.690357741038;12394.132410731252;12445.191062580903;12468.625941221779;4059;4216.620504154641;4309.935350969738;4339.7830108494445;4384.8903777405185;9706.029397060238;9708.320417570701;9714.417134971924;9715.902840971641;9728.075832795874;4950.653454258239;4971.005798840247;4975.527324904128;4978.327925730053;4978.576820970258;3979;4081.5714349992822;4658.673892827537;4669.509701481364;4679.742614156254;3644.1982763791925;3696.168362118502;3804.1821008483307;3820.4078367853026;3841.0973421245985;1106.9059129973882;1120.3222050659233;1137.26078049267;1139.1627154041773;1145.6734830573246;847.5550336073611;873.218469469821;880.5861245214738;893.9418937769025;905.8822353094188;5537.640053396516;5602.4957753802355;5696.601237913306;5788.986927287708;5836.212111364996;870.7561882672861;899.869518919766;910.3309067835136;926.2312280806914;937.4750139921666;3581.606023337431;3591.174029973121;3638.272345530904;3717.237966216919;3874.3994680824517;10750.516226769814;11194.608188713519;11204.271722338022;11487.310761354178;11513.136514761427;11303.434828258554;11324.886751132548;11326.830097548544;11337.886621133683;11346.262492937933;8266.256036956704;8346.374021948257;8357.247847693738;8407.201315874981;8434.62044208012;5446.046941785251;5477.616566840442;5519.337679478488;5592.608517403743;5672.376038635829;10013.549390277309;10229.232807539316;10235.334703244564;10265.076143147153;10320.845187322346;10433.373997560171;10463.68608941733;10533.315334503233;10557.9472102639;10614.097801686943;6633;6859.691313890987;7439.479236453396;7516.736914207976;7523.134839493309;8432.53621050848;8646.697365592174;8684.261837743863;8959.283257339528;8962.955185224033;7865.4494185406475;7904.762857114296;8007.559584222924;8190.262876341158;8206.58967051633;7463.365613922877;7630.122535908442;7722.845543089219;7752.4573279869865;7780.766577002699;7113;7209.71161153548;7219.133703955349;7222.205557388578;7227.7831665050135;4785.306130611111;4945.876353091202;4981.352424184833;5041.689160818287;5153.613478989016;4937.604991600591;5001.8749531260555;5016.72408017548;5106.234064890296;5108.131617624938 10:46:17 INFO - PROCESS | 30256 | |4;prototype.html;326.88559004348474;329.86970146792015;335.41804968379864;336.81475188646255;341.83250207398385;5103.571000119963;5214.426413094561;5270.578353731702;5293.364796224454;5318.654287471311;4984;5120.385553733548;5138.22926561016;5202.401723801764;5209.609279304048;4104.086098869791;4111.424400583921;4114.280000999821;4115.403266526352;4126.154138401621;3894.9805250973704;3933.606639336072;4120.958790412103;4139.8965025874295;4165.187788381267;4108.26051310764;4115.97942010291;4138.33786594145;4141.585841415865;4170.270202714528;4141.917161656765;4151.190517849021;4154.563770804082;4157.771322577257;4175.164967006581;3616.945745813815;3656.945145822815;3681.226942342111;3706.610805865372;3716.457670066919;5045.495450454961;5049.5455409013;5057.547089661512;5074.908894587681;5081.618878584121;4679.695819771704;4719.811207551694;4732.526747325274;4745;4748.5251474852585;5262.44757796451;5417.702026388547;5430.59270554706;5433.755481003364;5466.180072989044;3986.966647010017;3991.1219531702977;3994.2610617035944;3995.920081598381;4005.439238506611;5537.252470916415;5593.888122237573;5612.298462692163;5614.24207731951;5618.410066942953;3955.8417663293144;4106.958930410658;4109.465769450012;4109.97945010273;4124.278251306009;4118.382242663564;4131.876043718693;4140.565240649748;4149.875503734893;4150.900011496956;4693.436787585511;4729.266963620645;4734.124187025412;4738.763061846894;4742.407199100113;5384.434634363413;5455.1544510600925;5460.235567020621;5467;5512.944870551243;1399.5801259622074;1401.572520381273;1403.5298175111452;1405.7258834527374;1414.3635364086203;898.8651702244584;923.8937522185034;926.4348747264163;932.6689025396022;939.5993237278818;4621.79201935907;4634.536546345338;4635.490096089427;4646.233371493666;4650.279206722963;4878.707277563358;4947.752612369367;4952.356193694869;4969.608509617313;5002.699838009731;4473.977630111894;4711.340412342275;4723.149833030019;4746.620270378361;4775.856724298276;2577.780888624488;2594.8443093414458;2609.908653197129;2615.5815069588775;2623.216212975195;5021.639829280305;5057.508035129646;5062.670926389773;5075.416327122354;5088.440271570124;4784.808607655655;4789.788671186245;4945.258211268267;4968.627352948543;4994.225894986283;5003.699038250008;5006.574441172468;5053.772580233898;5083.110455670243;5092;4928.383952005999;4943.975280123576;4949.822078285543;4957.100096443477;4967.428745694291;4592.632589392907;4715.834945777018;4863.635227357891;4878.536539028786;4878.926816097833;4929.964707411484;4993;5074.213496907838;5103.489651035015;5155.484451554815;3754.23038277158;3770.981145094257;3919.6080391960577;4061.3298805696727;4063.167050754529;5436.836894893159;5532.6680399176175;5538.307711536058;5602.635828671123;5618.52242559387;5423.105187643994;5423.566114710892;5430.456954304538;5439.646422982493;5456.781728730806;5331.840044798662;5434;5459.153831156177;5464.644798088111;5496.5053145217125;5340.49265319794;5354.670718237579;5404.297851074462;5471.2613797138465;5472.863178420572;5272.525472707474;5427.402985671494;5440.9934162180125;5464.590155738415;5479.561635069264;5390.975714614211;5408.891822163613;5410.21551874968;5419.620626556103;5428.104362780255 10:46:17 INFO - PROCESS | 30256 | |5;yui.html;688.9586624802512;690.2097098821849;703.156212544946;724.999500689049;752.1763668782688;15047.623809404757;16394.426195083175;16438.589035274123;16493.587660308498;16502.42241521547;14693.118412895206;14829.03611265267;14840.257987100656;14856.18290993995;14856.85143148571;661.5832025823725;677.0250838792148;773.9226077392244;774.7636970723927;802.1978021978022;802.8956235689382;803.1446509467398;803.8111043904707;804.74650485097;805.1706742055692;845.6575087089739;845.898492180936;846.3779122345071;846.7798372423183;846.9745907622781;690.1097584116509;690.9861802763967;704.5385272646424;709.6735501669239;839.3159574946429;589.6196952965313;589.7110415896223;602.5962605054624;613.5245184981675;615.9630422174639;14385.928070359685;14465.421383144661;14520.709585808225;14560.854391456161;14589.197594132318;12931.741365172738;13650.658733531742;13863.861361386358;13977.860221397757;14092.073643026002;12967.157134786208;12974;13216.744409281104;13284.40220190084;13430.462781488728;4284.764337961411;4288.871333859989;4292.527821939584;4310.159518893817;4353.238183317939;82276;85084;86431;87177.56411217904;88916;11063.376990164865;11145.498452569655;11169.162312826571;11253.212275140826;11296.152788540729;18402.81597184011;18467.907660461613;18483.815161848477;18520.536986575444;19245.326413575738;7612.391008719289;7803.336716379058;7888.092869319987;7918.722844700523;8189.7133600323705;4473.955260447419;4556.589906908394;4621.95378046222;4635.397398338262;4652.720836749738;3638.21778317663;3725.1432170600915;3754.5119134512884;3765.7363984521367;3770.679492243135;610.6793933185113;620.8292719502083;638.1066506890298;646.0986923242051;648.73726140913;706.7914965085209;729.7409419656052;731.3637135691876;734.4821900560092;757.4394947738743;8667.09658217176;9234.215091717278;9603.615855365846;9719.271054670928;10396.546751141375;642.4810874587317;692.1624833950875;716.3946465236867;721.9169795473483;756.6141267953274;4123.237201117803;4411;4436.556344365537;4643.210654188796;4742.905141897212;112427;115882;115936.42031789955;117846;121247.39376303062;95612;96255;96584;96754;97974;84141;86243.5687821557;86733;87416;88184;9611.615535378507;10002.599896004078;10066.16304250195;10133.746656333651;10256.58973641046;51372.48627513827;51403;51938;52705.41883743494;52941.73529132484;67108.3289167102;71073;74519.62740186264;75124.24875751173;75261;12581.308028058545;12995.953023329585;13234.59101956264;13850.376733047238;14165.787513187104;14216.004879658325;14298.85701143017;14535.345909434312;14803.481878134213;14866.554003379484;12932.482700692244;13068.80396794068;13080;13466.192028478323;13731.725365492834;13115.409806558919;13666.658333541742;14077.648058798202;14621.707565848836;14802.6299342513;12983.740325193254;13050;13200.405981730653;13330.933345333211;13656.863431365558;10522.526486308288;10970;11334.659960201207;11355.829662554903;11415.942920285346;9742.512874356396;10209.846852297072;10288.382697038202;11454.770904582028;11523.942380288045 10:46:17 INFO - PROCESS | 30256 | __end_tp_report 10:46:17 INFO - PROCESS | 30256 | __start_cc_report 10:46:17 INFO - PROCESS | 30256 | _x_x_mozilla_cycle_collect,1281 10:46:17 INFO - PROCESS | 30256 | __end_cc_report 10:46:17 INFO - PROCESS | 30256 | __startTimestamp1476553577175__endTimestamp 10:46:17 INFO - PROCESS | 30256 | 10:46:17 INFO - PROCESS | 30256 | ------- Summary: start ------- 10:46:17 INFO - PROCESS | 30256 | Number of tests: 6 10:46:17 INFO - PROCESS | 30256 | 10:46:17 INFO - PROCESS | 30256 | [#0] dojo.html Cycles:165 Average:5143.66 Median:5306.84 stddev:574.81 (10.8%) stddev-sans-first:551.04 10:46:17 INFO - PROCESS | 30256 | Values: 2983.9 3004.2 3036.6 3038.4 3054.3 4942.2 5029.8 5155.4 5202.7 5314.9 5047.0 5155.6 5266.9 5272.1 5296.3 4676.0 4694.8 4731.3 4742.8 4752.7 4744.4 4763.0 4837.6 4840.6 4899.2 4556.5 4791.0 4812.4 4824.1 4914.9 4588.2 4640.5 4667.2 4733.1 4739.3 4693.1 4699.5 4703.3 4739.0 4775.8 5103.9 5153.4 5159.3 5163.2 5172.5 5306.8 5337.5 5471.9 5532.7 5571.8 5577.7 5584.1 5585.0 5633.7 5656.2 5187.8 5194.3 5195.6 5197.3 5258.0 5398.4 5446.5 5563.1 5674.8 5680.8 5410.6 5418.1 5423.9 5487.9 5491.6 5445.6 5485.8 5493.2 5495.6 5499.9 5201.3 5469.4 5482.4 5483.9 5495.9 5277.9 5464.0 5522.4 5541.0 5605.6 4198.7 4199.4 4216.0 4244.0 4295.4 3789.9 3794.9 3805.8 3837.3 3858.7 5069.1 5120.0 5210.6 5242.7 5254.1 5561.6 5564.8 5566.9 5569.3 5606.4 5215.7 5278.9 5280.8 5284.5 5337.5 4672.4 4715.3 4798.6 4850.8 4854.5 5784.5 5811.5 5812.4 5865.4 5878.1 5606.2 5620.3 5620.8 5622.6 5626.7 5399.5 5502.9 5811.2 5813.6 5816.6 5353.4 5372.4 5396.4 5419.2 5480.9 5460.3 5463.6 5492.9 5508.7 5516.4 5211.3 5368.1 5370.7 5382.4 5389.4 5252.8 5379.3 5427.0 5449.7 5530.3 5449.5 5450.2 5452.7 5455.8 5456.3 5517.2 5539.9 5540.8 5541.3 5614.7 5168.0 5240.8 5241.8 5256.8 5302.6 10:46:17 INFO - PROCESS | 30256 | 10:46:17 INFO - PROCESS | 30256 | [#1] ext.html Cycles:180 Average:67114.46 Median:39379.40 stddev:150002.32 (380.9%) stddev-sans-first:150339.86 10:46:17 INFO - PROCESS | 30256 | Values: 551.1 588.3 610.0 612.5 628.2 31088.0 41419.0 42304.0 42389.8 45481.0 43408.3 43861.3 43879.8 43892.8 43919.8 7967.2 8176.5 8764.5 8918.8 8928.2 10576.4 10880.1 10905.8 10910.6 10921.8 10790.6 10878.1 10887.8 10891.0 10901.6 10605.0 10653.0 10665.6 10674.8 10700.7 10550.7 10611.5 10616.6 10622.3 10629.3 42435.2 42726.8 42755.0 42836.6 42850.8 3555.1 3744.8 3828.9 3833.0 4080.2 31012.8 31135.2 31206.4 31732.5 31919.4 4224.4 4250.8 4398.0 4465.7 4479.1 343893.0 344378.0 348432.0 349152.3 350200.0 54998.5 55470.4 55594.7 55605.7 55669.7 34659.7 35322.6 35410.0 37613.6 59186.4 16025.6 16036.5 16096.1 16109.2 16112.8 11999.5 12277.6 12870.5 13247.5 13305.9 18113.5 18945.1 19123.0 19176.5 19282.0 6814.7 7076.3 7105.0 7145.9 7171.4 882.4 931.4 938.2 1014.5 1096.9 31165.5 33267.8 33590.0 34035.0 34129.3 966.7 975.8 982.5 1022.9 1064.3 15343.0 15825.4 15943.3 16283.9 16320.8 540984.0 804723.0 816199.0 820700.0 823843.0 56363.7 57349.7 57371.4 57415.4 57418.4 1213.7 1251.9 1324.8 1338.4 1347.6 27266.5 29845.0 31891.7 32004.4 32524.3 50429.7 51705.0 51736.5 51750.7 51846.0 465647.0 469612.0 475639.0 476312.0 477009.0 40991.3 42825.8 43211.6 43351.3 43410.8 46866.0 47788.8 47854.8 47970.0 48073.0 39269.8 40305.6 40417.8 40466.6 41381.2 39563.4 39665.6 40347.2 41501.4 41885.8 38714.2 39293.8 39465.0 39833.8 40223.6 34193.0 36268.6 36564.5 37107.4 37118.6 25939.0 25989.2 26151.0 26421.2 26976.0 10:46:17 INFO - PROCESS | 30256 | 10:46:17 INFO - PROCESS | 30256 | [#2] jquery.html Cycles:180 Average:29101.24 Median:20589.10 stddev:80009.63 (388.6%) stddev-sans-first:80204.98 10:46:17 INFO - PROCESS | 30256 | Values: 359.3 373.8 376.3 380.4 403.8 14287.8 18226.4 19487.0 20128.9 20317.6 18743.4 19688.6 19790.8 19889.5 19898.1 5442.0 5725.4 5730.5 5733.6 5735.3 5443.6 5608.6 5635.8 5664.3 5669.0 5636.2 5638.7 5639.4 5639.5 5643.2 5385.3 5560.7 5583.0 5585.3 5633.6 4978.2 4987.5 4989.7 4991.1 4991.5 23233.2 23418.9 23453.5 23471.8 23718.6 2178.3 2276.4 2281.9 2295.5 2341.1 13584.0 14011.0 14590.5 14736.6 15073.5 1871.6 1912.1 1914.6 1951.6 1981.9 82831.6 83819.0 84134.6 84532.6 86706.0 9916.6 10072.5 10311.3 10476.1 10478.3 14472.3 14487.9 14489.0 14506.8 14568.3 7860.6 7961.8 8013.2 8174.5 8238.6 7709.3 7780.2 8046.8 8062.0 8078.0 6266.6 6286.7 6415.4 6452.3 6452.9 1592.6 1801.9 1826.5 1843.1 1870.2 873.4 931.7 943.6 944.1 983.2 18550.6 19207.6 19486.3 19575.4 19753.3 819.6 885.0 893.9 907.4 909.3 8344.0 10259.7 10979.9 11128.2 11132.3 475628.0 478043.9 480619.6 492196.0 492351.0 93019.5 96482.5 97928.0 98626.5 99820.5 991.6 1009.8 1037.9 1038.4 1047.4 16338.6 16622.0 17084.0 17306.5 17500.0 40774.4 42079.4 42479.0 42479.4 42863.1 58544.0 58546.7 59230.9 59563.4 60159.0 7954.9 8426.4 8496.7 8524.4 8631.4 11216.9 12162.6 12617.1 13201.9 13436.4 11558.2 11598.8 11834.6 12165.9 12187.3 11504.8 11514.6 11703.9 11704.5 12070.5 10380.5 10771.1 11538.5 11565.4 11848.9 7649.9 7732.5 7974.3 8004.9 8014.2 9393.4 11110.8 11204.3 11358.8 11788.6 10:46:17 INFO - PROCESS | 30256 | 10:46:17 INFO - PROCESS | 30256 | [#3] mootools.html Cycles:180 Average:5746.26 Median:4861.46 stddev:3398.17 (69.9%) stddev-sans-first:3391.40 10:46:17 INFO - PROCESS | 30256 | Values: 1316.0 1405.0 1467.7 1585.1 1771.2 7176.4 8685.1 8894.7 8948.5 9213.8 9004.4 9056.0 9063.5 9069.1 9073.9 2216.6 2244.5 2244.9 2246.4 2249.2 2192.7 2226.5 2234.9 2241.5 2249.2 2208.3 2210.4 2216.3 2224.6 2240.7 2137.1 2151.9 2154.3 2154.4 2157.9 2174.6 2175.6 2176.1 2179.0 2183.3 8914.3 8944.4 9008.5 9009.7 9119.9 5090.2 5298.5 5300.4 5300.6 5317.8 3300.6 3451.7 3474.0 3479.6 3539.8 1082.9 1126.3 1136.4 1151.2 1154.0 12311.9 12385.7 12394.1 12445.2 12468.6 4059.0 4216.6 4309.9 4339.8 4384.9 9706.0 9708.3 9714.4 9715.9 9728.1 4950.7 4971.0 4975.5 4978.3 4978.6 3979.0 4081.6 4658.7 4669.5 4679.7 3644.2 3696.2 3804.2 3820.4 3841.1 1106.9 1120.3 1137.3 1139.2 1145.7 847.6 873.2 880.6 893.9 905.9 5537.6 5602.5 5696.6 5789.0 5836.2 870.8 899.9 910.3 926.2 937.5 3581.6 3591.2 3638.3 3717.2 3874.4 10750.5 11194.6 11204.3 11487.3 11513.1 11303.4 11324.9 11326.8 11337.9 11346.3 8266.3 8346.4 8357.2 8407.2 8434.6 5446.0 5477.6 5519.3 5592.6 5672.4 10013.5 10229.2 10235.3 10265.1 10320.8 10433.4 10463.7 10533.3 10557.9 10614.1 6633.0 6859.7 7439.5 7516.7 7523.1 8432.5 8646.7 8684.3 8959.3 8963.0 7865.4 7904.8 8007.6 8190.3 8206.6 7463.4 7630.1 7722.8 7752.5 7780.8 7113.0 7209.7 7219.1 7222.2 7227.8 4785.3 4945.9 4981.4 5041.7 5153.6 4937.6 5001.9 5016.7 5106.2 5108.1 10:46:17 INFO - PROCESS | 30256 | 10:46:17 INFO - PROCESS | 30256 | [#4] prototype.html Cycles:180 Average:4432.99 Median:4944.62 stddev:1258.57 (25.5%) stddev-sans-first:1223.78 10:46:17 INFO - PROCESS | 30256 | Values: 326.9 329.9 335.4 336.8 341.8 5103.6 5214.4 5270.6 5293.4 5318.7 4984.0 5120.4 5138.2 5202.4 5209.6 4104.1 4111.4 4114.3 4115.4 4126.2 3895.0 3933.6 4121.0 4139.9 4165.2 4108.3 4116.0 4138.3 4141.6 4170.3 4141.9 4151.2 4154.6 4157.8 4175.2 3616.9 3656.9 3681.2 3706.6 3716.5 5045.5 5049.5 5057.5 5074.9 5081.6 4679.7 4719.8 4732.5 4745.0 4748.5 5262.4 5417.7 5430.6 5433.8 5466.2 3987.0 3991.1 3994.3 3995.9 4005.4 5537.3 5593.9 5612.3 5614.2 5618.4 3955.8 4107.0 4109.5 4110.0 4124.3 4118.4 4131.9 4140.6 4149.9 4150.9 4693.4 4729.3 4734.1 4738.8 4742.4 5384.4 5455.2 5460.2 5467.0 5512.9 1399.6 1401.6 1403.5 1405.7 1414.4 898.9 923.9 926.4 932.7 939.6 4621.8 4634.5 4635.5 4646.2 4650.3 4878.7 4947.8 4952.4 4969.6 5002.7 4474.0 4711.3 4723.1 4746.6 4775.9 2577.8 2594.8 2609.9 2615.6 2623.2 5021.6 5057.5 5062.7 5075.4 5088.4 4784.8 4789.8 4945.3 4968.6 4994.2 5003.7 5006.6 5053.8 5083.1 5092.0 4928.4 4944.0 4949.8 4957.1 4967.4 4592.6 4715.8 4863.6 4878.5 4878.9 4930.0 4993.0 5074.2 5103.5 5155.5 3754.2 3771.0 3919.6 4061.3 4063.2 5436.8 5532.7 5538.3 5602.6 5618.5 5423.1 5423.6 5430.5 5439.6 5456.8 5331.8 5434.0 5459.2 5464.6 5496.5 5340.5 5354.7 5404.3 5471.3 5472.9 5272.5 5427.4 5441.0 5464.6 5479.6 5391.0 5408.9 5410.2 5419.6 5428.1 10:46:17 INFO - PROCESS | 30256 | 10:46:17 INFO - PROCESS | 30256 | [#5] yui.html Cycles:180 Average:20942.86 Median:4423.78 stddev:30401.16 (687.2%) stddev-sans-first:30448.41 10:46:17 INFO - PROCESS | 30256 | Values: 689.0 690.2 703.2 725.0 752.2 15047.6 16394.4 16438.6 16493.6 16502.4 14693.1 14829.0 14840.3 14856.2 14856.9 661.6 677.0 773.9 774.8 802.2 802.9 803.1 803.8 804.7 805.2 845.7 845.9 846.4 846.8 847.0 690.1 691.0 704.5 709.7 839.3 589.6 589.7 602.6 613.5 616.0 14385.9 14465.4 14520.7 14560.9 14589.2 12931.7 13650.7 13863.9 13977.9 14092.1 12967.2 12974.0 13216.7 13284.4 13430.5 4284.8 4288.9 4292.5 4310.2 4353.2 82276.0 85084.0 86431.0 87177.6 88916.0 11063.4 11145.5 11169.2 11253.2 11296.2 18402.8 18467.9 18483.8 18520.5 19245.3 7612.4 7803.3 7888.1 7918.7 8189.7 4474.0 4556.6 4622.0 4635.4 4652.7 3638.2 3725.1 3754.5 3765.7 3770.7 610.7 620.8 638.1 646.1 648.7 706.8 729.7 731.4 734.5 757.4 8667.1 9234.2 9603.6 9719.3 10396.5 642.5 692.2 716.4 721.9 756.6 4123.2 4411.0 4436.6 4643.2 4742.9 112427.0 115882.0 115936.4 117846.0 121247.4 95612.0 96255.0 96584.0 96754.0 97974.0 84141.0 86243.6 86733.0 87416.0 88184.0 9611.6 10002.6 10066.2 10133.7 10256.6 51372.5 51403.0 51938.0 52705.4 52941.7 67108.3 71073.0 74519.6 75124.2 75261.0 12581.3 12996.0 13234.6 13850.4 14165.8 14216.0 14298.9 14535.3 14803.5 14866.6 12932.5 13068.8 13080.0 13466.2 13731.7 13115.4 13666.7 14077.6 14621.7 14802.6 12983.7 13050.0 13200.4 13330.9 13656.9 10522.5 10970.0 11334.7 11355.8 11415.9 9742.5 10209.8 10288.4 11454.8 11523.9 10:46:17 INFO - PROCESS | 30256 | -------- Summary: end -------- 10:46:17 INFO - PROCESS | 30256 | 10:46:18 INFO - TEST-INFO | 30256: exit 0 10:46:18 INFO - TEST-OK | dromaeo_css | took 1116530ms 10:46:18 INFO - TEST-START | kraken 10:46:18 INFO - operating with platform_type : linux_ 10:46:18 INFO - Initialising browser for kraken test... 10:46:18 INFO - TEST-INFO | started process 30573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN2zhEp/profile http://localhost:32786/getInfo.html) 10:46:21 INFO - PROCESS | 30573 | __metrics Screen width/height:1600/1200 10:46:21 INFO - PROCESS | 30573 | colorDepth:24 10:46:21 INFO - PROCESS | 30573 | Browser inner width/height: 1024/697 10:46:21 INFO - PROCESS | 30573 | __metrics 10:46:22 INFO - PROCESS | 30573 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:46:22 INFO - PROCESS | 30573 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:46:22 INFO - PROCESS | 30573 | console.error: PushService: 10:46:22 INFO - PROCESS | 30573 | stateChangeProcessEnqueue: Error transitioning state 10:46:22 INFO - PROCESS | 30573 | UnknownError 10:46:23 INFO - TEST-INFO | 30573: exit 0 10:46:23 INFO - Browser initialized. 10:46:23 INFO - Running cycle 1/1 for kraken test... 10:46:23 INFO - TEST-INFO | started process 30656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN2zhEp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:46:35 INFO - PROCESS | 30656 | RSS: Main: 171565056 10:46:35 INFO - PROCESS | 30656 | 10:46:38 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32786/tests/kraken/driver.html?testName=audio-beat-detection) 10:46:39 INFO - PROCESS | 30656 | RSS: Main: 229302272 10:46:39 INFO - PROCESS | 30656 | 10:46:41 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32786/tests/kraken/driver.html?testName=audio-dft) 10:46:42 INFO - PROCESS | 30656 | RSS: Main: 216178688 10:46:42 INFO - PROCESS | 30656 | 10:46:45 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32786/tests/kraken/driver.html?testName=audio-fft) 10:46:46 INFO - PROCESS | 30656 | RSS: Main: 297238528 10:46:46 INFO - PROCESS | 30656 | 10:46:48 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32786/tests/kraken/driver.html?testName=audio-oscillator) 10:46:48 INFO - PROCESS | 30656 | RSS: Main: 208760832 10:46:48 INFO - PROCESS | 30656 | 10:46:50 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32786/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:46:51 INFO - PROCESS | 30656 | RSS: Main: 211775488 10:46:51 INFO - PROCESS | 30656 | 10:46:54 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32786/tests/kraken/driver.html?testName=imaging-darkroom) 10:46:55 INFO - PROCESS | 30656 | RSS: Main: 247517184 10:46:55 INFO - PROCESS | 30656 | 10:46:58 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32786/tests/kraken/driver.html?testName=imaging-desaturate) 10:46:59 INFO - PROCESS | 30656 | RSS: Main: 246611968 10:46:59 INFO - PROCESS | 30656 | 10:47:01 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32786/tests/kraken/driver.html?testName=json-parse-financial) 10:47:02 INFO - PROCESS | 30656 | RSS: Main: 246312960 10:47:02 INFO - PROCESS | 30656 | 10:47:03 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32786/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:47:04 INFO - PROCESS | 30656 | RSS: Main: 208592896 10:47:04 INFO - PROCESS | 30656 | 10:47:06 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32786/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:47:06 INFO - PROCESS | 30656 | RSS: Main: 216039424 10:47:06 INFO - PROCESS | 30656 | 10:47:08 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32786/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:47:09 INFO - PROCESS | 30656 | RSS: Main: 225226752 10:47:09 INFO - PROCESS | 30656 | 10:47:12 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:47:12 INFO - PROCESS | 30656 | RSS: Main: 233566208 10:47:12 INFO - PROCESS | 30656 | 10:47:15 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:47:16 INFO - PROCESS | 30656 | RSS: Main: 230899712 10:47:16 INFO - PROCESS | 30656 | 10:47:17 INFO - PROCESS | 30656 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32786/tests/kraken/driver.html?testName=ai-astar) 10:47:18 INFO - PROCESS | 30656 | RSS: Main: 281645056 10:47:18 INFO - PROCESS | 30656 | 10:47:18 INFO - PROCESS | 30656 | __start_tp_report 10:47:18 INFO - PROCESS | 30656 | _x_x_mozilla_page_load 10:47:18 INFO - PROCESS | 30656 | _x_x_mozilla_page_load_details 10:47:18 INFO - PROCESS | 30656 | |i|pagename|runs| 10:47:18 INFO - PROCESS | 30656 | |0;ai-astar;103;114;112;112;113;112;110;112;112;111 10:47:18 INFO - PROCESS | 30656 | |1;audio-beat-detection;151;122;124;173;127;125;126;123;178;125 10:47:18 INFO - PROCESS | 30656 | |2;audio-dft;162;160;162;162;160;161;160;162;161;161 10:47:18 INFO - PROCESS | 30656 | |3;audio-fft;76;75;75;109;75;76;76;74;108;77 10:47:18 INFO - PROCESS | 30656 | |4;audio-oscillator;83;82;119;83;83;83;104;82;82;113 10:47:18 INFO - PROCESS | 30656 | |5;imaging-gaussian-blur;117;117;118;118;117;117;117;117;117;116 10:47:18 INFO - PROCESS | 30656 | |6;imaging-darkroom;146;145;147;148;147;146;146;147;147;145 10:47:18 INFO - PROCESS | 30656 | |7;imaging-desaturate;86;85;85;85;85;85;85;85;85;85 10:47:18 INFO - PROCESS | 30656 | |8;json-parse-financial;55;53;52;52;53;54;54;53;52;53 10:47:18 INFO - PROCESS | 30656 | |9;json-stringify-tinderbox;61;61;60;60;61;60;60;61;60;61 10:47:18 INFO - PROCESS | 30656 | |10;stanford-crypto-aes;80;80;80;85;80;80;80;80;81;80 10:47:18 INFO - PROCESS | 30656 | |11;stanford-crypto-ccm;133;130;134;132;132;137;127;136;179;130 10:47:18 INFO - PROCESS | 30656 | |12;stanford-crypto-pbkdf2;170;169;169;173;170;174;169;167;167;169 10:47:18 INFO - PROCESS | 30656 | |13;stanford-crypto-sha256-iterative;65;66;67;67;66;66;65;66;66;65 10:47:18 INFO - PROCESS | 30656 | __end_tp_report 10:47:18 INFO - PROCESS | 30656 | __start_cc_report 10:47:18 INFO - PROCESS | 30656 | _x_x_mozilla_cycle_collect,1699 10:47:18 INFO - PROCESS | 30656 | __end_cc_report 10:47:18 INFO - PROCESS | 30656 | __startTimestamp1476553638248__endTimestamp 10:47:18 INFO - PROCESS | 30656 | 10:47:18 INFO - PROCESS | 30656 | ------- Summary: start ------- 10:47:18 INFO - PROCESS | 30656 | Number of tests: 14 10:47:18 INFO - PROCESS | 30656 | 10:47:18 INFO - PROCESS | 30656 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:3.03 (2.7%) stddev-sans-first:1.12 10:47:18 INFO - PROCESS | 30656 | Values: 103.0 114.0 112.0 112.0 113.0 112.0 110.0 112.0 112.0 111.0 10:47:18 INFO - PROCESS | 30656 | 10:47:18 INFO - PROCESS | 30656 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:126.50 stddev:21.78 (17.2%) stddev-sans-first:22.54 10:47:18 INFO - PROCESS | 30656 | Values: 151.0 122.0 124.0 173.0 127.0 125.0 126.0 123.0 178.0 125.0 10:47:18 INFO - PROCESS | 30656 | 10:47:18 INFO - PROCESS | 30656 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.87 10:47:18 INFO - PROCESS | 30656 | Values: 162.0 160.0 162.0 162.0 160.0 161.0 160.0 162.0 161.0 161.0 10:47:18 INFO - PROCESS | 30656 | 10:47:18 INFO - PROCESS | 30656 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:13.94 (18.5%) stddev-sans-first:14.61 10:47:18 INFO - PROCESS | 30656 | Values: 76.0 75.0 75.0 109.0 75.0 76.0 76.0 74.0 108.0 77.0 10:47:18 INFO - PROCESS | 30656 | 10:47:18 INFO - PROCESS | 30656 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:82.50 stddev:14.66 (17.8%) stddev-sans-first:15.23 10:47:18 INFO - PROCESS | 30656 | Values: 83.0 82.0 119.0 83.0 83.0 83.0 104.0 82.0 82.0 113.0 10:47:18 INFO - PROCESS | 30656 | 10:47:18 INFO - PROCESS | 30656 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 10:47:18 INFO - PROCESS | 30656 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 10:47:18 INFO - PROCESS | 30656 | 10:47:18 INFO - PROCESS | 30656 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 10:47:18 INFO - PROCESS | 30656 | Values: 146.0 145.0 147.0 148.0 147.0 146.0 146.0 147.0 147.0 145.0 10:47:18 INFO - PROCESS | 30656 | 10:47:18 INFO - PROCESS | 30656 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.32 (0.4%) stddev-sans-first:0.00 10:47:18 INFO - PROCESS | 30656 | Values: 86.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 10:47:18 INFO - PROCESS | 30656 | 10:47:18 INFO - PROCESS | 30656 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.99 (1.9%) stddev-sans-first:0.78 10:47:18 INFO - PROCESS | 30656 | Values: 55.0 53.0 52.0 52.0 53.0 54.0 54.0 53.0 52.0 53.0 10:47:18 INFO - PROCESS | 30656 | 10:47:18 INFO - PROCESS | 30656 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 10:47:18 INFO - PROCESS | 30656 | Values: 61.0 61.0 60.0 60.0 61.0 60.0 60.0 61.0 60.0 61.0 10:47:18 INFO - PROCESS | 30656 | 10:47:18 INFO - PROCESS | 30656 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:1.58 (2.0%) stddev-sans-first:1.66 10:47:18 INFO - PROCESS | 30656 | Values: 80.0 80.0 80.0 85.0 80.0 80.0 80.0 80.0 81.0 80.0 10:47:18 INFO - PROCESS | 30656 | 10:47:18 INFO - PROCESS | 30656 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:133.50 stddev:15.05 (11.3%) stddev-sans-first:15.89 10:47:18 INFO - PROCESS | 30656 | Values: 133.0 130.0 134.0 132.0 132.0 137.0 127.0 136.0 179.0 130.0 10:47:18 INFO - PROCESS | 30656 | 10:47:18 INFO - PROCESS | 30656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:169.50 stddev:2.26 (1.3%) stddev-sans-first:2.40 10:47:18 INFO - PROCESS | 30656 | Values: 170.0 169.0 169.0 173.0 170.0 174.0 169.0 167.0 167.0 169.0 10:47:18 INFO - PROCESS | 30656 | 10:47:18 INFO - PROCESS | 30656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 10:47:18 INFO - PROCESS | 30656 | Values: 65.0 66.0 67.0 67.0 66.0 66.0 65.0 66.0 66.0 65.0 10:47:18 INFO - PROCESS | 30656 | -------- Summary: end -------- 10:47:18 INFO - PROCESS | 30656 | 10:47:19 INFO - TEST-INFO | 30656: exit 0 10:47:19 INFO - TEST-OK | kraken | took 61223ms 10:47:19 INFO - SUITE-END | took 1177s 10:47:19 INFO - Completed test suite (00:19:38) 10:47:19 INFO - javascript benchmark 10:47:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2983.9104826855196, 3004.18886900537, 3036.605241318628, 3038.407510535446, 3054.282243672738, 4942.233953737167, 5029.798808047673, 5155.355580552431, 5202.661826981243, 5314.867128321789, 5047.04106219818, 5155.561777248939, 5266.947330526694, 5272.103742363798, 5296.311479507659, 4676.0, 4694.765261736917, 4731.290306454025, 4742.834000809972, 4752.691075080126, 4744.383230180072, 4763.047390521892, 4837.588804951583, 4840.56434920857, 4899.191633380488, 4556.54434556545, 4791.041791641651, 4812.446568644581, 4824.107540105074, 4914.926276105862, 4588.24293991491, 4640.5127461616385, 4667.183242932507, 4733.077049975256, 4739.289106633998, 4693.061387722435, 4699.530046995307, 4703.294505824154, 4739.0, 4775.785089670973, 5103.872403189913, 5153.381594208681, 5159.329287192679, 5163.199704045879, 5172.456892026358, 5306.8407947761625, 5337.5196232338885, 5471.890562188773, 5532.723363831792, 5571.777128914839, 5577.721113944327, 5584.106542953108, 5584.972075139598, 5633.661980281156, 5656.151577263402, 5187.766550505236, 5194.298769666047, 5195.610329225286, 5197.324347834795, 5258.0, 5398.379186393537, 5446.537044351196, 5563.13771365439, 5674.773009079673, 5680.801171958961, 5410.594205434608, 5418.078926582491, 5423.864403389868, 5487.917681234785, 5491.560675145979, 5445.646033007842, 5485.780568777204, 5493.23094766733, 5495.587830912697, 5499.890002199933, 5201.271821944931, 5469.371022332403, 5482.424345443751, 5483.945160548423, 5495.945040549624, 5277.868053298622, 5463.972680136574, 5522.447755224445, 5541.002619528524, 5605.579581531401, 4198.727082739612, 4199.4120823084795, 4215.97892010538, 4244.045089854758, 4295.37717031035, 3789.9431508527396, 3794.905127371838, 3805.809709514513, 3837.347650899354, 3858.7105967052585, 5069.138246498031, 5120.0, 5210.583153347723, 5242.68543887368, 5254.0805359062015, 5561.610687251854, 5564.8330550083565, 5566.944330556724, 5569.275994120739, 5606.439356064361, 5215.713135777569, 5278.947210527922, 5280.788768449219, 5284.471552844761, 5337.546308563816, 4672.369230153954, 4715.339852420664, 4798.592119669797, 4850.781714822841, 4854.466008739036, 5784.479396854304, 5811.476967072984, 5812.447817457335, 5865.384134665798, 5878.118282257696, 5606.18710286998, 5620.297462817148, 5620.831375058755, 5622.634528755618, 5626.690532020614, 5399.541039011728, 5502.862428439321, 5811.215485909517, 5813.6221145625395, 5816.563757718103, 5353.411124776349, 5372.355317361941, 5396.406395296593, 5419.241306217212, 5480.890382192413, 5460.290162279037, 5463.562914966873, 5492.862678433071, 5508.697021663847, 5516.420775818481, 5211.348581427322, 5368.114261146867, 5370.704611246263, 5382.381026182039, 5389.407165211902, 5252.816151434834, 5379.327584051994, 5427.0, 5449.6730196188355, 5530.308711411074, 5449.482299181572, 5450.2369668247275, 5452.727363631882, 5455.754491047833, 5456.290682211287, 5517.2275881377445, 5539.861503462445, 5540.7783688652, 5541.307336582927, 5614.6631202128, 5167.974160129325, 5240.764165612481, 5241.790328386975, 5256.816011439581, 5302.602304827076], "value": 5105.863982664025, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.1415458301021, 588.2529187931327, 610.0391882784612, 612.4977518434882, 628.1708145248274, 31088.0, 41419.0, 42304.0, 42389.788051059775, 45481.0, 43408.34887476682, 43861.342079868824, 43879.78060109703, 43892.78053609728, 43919.78040109803, 7967.16344783798, 8176.509409435424, 8764.517951512664, 8918.777030574223, 8928.15182557656, 10576.418296993701, 10880.075193608553, 10905.83641245378, 10910.563577456933, 10921.83617245738, 10790.5683772649, 10878.075363594104, 10887.782244355149, 10891.0, 10901.618443354484, 10605.0, 10653.0, 10665.573377064908, 10674.839877401846, 10700.678979630624, 10550.683479495627, 10611.522481488351, 10616.62841800541, 10622.25644204906, 10629.255952083357, 42435.15129697389, 42726.786366068285, 42755.0, 42836.57163428388, 42850.78574607107, 3555.1112221944513, 3744.776759446726, 3828.942565861514, 3832.9835964251993, 4080.2451546463703, 31012.844935775403, 31135.22161945947, 31206.375872482422, 31732.524012139835, 31919.361612767847, 4224.366345048267, 4250.787460626987, 4397.978010109961, 4465.665075119379, 4479.148961697267, 343893.0, 344378.0, 348432.0, 349152.2542387297, 350200.0, 54998.45001549933, 55470.44529554653, 55594.72202638961, 55605.72197138988, 55669.72165139148, 34659.653403466145, 35322.64677353194, 35410.0, 37613.623863761015, 59186.40813591809, 16025.599360016093, 16036.518904432885, 16096.11471369086, 16109.19454027294, 16112.838871611368, 11999.460024298927, 12277.570285039981, 12870.48518059286, 13247.470101195844, 13305.866941330656, 18113.45659630213, 18945.147468363957, 19123.0, 19176.520586985436, 19281.950790334187, 6814.659267036628, 7076.292370762985, 7104.964475177694, 7145.8928116078305, 7171.426285897116, 882.4220135811054, 931.3527098666361, 938.2454809506266, 1014.4826138669332, 1096.8793432722393, 31165.532517012263, 33267.833660831544, 33590.0, 34035.0, 34129.31741365159, 966.7341481092756, 975.8292298847673, 982.4940155819759, 1022.9208185364512, 1064.302881612545, 15343.0, 15825.366985320457, 15943.282552285174, 16283.918580407022, 16320.83679163217, 540984.0, 804723.0, 816199.0, 820700.0, 823843.0, 56363.71818140965, 57349.71325143431, 57371.426285736605, 57415.42584574184, 57418.42581574214, 1213.672308476724, 1251.9248845069326, 1324.761542922264, 1338.3508998135896, 1347.6496111011209, 27266.454670906074, 29845.0, 31891.6810831898, 32004.35991280208, 32524.349513009132, 50429.74785126051, 51705.0, 51736.482635174674, 51750.741246293524, 51846.0, 465647.0, 469612.0, 475639.0, 476312.0, 477009.0, 40991.26122342934, 42825.78587107169, 43211.598550181225, 43351.34972975471, 43410.78294608507, 46866.0, 47788.7610561945, 47854.760726196146, 47970.0, 48073.0, 39269.803650981565, 40305.596944030185, 40417.79791101025, 40466.59533404746, 41381.1723765517, 39563.40654890236, 39665.60334396619, 40347.19305613812, 41501.37747933723, 41885.79057104695, 38714.22571548609, 39293.803530982164, 39465.0, 39833.80083099566, 40223.59776402316, 34193.0, 36268.637313626525, 36564.525487356914, 37107.44338834973, 37118.62881371152, 25939.0, 25989.220323390327, 26151.0, 26421.207363779118, 26976.0], "value": 20469.139612591993, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.2868156708934, 373.78507358268985, 376.2625254501176, 380.3970706430308, 403.80213695289297, 14287.78568321476, 18226.362077327296, 19486.99999999998, 20128.899355503203, 20317.59364812703, 18743.43769686908, 19688.606227875433, 19790.802091979076, 19889.50276243091, 19898.10458529366, 5442.0, 5725.398833122525, 5730.541556675476, 5733.627314224562, 5735.340435849868, 5443.591730620199, 5608.635438696471, 5635.830925072254, 5664.291963504562, 5668.97165514174, 5636.15457681347, 5638.718064096779, 5639.407862174474, 5639.492445679888, 5643.209950606918, 5385.3268341457315, 5560.7219639017885, 5583.0, 5585.3297604287545, 5633.63381380211, 4978.228374601942, 4987.47631498691, 4989.700617962933, 4991.051700176955, 4991.475895031006, 23233.186838460573, 23418.882905585535, 23453.530929381315, 23471.76528234713, 23718.644220336708, 2178.2920550821045, 2276.3512398966213, 2281.897314620846, 2295.483516208856, 2341.1220792202926, 13584.0, 14011.0, 14590.489332873298, 14736.55790326292, 15073.47242846506, 1871.5804789571764, 1912.0592598512521, 1914.6457905287566, 1951.6096780643927, 1981.900904954761, 82831.58584207101, 83819.0, 84134.57932710358, 84532.57733711292, 86705.99999999937, 9916.603335866628, 10072.496375181358, 10311.329763565343, 10476.109530689824, 10478.266521343432, 14472.27638618086, 14487.855121448862, 14489.0, 14506.782398264035, 14568.271586420637, 7860.606969651494, 7961.785030804832, 8013.19868013194, 8174.468659537111, 8238.629261683238, 7709.267619576131, 7780.2219778021745, 8046.758597242092, 8061.959690201512, 8078.0, 6266.561340706198, 6286.654234017082, 6415.358464153641, 6452.290248072708, 6452.870942581122, 1592.5938885584333, 1801.8918365205304, 1826.4611939477886, 1843.1429385335616, 1870.1584287070873, 873.3711727556149, 931.6552875435997, 943.6272672294406, 944.1408318430196, 983.233078199006, 18550.628987420176, 19207.61584768297, 19486.317978870673, 19575.412737617895, 19753.308634197732, 819.5779173725537, 884.9734507964771, 893.9284857211408, 907.4011152639226, 909.2771246858763, 8343.95828020856, 10259.692209233735, 10979.890201098047, 11128.221024528368, 11132.276402033842, 475628.0, 478043.85429894587, 480619.59690201323, 492196.0, 492351.0, 93019.53490232506, 96482.51758741161, 97928.0, 98626.5068674652, 99820.50089749505, 991.613270824379, 1009.8232809258351, 1037.9221558383001, 1038.4496217004848, 1047.418682631147, 16338.611218046599, 16622.0, 17084.0, 17306.48080557585, 17500.0, 40774.38838417367, 42079.36880946849, 42479.0, 42479.3628095585, 42863.134349223554, 58544.0, 58546.7072664651, 59230.930741774864, 59563.40436595579, 60159.0, 7954.880676789969, 8426.41015128935, 8496.70261540843, 8524.360672949677, 8631.352648551509, 11216.943915280372, 12162.574309899112, 12617.116801823784, 13201.933990329986, 13436.39536220892, 11558.190926635054, 11598.768024639292, 11834.585789497327, 12165.939170304091, 12187.268763874195, 11504.82742758876, 11514.596989105341, 11703.882961170279, 11704.531818727155, 12070.45682944252, 10380.480975951323, 10771.138308935424, 11538.480768365276, 11565.421728913352, 11848.881511184778, 7649.923500764921, 7732.497387669783, 7974.282314591715, 8004.879926801219, 8014.19858014194, 9393.436393816393, 11110.777844430984, 11204.327740335606, 11358.829617555908, 11788.646340609796], "value": 9170.702668049624, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.012990257307, 1404.992975035125, 1467.6697743007824, 1585.0927463801727, 1771.1764029726166, 7176.354128128467, 8685.131486851311, 8894.733158005254, 8948.507832069234, 9213.802205713248, 9004.414713043647, 9056.049114842945, 9063.546822658873, 9069.13843184898, 9073.909260907389, 2216.645336746121, 2244.4513285832722, 2244.8540844845115, 2246.3710161154904, 2249.1902914950606, 2192.7368715754133, 2226.5101677630896, 2234.9329520114425, 2241.540484200735, 2249.156566287642, 2208.2602328220064, 2210.425289424745, 2216.2686313516583, 2224.6218142915745, 2240.6863039174527, 2137.0810551462864, 2151.8816465094337, 2154.2890846020778, 2154.396768904709, 2157.9460513487134, 2174.5759576882515, 2175.6083904897114, 2176.1404245323165, 2179.0, 2183.268605017321, 8914.286857051486, 8944.418612790148, 9008.549572521348, 9009.684661036898, 9119.908800911971, 5090.2110172922885, 5298.496642818926, 5300.416954135042, 5300.575953923677, 5317.813876514342, 3300.6369299377047, 3451.6548345165534, 3474.0099071764425, 3479.565054368204, 3539.805310707936, 1082.9458527073614, 1126.2679258481971, 1136.431784107946, 1151.205668089016, 1153.9942300288528, 12311.876881231252, 12385.690357741038, 12394.132410731252, 12445.191062580903, 12468.625941221779, 4059.0, 4216.620504154641, 4309.935350969738, 4339.7830108494445, 4384.8903777405185, 9706.029397060238, 9708.320417570701, 9714.417134971924, 9715.902840971641, 9728.075832795874, 4950.653454258239, 4971.005798840247, 4975.527324904128, 4978.327925730053, 4978.576820970258, 3979.0, 4081.5714349992822, 4658.673892827537, 4669.509701481364, 4679.742614156254, 3644.1982763791925, 3696.168362118502, 3804.1821008483307, 3820.4078367853026, 3841.0973421245985, 1106.9059129973882, 1120.3222050659233, 1137.26078049267, 1139.1627154041773, 1145.6734830573246, 847.5550336073611, 873.218469469821, 880.5861245214738, 893.9418937769025, 905.8822353094188, 5537.640053396516, 5602.4957753802355, 5696.601237913306, 5788.986927287708, 5836.212111364996, 870.7561882672861, 899.869518919766, 910.3309067835136, 926.2312280806914, 937.4750139921666, 3581.606023337431, 3591.174029973121, 3638.272345530904, 3717.237966216919, 3874.3994680824517, 10750.516226769814, 11194.608188713519, 11204.271722338022, 11487.310761354178, 11513.136514761427, 11303.434828258554, 11324.886751132548, 11326.830097548544, 11337.886621133683, 11346.262492937933, 8266.256036956704, 8346.374021948257, 8357.247847693738, 8407.201315874981, 8434.62044208012, 5446.046941785251, 5477.616566840442, 5519.337679478488, 5592.608517403743, 5672.376038635829, 10013.549390277309, 10229.232807539316, 10235.334703244564, 10265.076143147153, 10320.845187322346, 10433.373997560171, 10463.68608941733, 10533.315334503233, 10557.9472102639, 10614.097801686943, 6633.0, 6859.691313890987, 7439.479236453396, 7516.736914207976, 7523.134839493309, 8432.53621050848, 8646.697365592174, 8684.261837743863, 8959.283257339528, 8962.955185224033, 7865.4494185406475, 7904.762857114296, 8007.559584222924, 8190.262876341158, 8206.58967051633, 7463.365613922877, 7630.122535908442, 7722.845543089219, 7752.4573279869865, 7780.766577002699, 7113.0, 7209.71161153548, 7219.133703955349, 7222.205557388578, 7227.7831665050135, 4785.306130611111, 4945.876353091202, 4981.352424184833, 5041.689160818287, 5153.613478989016, 4937.604991600591, 5001.8749531260555, 5016.72408017548, 5106.234064890296, 5108.131617624938], "value": 4525.17631735951, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.88559004348474, 329.86970146792015, 335.41804968379864, 336.81475188646255, 341.83250207398385, 5103.571000119963, 5214.426413094561, 5270.578353731702, 5293.364796224454, 5318.654287471311, 4984.0, 5120.385553733548, 5138.22926561016, 5202.401723801764, 5209.609279304048, 4104.086098869791, 4111.424400583921, 4114.280000999821, 4115.403266526352, 4126.154138401621, 3894.9805250973704, 3933.606639336072, 4120.958790412103, 4139.8965025874295, 4165.187788381267, 4108.26051310764, 4115.97942010291, 4138.33786594145, 4141.585841415865, 4170.270202714528, 4141.917161656765, 4151.190517849021, 4154.563770804082, 4157.771322577257, 4175.164967006581, 3616.945745813815, 3656.945145822815, 3681.226942342111, 3706.610805865372, 3716.457670066919, 5045.495450454961, 5049.5455409013, 5057.547089661512, 5074.908894587681, 5081.618878584121, 4679.695819771704, 4719.811207551694, 4732.526747325274, 4745.0, 4748.5251474852585, 5262.44757796451, 5417.702026388547, 5430.59270554706, 5433.755481003364, 5466.180072989044, 3986.966647010017, 3991.1219531702977, 3994.2610617035944, 3995.920081598381, 4005.439238506611, 5537.252470916415, 5593.888122237573, 5612.298462692163, 5614.24207731951, 5618.410066942953, 3955.8417663293144, 4106.958930410658, 4109.465769450012, 4109.97945010273, 4124.278251306009, 4118.382242663564, 4131.876043718693, 4140.565240649748, 4149.875503734893, 4150.900011496956, 4693.436787585511, 4729.266963620645, 4734.124187025412, 4738.763061846894, 4742.407199100113, 5384.434634363413, 5455.1544510600925, 5460.235567020621, 5467.0, 5512.944870551243, 1399.5801259622074, 1401.572520381273, 1403.5298175111452, 1405.7258834527374, 1414.3635364086203, 898.8651702244584, 923.8937522185034, 926.4348747264163, 932.6689025396022, 939.5993237278818, 4621.79201935907, 4634.536546345338, 4635.490096089427, 4646.233371493666, 4650.279206722963, 4878.707277563358, 4947.752612369367, 4952.356193694869, 4969.608509617313, 5002.699838009731, 4473.977630111894, 4711.340412342275, 4723.149833030019, 4746.620270378361, 4775.856724298276, 2577.780888624488, 2594.8443093414458, 2609.908653197129, 2615.5815069588775, 2623.216212975195, 5021.639829280305, 5057.508035129646, 5062.670926389773, 5075.416327122354, 5088.440271570124, 4784.808607655655, 4789.788671186245, 4945.258211268267, 4968.627352948543, 4994.225894986283, 5003.699038250008, 5006.574441172468, 5053.772580233898, 5083.110455670243, 5092.0, 4928.383952005999, 4943.975280123576, 4949.822078285543, 4957.100096443477, 4967.428745694291, 4592.632589392907, 4715.834945777018, 4863.635227357891, 4878.536539028786, 4878.926816097833, 4929.964707411484, 4993.0, 5074.213496907838, 5103.489651035015, 5155.484451554815, 3754.23038277158, 3770.981145094257, 3919.6080391960577, 4061.3298805696727, 4063.167050754529, 5436.836894893159, 5532.6680399176175, 5538.307711536058, 5602.635828671123, 5618.52242559387, 5423.105187643994, 5423.566114710892, 5430.456954304538, 5439.646422982493, 5456.781728730806, 5331.840044798662, 5434.0, 5459.153831156177, 5464.644798088111, 5496.5053145217125, 5340.49265319794, 5354.670718237579, 5404.297851074462, 5471.2613797138465, 5472.863178420572, 5272.525472707474, 5427.402985671494, 5440.9934162180125, 5464.590155738415, 5479.561635069264, 5390.975714614211, 5408.891822163613, 5410.21551874968, 5419.620626556103, 5428.104362780255], "value": 4037.5387253713557, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.9586624802512, 690.2097098821849, 703.156212544946, 724.999500689049, 752.1763668782688, 15047.623809404757, 16394.426195083175, 16438.589035274123, 16493.587660308498, 16502.42241521547, 14693.118412895206, 14829.03611265267, 14840.257987100656, 14856.18290993995, 14856.85143148571, 661.5832025823725, 677.0250838792148, 773.9226077392244, 774.7636970723927, 802.1978021978022, 802.8956235689382, 803.1446509467398, 803.8111043904707, 804.74650485097, 805.1706742055692, 845.6575087089739, 845.898492180936, 846.3779122345071, 846.7798372423183, 846.9745907622781, 690.1097584116509, 690.9861802763967, 704.5385272646424, 709.6735501669239, 839.3159574946429, 589.6196952965313, 589.7110415896223, 602.5962605054624, 613.5245184981675, 615.9630422174639, 14385.928070359685, 14465.421383144661, 14520.709585808225, 14560.854391456161, 14589.197594132318, 12931.741365172738, 13650.658733531742, 13863.861361386358, 13977.860221397757, 14092.073643026002, 12967.157134786208, 12974.0, 13216.744409281104, 13284.40220190084, 13430.462781488728, 4284.764337961411, 4288.871333859989, 4292.527821939584, 4310.159518893817, 4353.238183317939, 82276.0, 85084.0, 86431.0, 87177.56411217904, 88916.0, 11063.376990164865, 11145.498452569655, 11169.162312826571, 11253.212275140826, 11296.152788540729, 18402.81597184011, 18467.907660461613, 18483.815161848477, 18520.536986575444, 19245.326413575738, 7612.391008719289, 7803.336716379058, 7888.092869319987, 7918.722844700523, 8189.7133600323705, 4473.955260447419, 4556.589906908394, 4621.95378046222, 4635.397398338262, 4652.720836749738, 3638.21778317663, 3725.1432170600915, 3754.5119134512884, 3765.7363984521367, 3770.679492243135, 610.6793933185113, 620.8292719502083, 638.1066506890298, 646.0986923242051, 648.73726140913, 706.7914965085209, 729.7409419656052, 731.3637135691876, 734.4821900560092, 757.4394947738743, 8667.09658217176, 9234.215091717278, 9603.615855365846, 9719.271054670928, 10396.546751141375, 642.4810874587317, 692.1624833950875, 716.3946465236867, 721.9169795473483, 756.6141267953274, 4123.237201117803, 4411.0, 4436.556344365537, 4643.210654188796, 4742.905141897212, 112427.0, 115882.0, 115936.42031789955, 117846.0, 121247.39376303062, 95612.0, 96255.0, 96584.0, 96754.0, 97974.0, 84141.0, 86243.5687821557, 86733.0, 87416.0, 88184.0, 9611.615535378507, 10002.599896004078, 10066.16304250195, 10133.746656333651, 10256.58973641046, 51372.48627513827, 51403.0, 51938.0, 52705.41883743494, 52941.73529132484, 67108.3289167102, 71073.0, 74519.62740186264, 75124.24875751173, 75261.0, 12581.308028058545, 12995.953023329585, 13234.59101956264, 13850.376733047238, 14165.787513187104, 14216.004879658325, 14298.85701143017, 14535.345909434312, 14803.481878134213, 14866.554003379484, 12932.482700692244, 13068.80396794068, 13080.0, 13466.192028478323, 13731.725365492834, 13115.409806558919, 13666.658333541742, 14077.648058798202, 14621.707565848836, 14802.6299342513, 12983.740325193254, 13050.0, 13200.405981730653, 13330.933345333211, 13656.863431365558, 10522.526486308288, 10970.0, 11334.659960201207, 11355.829662554903, 11415.942920285346, 9742.512874356396, 10209.846852297072, 10288.382697038202, 11454.770904582028, 11523.942380288045], "value": 7489.0713452596865, "unit": "score"}], "name": "dromaeo_css", "value": 7127.98645360743, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 112.0, 112.0, 113.0, 112.0, 110.0, 112.0, 112.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 124.0, 173.0, 127.0, 125.0, 126.0, 123.0, 178.0, 125.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 162.0, 160.0, 161.0, 160.0, 162.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 109.0, 75.0, 76.0, 76.0, 74.0, 108.0, 77.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 119.0, 83.0, 83.0, 83.0, 104.0, 82.0, 82.0, 113.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 148.0, 147.0, 146.0, 146.0, 147.0, 147.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 52.0, 53.0, 54.0, 54.0, 53.0, 52.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 85.0, 80.0, 80.0, 80.0, 80.0, 81.0, 80.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 134.0, 132.0, 132.0, 137.0, 127.0, 136.0, 179.0, 130.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 169.0, 173.0, 170.0, 174.0, 169.0, 167.0, 167.0, 169.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 67.0, 66.0, 66.0, 65.0, 66.0, 66.0, 65.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1498.5000000000002, "alertThreshold": 2.0}]} 10:47:19 INFO - Return code: 0 10:47:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:47:20 INFO - # TBPL SUCCESS # 10:47:20 INFO - Running post-action listener: _resource_record_post_action 10:47:20 INFO - [mozharness: 2016-10-15 17:47:20.054684Z] Finished run-tests step (success) 10:47:20 INFO - Running post-run listener: _resource_record_post_run 10:47:20 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393842688; Read time: 12; Write time: 300172 10:47:20 INFO - TinderboxPrint: CPU usage
13.1% 10:47:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:47:20 INFO - TinderboxPrint: I/O write bytes / time
393,842,688 / 300,172 10:47:20 INFO - TinderboxPrint: CPU idle
8,280.5 (86.8%) 10:47:20 INFO - TinderboxPrint: CPU user
1,204.1 (12.6%) 10:47:20 INFO - TinderboxPrint: Swap in / out
0 / 0 10:47:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103735296; Read time: 0; Write time: 96148 10:47:20 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 290107392; Read time: 0; Write time: 204024 10:47:20 INFO - Running post-run listener: _upload_blobber_files 10:47:20 INFO - Blob upload gear active. 10:47:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:47:20 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 10:47:20 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'] 10:47:20 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 10:47:21 INFO - (blobuploader) - INFO - Open directory for files ... 10:47:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:47:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:47:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:47:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:47:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:47:21 INFO - (blobuploader) - INFO - Done attempting. 10:47:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:47:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:47:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:47:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:47:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:47:22 INFO - (blobuploader) - INFO - Done attempting. 10:47:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:47:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:47:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:47:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:47:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:47:26 INFO - (blobuploader) - INFO - Done attempting. 10:47:26 INFO - (blobuploader) - INFO - Iteration through files over. 10:47:26 INFO - Return code: 0 10:47:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:47:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:47:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f1c78f0639140be071da33d4916c2319f94e2aa91f103717ef411cc46aeb69f45ec6aa1747d05ccce00fdf01c650aca0ce95edae443e4dcebe3d50ac3cc2aa3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66051c1bb3c811caf536b451d6aebd76acfde9a6588017adc5c64fbd7e503778dceeb44a625d12ba97dfb3e5c7e252ecf687f7da9f8ae0b21dabf5c7e62101d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75cc531ac76e03e14063d7a1d7530dc1fb849910657767b4b10076717b9d1370e4e66c84fc30bcaa5376760bdac70826fc075f54d80b92e51b253fa5e890b7eb"} 10:47:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:47:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:47:26 INFO - Contents: 10:47:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f1c78f0639140be071da33d4916c2319f94e2aa91f103717ef411cc46aeb69f45ec6aa1747d05ccce00fdf01c650aca0ce95edae443e4dcebe3d50ac3cc2aa3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66051c1bb3c811caf536b451d6aebd76acfde9a6588017adc5c64fbd7e503778dceeb44a625d12ba97dfb3e5c7e252ecf687f7da9f8ae0b21dabf5c7e62101d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75cc531ac76e03e14063d7a1d7530dc1fb849910657767b4b10076717b9d1370e4e66c84fc30bcaa5376760bdac70826fc075f54d80b92e51b253fa5e890b7eb"} 10:47:26 INFO - Running post-run listener: copy_logs_to_upload_dir 10:47:26 INFO - Copying logs to upload dir... 10:47:26 INFO - mkdir: /builds/slave/test/build/upload/logs 10:47:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.954101 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-15 10:47:25.779564) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-15 10:47:25.783103) ========= 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=0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f1c78f0639140be071da33d4916c2319f94e2aa91f103717ef411cc46aeb69f45ec6aa1747d05ccce00fdf01c650aca0ce95edae443e4dcebe3d50ac3cc2aa3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66051c1bb3c811caf536b451d6aebd76acfde9a6588017adc5c64fbd7e503778dceeb44a625d12ba97dfb3e5c7e252ecf687f7da9f8ae0b21dabf5c7e62101d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75cc531ac76e03e14063d7a1d7530dc1fb849910657767b4b10076717b9d1370e4e66c84fc30bcaa5376760bdac70826fc075f54d80b92e51b253fa5e890b7eb"} build_url:https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011384 build_url: 'https://queue.taskcluster.net/v1/task/KjiWeEX0QkCWk5JhVFV6jA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f1c78f0639140be071da33d4916c2319f94e2aa91f103717ef411cc46aeb69f45ec6aa1747d05ccce00fdf01c650aca0ce95edae443e4dcebe3d50ac3cc2aa3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66051c1bb3c811caf536b451d6aebd76acfde9a6588017adc5c64fbd7e503778dceeb44a625d12ba97dfb3e5c7e252ecf687f7da9f8ae0b21dabf5c7e62101d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75cc531ac76e03e14063d7a1d7530dc1fb849910657767b4b10076717b9d1370e4e66c84fc30bcaa5376760bdac70826fc075f54d80b92e51b253fa5e890b7eb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-15 10:47:25.808675) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 10:47:25.809262) ========= 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=0333a256a5e4f052382dd180000001b1-1476550887.305030-127595436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 10:47:25.895488) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-15 10:47:25.896354) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-15 10:47:25.897126) ========= ========= Total master_lag: 0.21 =========