builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1476277318.83 results: success (0) buildid: 20161012030211 builduid: a769541e4bb74131a09b21df7c55a423 revision: 500baee3ce9f1b701ace9d38489cbc112d076c72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 06:01:58.832310) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 06:01:58.832784) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 06:01:58.833122) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 06:01:58.848356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:01:58.848740) ========= 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=5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-12 06:01:59-- 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% 226M=0s 2016-10-12 06:01:59 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107523 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:01:58.969862) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:01:58.970230) ========= 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=5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020995 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:01:59.019701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 06:01:59.020032) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 500baee3ce9f1b701ace9d38489cbc112d076c72 --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 500baee3ce9f1b701ace9d38489cbc112d076c72 --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=5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-12 06:01:59,839 truncating revision to first 12 chars 2016-10-12 06:01:59,839 Setting DEBUG logging. 2016-10-12 06:01:59,839 attempt 1/10 2016-10-12 06:01:59,839 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/500baee3ce9f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 06:02:00,877 unpacking tar archive at: mozilla-central-500baee3ce9f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.390668 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 06:02:00.424568) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 06:02:00.424910) ========= script_repo_revision: 500baee3ce9f1b701ace9d38489cbc112d076c72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 06:02:00.425399) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 06:02:00.425666) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 06:02:00.435789) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-12 06:02:00.436222) ========= /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=5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:02:01 INFO - MultiFileLogger online at 20161012 06:02:01 in /builds/slave/test 06:02:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:02:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:02:01 INFO - {'append_to_log': False, 06:02:01 INFO - 'base_work_dir': '/builds/slave/test', 06:02:01 INFO - 'blob_upload_branch': 'Firefox', 06:02:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:02:01 INFO - 'branch': 'Firefox', 06:02:01 INFO - 'buildbot_json_path': 'buildprops.json', 06:02:01 INFO - 'config_files': ('talos/linux_config.py',), 06:02:01 INFO - 'default_actions': ('clobber', 06:02:01 INFO - 'read-buildbot-config', 06:02:01 INFO - 'download-and-extract', 06:02:01 INFO - 'populate-webroot', 06:02:01 INFO - 'create-virtualenv', 06:02:01 INFO - 'install', 06:02:01 INFO - 'run-tests'), 06:02:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:02:01 INFO - 'download_minidump_stackwalk': True, 06:02:01 INFO - 'download_symbols': 'ondemand', 06:02:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:02:01 INFO - 'tooltool.py': '/tools/tooltool.py', 06:02:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:02:01 INFO - '/tools/misc-python/virtualenv.py')}, 06:02:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:02:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:02:01 INFO - 'installer_path': 'installer.exe', 06:02:01 INFO - 'log_level': 'info', 06:02:01 INFO - 'log_name': 'talos', 06:02:01 INFO - 'log_to_console': True, 06:02:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:02:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:02:01 INFO - 'opt_config_files': (), 06:02:01 INFO - 'pip_index': False, 06:02:01 INFO - 'sps_profile': False, 06:02:01 INFO - 'sps_profile_interval': 0, 06:02:01 INFO - 'suite': 'dromaeojs', 06:02:01 INFO - 'system_bits': '32', 06:02:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:02:01 INFO - 'title': 'talos-linux64-ix-039', 06:02:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:02:01 INFO - 'use_talos_json': True, 06:02:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:02:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:02:01 INFO - 'work_dir': 'build'} 06:02:01 INFO - [mozharness: 2016-10-12 13:02:01.359069Z] Running clobber step. 06:02:01 INFO - Running pre-action listener: _resource_record_pre_action 06:02:01 INFO - Running main action method: clobber 06:02:01 INFO - rmtree: /builds/slave/test/build 06:02:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:02:02 INFO - Running post-action listener: _resource_record_post_action 06:02:02 INFO - [mozharness: 2016-10-12 13:02:02.341285Z] Finished clobber step (success) 06:02:02 INFO - [mozharness: 2016-10-12 13:02:02.341385Z] Running read-buildbot-config step. 06:02:02 INFO - Running pre-action listener: _resource_record_pre_action 06:02:02 INFO - Running main action method: read_buildbot_config 06:02:02 INFO - Using buildbot properties: 06:02:02 INFO - { 06:02:02 INFO - "project": "", 06:02:02 INFO - "product": "firefox", 06:02:02 INFO - "script_repo_revision": "production", 06:02:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:02:02 INFO - "repository": "", 06:02:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:02:02 INFO - "buildid": "20161012030211", 06:02:02 INFO - "stage_platform": "linux64-pgo", 06:02:02 INFO - "basedir": "/builds/slave/test", 06:02:02 INFO - "nightly_build": "True", 06:02:02 INFO - "buildnumber": 30, 06:02:02 INFO - "slavename": "talos-linux64-ix-039", 06:02:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:02:02 INFO - "platform": "ubuntu64_hw", 06:02:02 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:02:02 INFO - "branch": "mozilla-central", 06:02:02 INFO - "repo_path": "mozilla-central", 06:02:02 INFO - "revision": "500baee3ce9f1b701ace9d38489cbc112d076c72", 06:02:02 INFO - "pgo_build": "True", 06:02:02 INFO - "builduid": "a769541e4bb74131a09b21df7c55a423", 06:02:02 INFO - "slavebuilddir": "test" 06:02:02 INFO - } 06:02:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:02:02 INFO - Running post-action listener: _resource_record_post_action 06:02:02 INFO - [mozharness: 2016-10-12 13:02:02.343886Z] Finished read-buildbot-config step (success) 06:02:02 INFO - [mozharness: 2016-10-12 13:02:02.344025Z] Running download-and-extract step. 06:02:02 INFO - Running pre-action listener: _resource_record_pre_action 06:02:02 INFO - Running main action method: download_and_extract 06:02:02 INFO - mkdir: /builds/slave/test/build/tests 06:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:02 INFO - trying https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:02:02 INFO - Downloading https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/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 06:02:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/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 06:02:02 INFO - Downloaded 1361 bytes. 06:02:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:02:02 INFO - Using the following test package requirements: 06:02:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:02:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:02:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:02:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:02:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:02:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:02:02 INFO - u'jsshell-linux-x86_64.zip'], 06:02:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:02:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:02:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:02:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:02:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:02:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:02:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:02:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:02:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:02:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:02:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:02:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:02:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:02:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:02:02 INFO - Fetch https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:02:03 INFO - Http code: 200 06:02:03 INFO - via: 1.1 3344ddc09ccf1d185bb41add18940cc4.cloudfront.net (CloudFront) 06:02:03 INFO - x-amz-cf-id: jEbwumPZuiCIVdR5kl6tOFMAi0yCvt6w3tMUHqOl2ma9UmPa-Ws4Lw== 06:02:03 INFO - x-amz-version-id: SE9QnOpJB9lilfpjivuC.lZnVaGK3_wM 06:02:03 INFO - Expected file size: 22100174 06:02:03 INFO - Obtained file size: 22100174 06:02:08 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 06:02:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:02:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:02:08 INFO - Fetch https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:02:08 INFO - Http code: 200 06:02:08 INFO - via: 1.1 55676da1e5c0a9c4e60a94a95b01dc04.cloudfront.net (CloudFront) 06:02:08 INFO - x-amz-cf-id: FNeI-NLQC8nCDuTAua9gxoGiYYVO3k-U1s4daomS0cH9S-icZKK7DA== 06:02:08 INFO - x-amz-version-id: SE9QnOpJB9lilfpjivuC.lZnVaGK3_wM 06:02:08 INFO - Expected file size: 22100174 06:02:08 INFO - Obtained file size: 22100174 06:02:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:02:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:02:13 INFO - Fetch https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:02:13 INFO - Http code: 200 06:02:13 INFO - via: 1.1 68e4011ca1c00bec92bb202e1ddce131.cloudfront.net (CloudFront) 06:02:13 INFO - x-amz-cf-id: Tt6FqK7euW2xL2MpYa7ULGBYWXeTkrhIiIKMZ3BBBQjaQ-rThH5NZA== 06:02:13 INFO - x-amz-version-id: yaeBMnhbVpfeDdywbU7XuDCwxuy2dyWE 06:02:14 INFO - Expected file size: 14409006 06:02:14 INFO - Obtained file size: 14409006 06:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:14 INFO - trying https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:02:14 INFO - Downloading https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/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 06:02:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/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 06:02:15 INFO - Downloaded 59747406 bytes. 06:02:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:02:15 INFO - mkdir: /builds/slave/test/properties 06:02:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:02:15 INFO - Writing to file /builds/slave/test/properties/build_url 06:02:15 INFO - Contents: 06:02:15 INFO - build_url:https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:02:16 INFO - Running post-action listener: _resource_record_post_action 06:02:16 INFO - Running post-action listener: set_extra_try_arguments 06:02:16 INFO - [mozharness: 2016-10-12 13:02:16.216407Z] Finished download-and-extract step (success) 06:02:16 INFO - [mozharness: 2016-10-12 13:02:16.216633Z] Running populate-webroot step. 06:02:16 INFO - Running pre-action listener: _resource_record_pre_action 06:02:16 INFO - Running main action method: populate_webroot 06:02:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:02:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:02:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:02:16 INFO - '--tppagecycles', 06:02:16 INFO - '7'], 06:02:16 INFO - 'tests': ['tsvgm']}}, 06:02:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:02:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:02:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:02:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:02:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:02:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:02:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:16 INFO - 'talos_options': ['--disable-e10s'], 06:02:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:02:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:02:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:16 INFO - 'talos_options': ['--disable-e10s'], 06:02:16 INFO - 'tests': ['damp', 'tps']}, 06:02:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:16 INFO - 'tests': ['damp', 'tps']}, 06:02:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:02:16 INFO - 'tests': ['dromaeo_dom']}, 06:02:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:02:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:02:16 INFO - 'tests': ['basic_compositor_video']}, 06:02:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:02:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:02:16 INFO - 'tests': ['a11yr', 06:02:16 INFO - 'ts_paint', 06:02:16 INFO - 'tpaint', 06:02:16 INFO - 'sessionrestore', 06:02:16 INFO - 'sessionrestore_no_auto_restore', 06:02:16 INFO - 'tabpaint']}, 06:02:16 INFO - 'other-e10s': {'tests': ['a11yr', 06:02:16 INFO - 'ts_paint', 06:02:16 INFO - 'tpaint', 06:02:16 INFO - 'sessionrestore', 06:02:16 INFO - 'sessionrestore_no_auto_restore', 06:02:16 INFO - 'tabpaint']}, 06:02:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:02:16 INFO - 'ts_paint', 06:02:16 INFO - 'tpaint', 06:02:16 INFO - 'sessionrestore', 06:02:16 INFO - 'sessionrestore_no_auto_restore', 06:02:16 INFO - 'tabpaint']}, 06:02:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:02:16 INFO - 'ts_paint', 06:02:16 INFO - 'tpaint', 06:02:16 INFO - 'sessionrestore', 06:02:16 INFO - 'sessionrestore_no_auto_restore', 06:02:16 INFO - 'tabpaint']}, 06:02:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:02:16 INFO - 'tests': ['a11yr', 06:02:16 INFO - 'ts_paint', 06:02:16 INFO - 'tpaint', 06:02:16 INFO - 'sessionrestore', 06:02:16 INFO - 'sessionrestore_no_auto_restore', 06:02:16 INFO - 'tabpaint']}, 06:02:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:02:16 INFO - 'tests': ['a11yr', 06:02:16 INFO - 'ts_paint', 06:02:16 INFO - 'tpaint', 06:02:16 INFO - 'sessionrestore', 06:02:16 INFO - 'sessionrestore_no_auto_restore', 06:02:16 INFO - 'tabpaint']}, 06:02:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:02:16 INFO - 'tests': ['tsvgx', 06:02:16 INFO - 'tsvgr_opacity', 06:02:16 INFO - 'tart', 06:02:16 INFO - 'tscrollx', 06:02:16 INFO - 'cart']}, 06:02:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:02:16 INFO - 'tsvgr_opacity', 06:02:16 INFO - 'tart', 06:02:16 INFO - 'tscrollx', 06:02:16 INFO - 'cart']}, 06:02:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:16 INFO - 'talos_options': ['--disable-e10s'], 06:02:16 INFO - 'tests': ['tp5o']}, 06:02:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:16 INFO - 'tests': ['tp5o']}, 06:02:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:16 INFO - 'talos_options': ['--disable-e10s', 06:02:16 INFO - '--xperf_path', 06:02:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:02:16 INFO - 'tests': ['tp5n']}, 06:02:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:16 INFO - 'talos_options': ['--xperf_path', 06:02:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:02:16 INFO - 'tests': ['tp5n']}}, 06:02:16 INFO - 'talos.zip': {'path': '', 06:02:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:02:16 INFO - Running post-action listener: _resource_record_post_action 06:02:16 INFO - [mozharness: 2016-10-12 13:02:16.232117Z] Finished populate-webroot step (success) 06:02:16 INFO - [mozharness: 2016-10-12 13:02:16.232205Z] Running create-virtualenv step. 06:02:16 INFO - Running pre-action listener: _resource_record_pre_action 06:02:16 INFO - Running main action method: create_virtualenv 06:02:16 INFO - Creating virtualenv /builds/slave/test/build/venv 06:02:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:02:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:02:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:02:16 INFO - Using real prefix '/usr' 06:02:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:02:16 INFO - Installing distribute.............................................................................................................................................................................................done. 06:02:18 INFO - Installing pip.................done. 06:02:18 INFO - Return code: 0 06:02:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:02:19 INFO - Reading from file tmpfile_stdout 06:02:19 INFO - Output received: 06:02:19 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) 06:02:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:02: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')]} 06:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02: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')]} 06:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:19 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 0x7f935fe8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d27b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, '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 0x2362690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2362b20>, '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': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:02:19 INFO - Using env: {'DISPLAY': ':0', 06:02:19 INFO - 'HOME': '/home/cltbld', 06:02:19 INFO - 'LANG': 'en_US.UTF-8', 06:02:19 INFO - 'LANGUAGE': 'en_US:en', 06:02:19 INFO - 'LOGNAME': 'cltbld', 06:02:19 INFO - 'MAIL': '/var/mail/cltbld', 06:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:19 INFO - 'MOZ_NO_REMOTE': '1', 06:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:19 INFO - 'NO_EM_RESTART': '1', 06:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:19 INFO - 'PWD': '/builds/slave/test', 06:02:19 INFO - 'SHELL': '/bin/bash', 06:02:19 INFO - 'SHLVL': '1', 06:02:19 INFO - 'TERM': 'linux', 06:02:19 INFO - 'TMOUT': '86400', 06:02:19 INFO - 'USER': 'cltbld', 06:02:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 06:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:19 INFO - '_': '/tools/buildbot/bin/python'} 06:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:02:19 INFO - Cleaning up... 06:02:19 INFO - Return code: 0 06:02:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:02: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')]} 06:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02: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')]} 06:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:19 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 0x7f935fe8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d27b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, '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 0x2362690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2362b20>, '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': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:02:19 INFO - Using env: {'DISPLAY': ':0', 06:02:19 INFO - 'HOME': '/home/cltbld', 06:02:19 INFO - 'LANG': 'en_US.UTF-8', 06:02:19 INFO - 'LANGUAGE': 'en_US:en', 06:02:19 INFO - 'LOGNAME': 'cltbld', 06:02:19 INFO - 'MAIL': '/var/mail/cltbld', 06:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:19 INFO - 'MOZ_NO_REMOTE': '1', 06:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:19 INFO - 'NO_EM_RESTART': '1', 06:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:19 INFO - 'PWD': '/builds/slave/test', 06:02:19 INFO - 'SHELL': '/bin/bash', 06:02:19 INFO - 'SHLVL': '1', 06:02:19 INFO - 'TERM': 'linux', 06:02:19 INFO - 'TMOUT': '86400', 06:02:19 INFO - 'USER': 'cltbld', 06:02:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 06:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:19 INFO - '_': '/tools/buildbot/bin/python'} 06:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:19 INFO - Downloading/unpacking psutil>=3.1.1 06:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:02:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:02:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:02:21 INFO - Installing collected packages: psutil 06:02:21 INFO - Running setup.py install for psutil 06:02:21 INFO - building 'psutil._psutil_linux' extension 06:02:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:02:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:02:21 INFO - building 'psutil._psutil_posix' extension 06:02:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:02:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:02:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:02:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:02:21 INFO - Successfully installed psutil 06:02:21 INFO - Cleaning up... 06:02:22 INFO - Return code: 0 06:02:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:22 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 0x7f935fe8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d27b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, '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 0x2362690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2362b20>, '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': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:02:22 INFO - Using env: {'DISPLAY': ':0', 06:02:22 INFO - 'HOME': '/home/cltbld', 06:02:22 INFO - 'LANG': 'en_US.UTF-8', 06:02:22 INFO - 'LANGUAGE': 'en_US:en', 06:02:22 INFO - 'LOGNAME': 'cltbld', 06:02:22 INFO - 'MAIL': '/var/mail/cltbld', 06:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:22 INFO - 'MOZ_NO_REMOTE': '1', 06:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:22 INFO - 'NO_EM_RESTART': '1', 06:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:22 INFO - 'PWD': '/builds/slave/test', 06:02:22 INFO - 'SHELL': '/bin/bash', 06:02:22 INFO - 'SHLVL': '1', 06:02:22 INFO - 'TERM': 'linux', 06:02:22 INFO - 'TMOUT': '86400', 06:02:22 INFO - 'USER': 'cltbld', 06:02:22 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 06:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:22 INFO - '_': '/tools/buildbot/bin/python'} 06:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:02:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:02:24 INFO - Installing collected packages: mozsystemmonitor 06:02:24 INFO - Running setup.py install for mozsystemmonitor 06:02:24 INFO - Successfully installed mozsystemmonitor 06:02:24 INFO - Cleaning up... 06:02:24 INFO - Return code: 0 06:02:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:24 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 0x7f935fe8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d27b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, '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 0x2362690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2362b20>, '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': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:02:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:02:24 INFO - Using env: {'DISPLAY': ':0', 06:02:24 INFO - 'HOME': '/home/cltbld', 06:02:24 INFO - 'LANG': 'en_US.UTF-8', 06:02:24 INFO - 'LANGUAGE': 'en_US:en', 06:02:24 INFO - 'LOGNAME': 'cltbld', 06:02:24 INFO - 'MAIL': '/var/mail/cltbld', 06:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:24 INFO - 'MOZ_NO_REMOTE': '1', 06:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:24 INFO - 'NO_EM_RESTART': '1', 06:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:24 INFO - 'PWD': '/builds/slave/test', 06:02:24 INFO - 'SHELL': '/bin/bash', 06:02:24 INFO - 'SHLVL': '1', 06:02:24 INFO - 'TERM': 'linux', 06:02:24 INFO - 'TMOUT': '86400', 06:02:24 INFO - 'USER': 'cltbld', 06:02:24 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 06:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:24 INFO - '_': '/tools/buildbot/bin/python'} 06:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:24 INFO - Downloading/unpacking jsonschema==2.5.1 06:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:02:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:26 INFO - Downloading functools32-3.2.3-2.tar.gz 06:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:02:26 INFO - warning: no files found matching '*.txt' 06:02:26 INFO - no previously-included directories found matching 'build' 06:02:26 INFO - no previously-included directories found matching 'dist' 06:02:26 INFO - no previously-included directories found matching '.git*' 06:02:26 INFO - Installing collected packages: jsonschema, functools32 06:02:26 INFO - Running setup.py install for functools32 06:02:26 INFO - warning: no files found matching '*.txt' 06:02:26 INFO - no previously-included directories found matching 'build' 06:02:26 INFO - no previously-included directories found matching 'dist' 06:02:26 INFO - no previously-included directories found matching '.git*' 06:02:26 INFO - Successfully installed jsonschema functools32 06:02:26 INFO - Cleaning up... 06:02:26 INFO - Return code: 0 06:02:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:27 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 0x7f935fe8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d27b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, '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 0x2362690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2362b20>, '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': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:02:27 INFO - Using env: {'DISPLAY': ':0', 06:02:27 INFO - 'HOME': '/home/cltbld', 06:02:27 INFO - 'LANG': 'en_US.UTF-8', 06:02:27 INFO - 'LANGUAGE': 'en_US:en', 06:02:27 INFO - 'LOGNAME': 'cltbld', 06:02:27 INFO - 'MAIL': '/var/mail/cltbld', 06:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:27 INFO - 'MOZ_NO_REMOTE': '1', 06:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:27 INFO - 'NO_EM_RESTART': '1', 06:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:27 INFO - 'PWD': '/builds/slave/test', 06:02:27 INFO - 'SHELL': '/bin/bash', 06:02:27 INFO - 'SHLVL': '1', 06:02:27 INFO - 'TERM': 'linux', 06:02:27 INFO - 'TMOUT': '86400', 06:02:27 INFO - 'USER': 'cltbld', 06:02:27 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 06:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:27 INFO - '_': '/tools/buildbot/bin/python'} 06:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:02:27 INFO - Cleaning up... 06:02:27 INFO - Return code: 0 06:02:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:27 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 0x7f935fe8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d27b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, '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 0x2362690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2362b20>, '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': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:02:27 INFO - Using env: {'DISPLAY': ':0', 06:02:27 INFO - 'HOME': '/home/cltbld', 06:02:27 INFO - 'LANG': 'en_US.UTF-8', 06:02:27 INFO - 'LANGUAGE': 'en_US:en', 06:02:27 INFO - 'LOGNAME': 'cltbld', 06:02:27 INFO - 'MAIL': '/var/mail/cltbld', 06:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:27 INFO - 'MOZ_NO_REMOTE': '1', 06:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:27 INFO - 'NO_EM_RESTART': '1', 06:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:27 INFO - 'PWD': '/builds/slave/test', 06:02:27 INFO - 'SHELL': '/bin/bash', 06:02:27 INFO - 'SHLVL': '1', 06:02:27 INFO - 'TERM': 'linux', 06:02:27 INFO - 'TMOUT': '86400', 06:02:27 INFO - 'USER': 'cltbld', 06:02:27 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 06:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:27 INFO - '_': '/tools/buildbot/bin/python'} 06:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:27 INFO - Downloading/unpacking blobuploader==1.2.4 06:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:29 INFO - Downloading blobuploader-1.2.4.tar.gz 06:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:02:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:02:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:30 INFO - Downloading docopt-0.6.1.tar.gz 06:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:02:30 INFO - Installing collected packages: blobuploader, requests, docopt 06:02:30 INFO - Running setup.py install for blobuploader 06:02:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:02:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:02:30 INFO - Running setup.py install for requests 06:02:30 INFO - Running setup.py install for docopt 06:02:30 INFO - Successfully installed blobuploader requests docopt 06:02:30 INFO - Cleaning up... 06:02:30 INFO - Return code: 0 06:02:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:30 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 0x7f935fe8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d27b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, '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 0x2362690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2362b20>, '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': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:02:30 INFO - Using env: {'DISPLAY': ':0', 06:02:30 INFO - 'HOME': '/home/cltbld', 06:02:30 INFO - 'LANG': 'en_US.UTF-8', 06:02:30 INFO - 'LANGUAGE': 'en_US:en', 06:02:30 INFO - 'LOGNAME': 'cltbld', 06:02:30 INFO - 'MAIL': '/var/mail/cltbld', 06:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:30 INFO - 'MOZ_NO_REMOTE': '1', 06:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:30 INFO - 'NO_EM_RESTART': '1', 06:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:30 INFO - 'PWD': '/builds/slave/test', 06:02:30 INFO - 'SHELL': '/bin/bash', 06:02:30 INFO - 'SHLVL': '1', 06:02:30 INFO - 'TERM': 'linux', 06:02:30 INFO - 'TMOUT': '86400', 06:02:30 INFO - 'USER': 'cltbld', 06:02:30 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 06:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:30 INFO - '_': '/tools/buildbot/bin/python'} 06:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:02:30 INFO - Running setup.py (path:/tmp/pip-9ErSej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:02:31 INFO - Running setup.py (path:/tmp/pip-WwL9bY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:02:31 INFO - Running setup.py (path:/tmp/pip-bCgSKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:02:31 INFO - Running setup.py (path:/tmp/pip-OWnsfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:02:31 INFO - Running setup.py (path:/tmp/pip-mOGjOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:02:31 INFO - Running setup.py (path:/tmp/pip-5uacIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:02:31 INFO - Running setup.py (path:/tmp/pip-0HWVc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:02:31 INFO - Running setup.py (path:/tmp/pip-LGYC52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:02:31 INFO - Running setup.py (path:/tmp/pip-QwxT3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:02:31 INFO - Running setup.py (path:/tmp/pip-o7gPbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:02:31 INFO - Running setup.py (path:/tmp/pip-a2WnTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:02:31 INFO - Running setup.py (path:/tmp/pip-HhQoED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:02:31 INFO - Running setup.py (path:/tmp/pip-1yPrTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:02:31 INFO - Running setup.py (path:/tmp/pip-JRwQYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:31 INFO - Running setup.py (path:/tmp/pip-Gj1dbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:02:32 INFO - Running setup.py (path:/tmp/pip-17zfLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:02:32 INFO - Running setup.py (path:/tmp/pip-1i8Brq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:02:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:02:32 INFO - Running setup.py install for manifestparser 06:02:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:02:32 INFO - Running setup.py install for mozcrash 06:02:32 INFO - Running setup.py install for mozdebug 06:02:32 INFO - Running setup.py install for mozdevice 06:02:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:02:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:02:32 INFO - Running setup.py install for mozfile 06:02:32 INFO - Running setup.py install for mozhttpd 06:02:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:02:32 INFO - Running setup.py install for mozinfo 06:02:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:02:32 INFO - Running setup.py install for mozInstall 06:02:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:02:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:02:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:02:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:02:32 INFO - Running setup.py install for mozleak 06:02:33 INFO - Running setup.py install for mozlog 06:02:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:02:33 INFO - Running setup.py install for moznetwork 06:02:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:02:33 INFO - Running setup.py install for mozprocess 06:02:33 INFO - Running setup.py install for mozprofile 06:02:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:02:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:02:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:02:33 INFO - Running setup.py install for mozrunner 06:02:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:02:33 INFO - Running setup.py install for mozscreenshot 06:02:33 INFO - Running setup.py install for moztest 06:02:33 INFO - Running setup.py install for mozversion 06:02:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:02:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:02:33 INFO - Cleaning up... 06:02:33 INFO - Return code: 0 06:02:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:33 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 0x7f935fe8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d27b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, '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 0x2362690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2362b20>, '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': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:02:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:02:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:02:33 INFO - Using env: {'DISPLAY': ':0', 06:02:33 INFO - 'HOME': '/home/cltbld', 06:02:33 INFO - 'LANG': 'en_US.UTF-8', 06:02:33 INFO - 'LANGUAGE': 'en_US:en', 06:02:33 INFO - 'LOGNAME': 'cltbld', 06:02:33 INFO - 'MAIL': '/var/mail/cltbld', 06:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:33 INFO - 'MOZ_NO_REMOTE': '1', 06:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:33 INFO - 'NO_EM_RESTART': '1', 06:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:34 INFO - 'PWD': '/builds/slave/test', 06:02:34 INFO - 'SHELL': '/bin/bash', 06:02:34 INFO - 'SHLVL': '1', 06:02:34 INFO - 'TERM': 'linux', 06:02:34 INFO - 'TMOUT': '86400', 06:02:34 INFO - 'USER': 'cltbld', 06:02:34 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 06:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:34 INFO - '_': '/tools/buildbot/bin/python'} 06:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:02:34 INFO - Running setup.py (path:/tmp/pip-ReuMOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:02:34 INFO - Running setup.py (path:/tmp/pip-qGDegN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:02:34 INFO - Running setup.py (path:/tmp/pip-mL12Hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:02:34 INFO - Running setup.py (path:/tmp/pip-wu7et8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:02:34 INFO - Running setup.py (path:/tmp/pip-ye1b7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:02:34 INFO - Running setup.py (path:/tmp/pip-_EMVBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:02:34 INFO - Running setup.py (path:/tmp/pip-XW1q9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:02:34 INFO - Running setup.py (path:/tmp/pip-iHQEZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:02:34 INFO - Running setup.py (path:/tmp/pip-4zun4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:02:34 INFO - Running setup.py (path:/tmp/pip-BYNWNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:02:34 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)) 06:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:02:34 INFO - Running setup.py (path:/tmp/pip-DWW5Tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:02:35 INFO - Running setup.py (path:/tmp/pip-z6rcvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:02:35 INFO - Running setup.py (path:/tmp/pip-A_W9AU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:02:35 INFO - Running setup.py (path:/tmp/pip-lEbmcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:35 INFO - Running setup.py (path:/tmp/pip-IwYqsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:02:35 INFO - Running setup.py (path:/tmp/pip-2cOiAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:02:35 INFO - Running setup.py (path:/tmp/pip-CqyQQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:02:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:37 INFO - Downloading blessings-1.6.tar.gz 06:02:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:02:37 INFO - Installing collected packages: blessings 06:02:37 INFO - Running setup.py install for blessings 06:02:37 INFO - Successfully installed blessings 06:02:37 INFO - Cleaning up... 06:02:37 INFO - Return code: 0 06:02:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:02:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:02:37 INFO - Reading from file tmpfile_stdout 06:02:37 INFO - Current package versions: 06:02:37 INFO - argparse == 1.2.1 06:02:37 INFO - blessings == 1.6 06:02:37 INFO - blobuploader == 1.2.4 06:02:37 INFO - docopt == 0.6.1 06:02:37 INFO - functools32 == 3.2.3-2 06:02:37 INFO - jsonschema == 2.5.1 06:02:37 INFO - manifestparser == 1.1 06:02:37 INFO - mozInstall == 1.12 06:02:37 INFO - mozcrash == 0.17 06:02:37 INFO - mozdebug == 0.1 06:02:37 INFO - mozdevice == 0.48 06:02:37 INFO - mozfile == 1.2 06:02:37 INFO - mozhttpd == 0.7 06:02:37 INFO - mozinfo == 0.9 06:02:37 INFO - mozleak == 0.1 06:02:37 INFO - mozlog == 3.4 06:02:37 INFO - moznetwork == 0.27 06:02:37 INFO - mozprocess == 0.23 06:02:37 INFO - mozprofile == 0.28 06:02:37 INFO - mozrunner == 6.12 06:02:37 INFO - mozscreenshot == 0.1 06:02:37 INFO - mozsystemmonitor == 0.3 06:02:37 INFO - moztest == 0.7 06:02:37 INFO - mozversion == 1.4 06:02:37 INFO - psutil == 3.1.1 06:02:37 INFO - requests == 1.2.3 06:02:37 INFO - wsgiref == 0.1.2 06:02:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:37 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 0x7f935fe8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d27b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, '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 0x2362690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2362b20>, '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': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:02:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:02:37 INFO - Using env: {'DISPLAY': ':0', 06:02:37 INFO - 'HOME': '/home/cltbld', 06:02:37 INFO - 'LANG': 'en_US.UTF-8', 06:02:37 INFO - 'LANGUAGE': 'en_US:en', 06:02:37 INFO - 'LOGNAME': 'cltbld', 06:02:37 INFO - 'MAIL': '/var/mail/cltbld', 06:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:37 INFO - 'MOZ_NO_REMOTE': '1', 06:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:37 INFO - 'NO_EM_RESTART': '1', 06:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:37 INFO - 'PWD': '/builds/slave/test', 06:02:37 INFO - 'SHELL': '/bin/bash', 06:02:37 INFO - 'SHLVL': '1', 06:02:37 INFO - 'TERM': 'linux', 06:02:37 INFO - 'TMOUT': '86400', 06:02:37 INFO - 'USER': 'cltbld', 06:02:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 06:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:37 INFO - '_': '/tools/buildbot/bin/python'} 06:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:02:38 INFO - Cleaning up... 06:02:38 INFO - Return code: 0 06:02:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:38 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 0x7f935fe8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d27b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2361790>, '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 0x2362690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2362b20>, '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': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:02:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:02:38 INFO - Using env: {'DISPLAY': ':0', 06:02:38 INFO - 'HOME': '/home/cltbld', 06:02:38 INFO - 'LANG': 'en_US.UTF-8', 06:02:38 INFO - 'LANGUAGE': 'en_US:en', 06:02:38 INFO - 'LOGNAME': 'cltbld', 06:02:38 INFO - 'MAIL': '/var/mail/cltbld', 06:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:38 INFO - 'MOZ_NO_REMOTE': '1', 06:02:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:38 INFO - 'NO_EM_RESTART': '1', 06:02:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:38 INFO - 'PWD': '/builds/slave/test', 06:02:38 INFO - 'SHELL': '/bin/bash', 06:02:38 INFO - 'SHLVL': '1', 06:02:38 INFO - 'TERM': 'linux', 06:02:38 INFO - 'TMOUT': '86400', 06:02:38 INFO - 'USER': 'cltbld', 06:02:38 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 06:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:38 INFO - '_': '/tools/buildbot/bin/python'} 06:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:02:38 INFO - Cleaning up... 06:02:38 INFO - Return code: 0 06:02:38 INFO - Running post-action listener: _resource_record_post_action 06:02:38 INFO - Running post-action listener: _start_resource_monitoring 06:02:38 INFO - Starting resource monitoring. 06:02:38 INFO - [mozharness: 2016-10-12 13:02:38.329436Z] Finished create-virtualenv step (success) 06:02:38 INFO - [mozharness: 2016-10-12 13:02:38.329913Z] Running install step. 06:02:38 INFO - Running pre-action listener: _resource_record_pre_action 06:02:38 INFO - Running main action method: install 06:02:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:02:38 INFO - Reading from file tmpfile_stdout 06:02:38 INFO - Detecting whether we're running mozinstall >=1.0... 06:02:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:02:38 INFO - Reading from file tmpfile_stdout 06:02:38 INFO - Output received: 06:02:38 INFO - Usage: mozinstall [options] installer 06:02:38 INFO - Options: 06:02:38 INFO - -h, --help show this help message and exit 06:02:38 INFO - -d DEST, --destination=DEST 06:02:38 INFO - Directory to install application into. [default: 06:02:38 INFO - "/builds/slave/test"] 06:02:38 INFO - --app=APP Application being installed. [default: firefox] 06:02:38 INFO - mkdir: /builds/slave/test/build/application 06:02:38 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'] 06:02:38 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 06:02:56 INFO - Reading from file tmpfile_stdout 06:02:56 INFO - Output received: 06:02:56 INFO - /builds/slave/test/build/application/firefox/firefox 06:02:56 INFO - Running post-action listener: _resource_record_post_action 06:02:56 INFO - [mozharness: 2016-10-12 13:02:56.426375Z] Finished install step (success) 06:02:56 INFO - [mozharness: 2016-10-12 13:02:56.426620Z] Running run-tests step. 06:02:56 INFO - Running pre-action listener: _resource_record_pre_action 06:02:56 INFO - Running main action method: run_tests 06:02:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:02:56 INFO - Python 2.7.3 06:02:56 INFO - Return code: 0 06:02:56 INFO - grabbing minidump binary from tooltool 06:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:56 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 0x2361790>, '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 0x2362690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2362b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:02:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:02:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:02:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:02:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:02:56 INFO - Return code: 0 06:02:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:02:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:02:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:02:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:02:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:02:56 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/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:02:56 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/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:02:56 INFO - Using env: {'DISPLAY': ':0', 06:02:56 INFO - 'HOME': '/home/cltbld', 06:02:56 INFO - 'LANG': 'en_US.UTF-8', 06:02:56 INFO - 'LANGUAGE': 'en_US:en', 06:02:56 INFO - 'LOGNAME': 'cltbld', 06:02:56 INFO - 'MAIL': '/var/mail/cltbld', 06:02:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:02:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:56 INFO - 'MOZ_NO_REMOTE': '1', 06:02:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:56 INFO - 'NO_EM_RESTART': '1', 06:02:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:56 INFO - 'PWD': '/builds/slave/test', 06:02:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:02:56 INFO - 'SHELL': '/bin/bash', 06:02:56 INFO - 'SHLVL': '1', 06:02:56 INFO - 'TERM': 'linux', 06:02:56 INFO - 'TMOUT': '86400', 06:02:56 INFO - 'USER': 'cltbld', 06:02:56 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505', 06:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:56 INFO - '_': '/tools/buildbot/bin/python'} 06:02:56 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/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:02:56 INFO - mozversion application_buildid: 20161012030211 06:02:56 INFO - mozversion application_changeset: 500baee3ce9f1b701ace9d38489cbc112d076c72 06:02:56 INFO - mozversion application_display_name: Nightly 06:02:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:02:56 INFO - mozversion application_name: Firefox 06:02:56 INFO - mozversion application_remotingname: firefox 06:02:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:02:56 INFO - mozversion application_vendor: Mozilla 06:02:56 INFO - mozversion application_version: 52.0a1 06:02:56 INFO - mozversion platform_buildid: 20161012030211 06:02:56 INFO - mozversion platform_changeset: 500baee3ce9f1b701ace9d38489cbc112d076c72 06:02:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:02:56 INFO - mozversion platform_version: 52.0a1 06:02:56 INFO - using testdate: 1476277376 06:02:56 INFO - actual date: 1476277376 06:02:56 INFO - starting webserver on 'localhost:38955' 06:02:56 INFO - SUITE-START | Running 2 tests 06:02:56 INFO - TEST-START | dromaeo_css 06:02:56 INFO - operating with platform_type : linux_ 06:02:56 INFO - Initialising browser for dromaeo_css test... 06:02:56 INFO - TEST-INFO | started process 25449 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCsCX9o/profile http://localhost:38955/getInfo.html) 06:03:01 INFO - PROCESS | 25449 | __metrics Screen width/height:1600/1200 06:03:01 INFO - PROCESS | 25449 | colorDepth:24 06:03:01 INFO - PROCESS | 25449 | Browser inner width/height: 1024/697 06:03:01 INFO - PROCESS | 25449 | __metrics 06:03:01 INFO - PROCESS | 25449 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:03:01 INFO - PROCESS | 25449 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:03:02 INFO - PROCESS | 25449 | console.error: PushService: 06:03:02 INFO - PROCESS | 25449 | stateChangeProcessEnqueue: Error transitioning state 06:03:02 INFO - PROCESS | 25449 | UnknownError 06:03:02 INFO - TEST-INFO | 25449: exit 0 06:03:02 INFO - Browser initialized. 06:03:02 INFO - Running cycle 1/1 for dromaeo_css test... 06:03:02 INFO - TEST-INFO | started process 25533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCsCX9o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:03:15 INFO - PROCESS | 25533 | RSS: Main: 173404160 06:03:15 INFO - PROCESS | 25533 | 06:04:06 INFO - PROCESS | 25533 | 1476277446235 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:06:17 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:38955/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38955/tests/dromaeo/cssquery-ext.html) 06:06:18 INFO - PROCESS | 25533 | RSS: Main: 323940352 06:06:18 INFO - PROCESS | 25533 | 06:09:21 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:38955/tests/dromaeo/cssquery-ext.html (next: http://localhost:38955/tests/dromaeo/cssquery-jquery.html) 06:09:22 INFO - PROCESS | 25533 | RSS: Main: 277569536 06:09:22 INFO - PROCESS | 25533 | 06:12:24 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:38955/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38955/tests/dromaeo/cssquery-mootools.html) 06:12:24 INFO - PROCESS | 25533 | RSS: Main: 215568384 06:12:24 INFO - PROCESS | 25533 | 06:15:26 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:38955/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38955/tests/dromaeo/cssquery-prototype.html) 06:15:27 INFO - PROCESS | 25533 | RSS: Main: 217059328 06:15:27 INFO - PROCESS | 25533 | 06:18:30 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:38955/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38955/tests/dromaeo/cssquery-yui.html) 06:18:30 INFO - PROCESS | 25533 | RSS: Main: 215687168 06:18:30 INFO - PROCESS | 25533 | 06:21:33 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:38955/tests/dromaeo/cssquery-yui.html (next: http://localhost:38955/tests/dromaeo/cssquery-dojo.html) 06:21:34 INFO - PROCESS | 25533 | RSS: Main: 321662976 06:21:34 INFO - PROCESS | 25533 | 06:21:34 INFO - PROCESS | 25533 | __start_tp_report 06:21:34 INFO - PROCESS | 25533 | _x_x_mozilla_page_load 06:21:34 INFO - PROCESS | 25533 | _x_x_mozilla_page_load_details 06:21:34 INFO - PROCESS | 25533 | |i|pagename|runs| 06:21:34 INFO - PROCESS | 25533 | |0;dojo.html;2901.8984335548253;2940.456015637107;2942.3968086542272;2959.911202663921;3001.159675290918;5040.4959504049575;5057.0897238497055;5119.616028797836;5144.331236939197;5202.546812029036;5145.81989630363;5149.459306772782;5197.7920883164625;5214.296070030545;5238.423773384925;4611.538846115378;4625.699329543586;4688.484266730657;4689.226277664198;4717.033008233321;4192.4759405074365;4674.11191873543;4716.504766999467;4722.669413141081;4777.307290442884;4568.725876447391;4680.4383473983;4681.297805329194;4693.413323334583;4796.08874313881;4601.28680054592;4666.393368862026;4667;4668.836590719343;4675.532446755331;4632.374629425019;4636.397268355126;4639.744814035227;4645.163870503308;4648.558386953234;5049.4950504949575;5059.215821547666;5091.643584949055;5094.439611642753;5125.769340379655;5446.809361672323;5452.4274951129955;5453.918191227135;5454.072807622674;5458.645188062763;5469.644473109235;5472.315960504937;5492.890142197173;5493.450654934514;5498.477644623755;5099.5410413063;5108.106081435771;5131.563817075553;5133.640645154841;5135.178371460548;5598.10430331145;5606.775728970877;5608.523275521627;5608.635438696553;5660.603757737002;5387.81142660005;5399.595030372738;5403.5136837684795;5403.729813509309;5457.126859702428;5341.118715411992;5381.7578208980685;5385.892282154335;5440.755166017539;5461.672299662033;5463.672179669233;5494.203340515683;5500.944990550043;5542.806001789918;5571.9442805572235;5520.171974203821;5521.3926468088475;5521.779128834882;5523.558115350843;5565.109582466866;4165.75005499671;4204.705670603028;4272.700910936204;4274.294741367639;4332.545082766264;3751.737378383487;3782.3002744492355;3794.0894185395305;3800.6959443244473;3845.5193100862393;5228.215767634885;5237.816676416383;5253.13323301651;5254.106801843695;5307.469253074739;5509.201165830932;5514.365847927459;5522.199281104217;5522.834314970557;5525.336959564797;5120.462351453119;5160.664556803796;5219.321488206585;5230.869228269324;5266.262723218752;4795.472498025214;4803.495632958489;4808.495108013608;4831.154547954094;4857.028594281158;5740.024195886709;5751.798687045934;5762.452567006211;5763.135529670583;5768.451997060272;5361.088614935392;5408.648437851527;5416.458354164552;5499;5554.611177217556;5743.942560574341;5765.4811067004175;5796.768129274782;5799.710014499174;5801.796937107181;5384.838454846361;5394.541463975606;5432.8047829477455;5452.727363631723;5515.062439385234;5480.698561579152;5493.09363954943;5508.228847961209;5570.303712035996;5625.21247025425;5268.552173065333;5278.70967096798;5333.12003519415;5400.810971615974;5434.728263586726;5320.8935821282585;5343.625946183885;5361.839144825662;5376.193570964387;5379.1662292344745;5314.22943673173;5316.122839731555;5358;5368.141097424394;5372.328458942632;5453.2365468833605;5459;5464.371597266365;5472.042392581362;5517.917231241454;5137.280780690631;5182.663126896739;5225.085610018307;5327.227552005015;5350.2242174885205 06:21:34 INFO - PROCESS | 25533 | |1;ext.html;543.9620215606766;599.3107925885231;604.4650484321377;614.4163045107148;619.3311223878206;31658.366832663363;43096.35355469667;43290.567094329046;43371;43375;45910.31134532976;46217.920193591286;46385.30422043672;46413;46414.53585464144;8042.3566114710975;8889.955550222256;9049.095090490964;9049.411788233743;9049.864252036225;8170.877436838452;8247.422680412343;8249.257566818986;10562.78874422511;10811.459427028656;10960.28758130719;11042.723931901726;11046.447677616126;11053.336799791998;11068.446577671124;10731.195160362964;10760.3543787373;10804.99999999996;10816.35101893881;10819.891801082045;7982.32150267228;8144.877826832602;8145.226203510657;8394.328453723687;10235.488225588766;40119.799401002805;42706.57293427057;43464.56535434637;43520.782396087816;43544.782276088416;3306.322203948209;3369.275605744777;3431.1079119428878;3558.5907620623443;3756.211195648917;29367.412651747058;31342.843285783427;32000.19999500008;32070.198245043826;32119.51820722691;4262.12626411588;4461.174682683682;4469.7541635210055;4520.32195170727;4616.215243408628;333275;333644;335344;335697;335761;61228.69385653043;61625.69187154035;61662.68361214672;61670.69164654148;61679.6916015426;65012;65042;65064;65167;65178;17660.646787064186;17876.821231787777;17886.910565447088;17901.19444624995;17917.19372628235;11200.831987520194;11968.521259149711;11980.580679676345;11981.341026243466;12055.276683399024;16794.748078778826;18034.046822434764;18975.71536426955;19494.805051949297;19536.218551258076;7069.92930070703;7080.893786593205;7113.3953613943395;7117.3238542338395;7433.368163706037;934.444005816538;952.2810278240023;983.3902980152351;990.8810942686923;1002.4436437777103;31814.681853181173;32584.348313033606;33005.834970824995;35319.64680353215;35540.2674206747;1039.8128336899279;1066.3974854207347;1075.3386667199773;1085.46812062089;1143.6454699043156;16197.41884552527;16953.745693814602;16988.74516882248;17021.48935531936;17232.483025509257;531704;532083;533069;533585;533728;44683.329750053774;56636.15045774317;57895;57899.710501447225;64110;1321.154461144868;1321.5969129415428;1350.4598160735784;1360.9523666671619;1363.849976502584;30239.020569437922;32619.18452038718;32635.673643264214;33116.668833312324;33563.32873342568;54796.17805732997;56290;56340.71829640825;61223.38776612177;61267.38732612617;498458;503513;504240;505121.42317866;506303;42971.35542966796;43307;43818.56181438272;43987.34018989654;44590.554094459934;47351.76324118357;48983;49156;49179.508204917496;49750.75124624499;40824.79587602043;40997.1800563993;41125.383119253835;42600.360994585724;43133.784331078146;40861;41578.598253427415;41702.79148604359;43449.3482597755;44647.06261496448;40773.59226407698;41264.381034283906;41385.1722965533;41656.58343416527;41991.580084198766;34109.48835767515;37099.81450092732;37184.256314874096;37388.43917341297;38119.618803812715;27805.721942780314;28059.719402806528;28101.859490703235;28135.71864281331;28377.43245135127 06:21:34 INFO - PROCESS | 25533 | |2;jquery.html;367.731555964146;399.20757296765913;408.37518596547295;411.9958800411996;425.9126878989807;13199.934000329997;15094.396224151034;18883.339083132094;18906.243750249992;19487.707684384746;19413.90293048533;19736.309229176983;19738.111784969675;19954.401367958984;19961;5384.623076384654;5475.67145971241;5625.465580769831;5854.88290234195;5856.502197313233;5695.857603559903;5735.1970724098655;5774.364819869811;5785.247917770684;5807.0998995155815;5547.389787123413;5653.406392328788;5669.0646043402785;5764.481196692297;5766.394528574502;5650.63270887391;5702.287214098238;5709;5710.1434784782405;5715.885682286352;4902.730349830758;5113.897722045575;5124.436312005676;5153;5154.201098829687;22966.54066918652;22988.965496552697;23080.538389232122;23099.53800923989;23141.537169256688;2298.069281940817;2359.127122964514;2377.405648587853;2627.3694313364845;2965.3328001199775;14465.276736163254;14655.560333190022;14690.338934747962;14785.852141478555;15459.768103478456;1898.2881419467699;1974.427416049344;1995.750531183602;1996.3511858645852;2020.737304150451;87506;89390.553047235;89907;90381.08712062502;91075.08924910732;10723.46382680863;10862.61980830683;10951.616693415692;10959.890401095887;11141.331520108819;15907.840921590636;15919.204039797964;15936.760948585781;15964.680706385807;15989.680206395808;8275.793105172299;8340.624671889658;8364.58177091143;8567.057623661392;8619.353548483889;7945.562994035268;7990.84018319642;8263.710770123016;8378.916210837935;8396;4687.531246875285;4757.286407038971;4766.833160839354;4801.807927682923;4910.729909854921;1973.7434133562833;1992.9601407971759;2033.6542787726123;2072.8859912704643;2076.9480762981048;835.6824406725527;928.4754113925745;979.2313034268208;991.548845275398;1008.8988262712052;19100.808991909904;19596;19706.113224904915;19731.802681973284;20086.59826803485;943.9197668198143;951.5765484359393;958.1281034258791;972.5769290358717;991.3159919655415;10218.744531386626;10823.404712740874;10968.23222374442;11058.447077646086;11065.50205240766;501635;507203;513195;517624;523184;89967.65048524278;90871;93366.53316733374;97192;97328;952.3476418653245;987.225028352754;1000.7047920863363;1004.5881188712593;1004.8693669822876;16331.59171020734;16542.83457165413;17055.232514536627;17378.52282555997;17597.984574396236;41185.1762964745;41249;42019.1596168081;42202.577974219865;43018.78490607527;58137.4186258132;58805.70597146987;59025.40974590199;60034.39965600288;60836;8184.672613095648;8280.337572994267;8371.786091016647;8376.916230837614;8418.536980466133;11517.424128793695;12871.485140594647;13138.474461021835;13249.602511924657;13493.122947008413;10908.400037997986;11147.498362573866;11208.719782005515;11490.48292826808;11567.652970410902;10513.211509136998;10795.244332896937;11412.087033037504;11450.885491144982;11519.25124866881;10732.51703673321;10893.128549715846;10991.175661825235;11039.448027598748;11227.157963152633;7426.034615499951;7788.299053085249;8527.403081784216;8549.059603443491;8956.910430895608;10503;10901.127909767041;10916.890831091587;11021.614243501439;11625.88374116282 06:21:34 INFO - PROCESS | 25533 | |3;mootools.html;1248.138784238875;1301.8502872169697;1309.3715016791946;1364.1269587464026;1656.2215758593463;6915.827104322394;7430.702771889125;7717.305442510173;7726.536407815528;7892.526448413099;7777.105632852224;7817.374610031198;7831.060272767261;7831.843363132734;7851.92148078519;2232.5423288225916;2251.0658076898067;2252.087904398721;2252.8648281103187;2260.0959616153505;2199.670049492573;2251.0658076898067;2260.672202530632;2263.9320820375415;2264.30938563738;2210.3037543173928;2227.7883601057874;2236.552689462106;2248.921287754929;2280.372897453197;2164.6644770060666;2187.748408932969;2190.7480639726477;2190.9014094365793;2197.055266235518;2141.1649456711893;2143.485563464773;2150.0969592771075;2150.473134082144;2152.13914434226;7799.844003119906;7801.921980780176;7854.175311592315;7969.442139050268;8274.627641756075;4917.336159618477;5018.422881368653;5023.824166154203;5030.320906677588;5032.094223039851;3066.7242844863995;3227.273863380744;3229.531717900915;3230.224746060952;3270.8201048942296;1054.609794376078;1054.783769327286;1064.4092528646597;1071.9678409647645;1076.6178006807627;10415.427151506665;10479.895201048044;10502.422366769824;10530.84203736937;10553;4040.777757223322;4150.232207041707;4273.91452170961;4274.5939135782055;4303.892402689958;8517.659293628185;8537.573121343908;8550.78623034429;8555.828883422297;8563.700270490503;4897.730624815598;4901.926471102936;4902.240152776325;4903.53416425439;4908.533689299511;4066.6949978751713;4189.832406703758;4492.9550704493195;4610.423697037871;4611.077784443125;3429.9485507717404;3497.9125521862156;3501.072215862798;3524.488949102366;3576.46353047045;1062.2033474893828;1091.399730148431;1092.421016861049;1104.7900898829196;1110.5502271580024;915.5056269614466;918.779492921694;949.3876449690049;953.50894289441;966.3477152921749;5189.455107213688;5420;5593.272874526286;5691.089425691869;5707.800226992035;918.5407296351824;935.7192842147465;937.315759495572;938.5541867612966;953.6900507335143;3604.6575575320303;3624.6012938576737;3637.3452778500123;3789.3558095123894;3871.7289789715014;9418.90581094194;9632.518374081268;9712.902870971342;9714.12572868431;9776.511174441392;9252.306077044248;9661.565229564687;9701.399269120517;9702.466364349888;9705.466199359103;7204.639768011579;7385.556866588022;7388.667509962064;7431.219721929336;7533.171351151369;5489.917651235314;5505.284313039279;5586.7306472082055;5741.5119714824705;5751.367349591458;8793.428427152214;9026.503542304974;9039.367244292836;9196.678116265899;9255.722328330161;8918.955405222932;9130.908690913006;9170.312226582899;9292.163705266288;9302.255819534286;6066.666333351708;6085.878282434238;6195.876082478415;7048;7189.712411503481;7515.023047003854;7715.498492597963;7718.729844455417;7725.304722574995;7726.729564465217;6905.309469053054;7037;7088.043114179726;7092.468064895051;7193.208747037717;6757.222919364336;6880.965595171992;6898.586084834926;6957.339052789976;6966;6367.076773867856;6409.615423074631;6427.58220715652;6496.935030649633;6563.671816409256;4579.129965306581;4642.2108241598335;4720.858374248778;4757.167495688172;4868.026394721141;4499.595036446735;4511.09778044399;4610.193216187086;4670.486246512949;4731.810727570859 06:21:34 INFO - PROCESS | 25533 | |4;prototype.html;329.38569567756133;335.1888429999401;340.70188584988125;352.7090150625734;352.89589571076544;5241.091194387113;5255.658382205159;5282.20766884967;5302.814401495939;5317.548008419289;5190.480951904817;5216.217567364897;5251.947480525194;5252.711100889459;5273.393559740631;4072.1448495815766;4150.190712811003;4163.2298024865495;4171.916561668765;4189.036521600034;4165.708400411957;4173.457450531427;4209.410682504452;4217.768022758747;4224.894377640569;4113.444684967536;4123.9381409278885;4128.752274863503;4132.628063474287;4135.834566617332;3946.4277679736565;4004.9199016019516;4051.696122790773;4106.568810274908;4154.875353739378;3642.3625865473437;3658.506101676266;3659.79871107089;3665.688416484602;3671.3391589513876;5076.035553244872;5099.4900509949075;5108.233764935252;5114.667546609458;5220.399654039796;4396.846110386153;4427.645788336926;4705.435347758256;4710.929336059962;4757.738324392157;5442.673439593637;5452.182172674131;5464.316960379952;5473.616846820724;5475.123980163155;4056.0468289951837;4067.3288907330257;4070.61329173728;4086.1214838809797;4086.7139300248996;5428.665673760282;5671.829845104653;5682.17608446777;5726.141078838207;5763.4812866842185;4031.1053804711737;4050.716449848482;4062.1266427718183;4079.8572049978106;4102.99476628228;4118.9588104119175;4145;4159.04524873309;4165.8958526037095;4171.666266698657;4403.625691816167;4722.787474563653;4730.62155027597;4751.097291514601;4751.976240118846;5474.7810087596845;5483.040467918098;5499.340079190522;5520.3651580068;5529.654558991832;1380.9309534523234;1395.1698739250332;1398.5175114585452;1414.7453458377386;1417.893657975656;848.6350869126212;917.866909298148;931.8835145606799;939.5771902643837;945.2674177512346;4659.4175728034;4698.8355407560575;4708.317293992352;4718.787654555554;4748.050389922029;4866.975665121722;4878;4917.336159618406;4943.382077240345;4958.231474121517;4678.8596342109795;4691.460482044608;4713.481517033124;4720.716756994591;4970.329005584272;2943.705629437039;2967.5548667699586;2977.76177905767;2986.283292009902;2996.6553846307515;5808.506276966421;5825.854353641193;5840.649561026352;5857.619254748428;5861.384554621789;5486.478784515464;5730.452777749984;5750.1949727038245;5754.165645981309;5773.307203135567;5724.942750572441;5779.3642699303045;5799.88400231993;5815.94184058154;5823.708814559171;5415.2689386933835;5590.608657393944;5640.689762062962;5644.6330988485615;5668.914966275427;5553.4724201200825;5573.665580065209;5587.385387607279;5595.35653399848;5610.9158362623775;5787.94212057874;5851.61964472308;5854.590178687451;5868.413158684098;5868.882622347614;3901.51231096113;3995.4805875236034;4022.35642297231;4028.3957406389277;4088.855120566246;5524.502794748492;5550.555955523468;5564.916526252028;5604.607677462538;5617.6013511826395;5411.458854114557;5424.945750542602;5485.61600687948;5512;5515;5272.7100009499845;5416.8104116355735;5437.429069947599;5443.510084092451;5465.180222966586;5381;5383;5430.619856609999;5431.9185212221055;5441.211024401518;5257.63196576236;5364.678119312854;5391.649542779864;5517.834464966058;5534.308211473566;5406.567474602101;5418.805383819559;5424.783008679767;5433.972830135982;5434.2392065110125 06:21:34 INFO - PROCESS | 25533 | |5;yui.html;745.9776206713798;806.4314658165994;833.6373677450309;835.4152093534524;842.3050982939077;15264.694706105885;16405.835941640595;16527;16619.83380166198;16691.83308166918;15318.157501337422;15328.61678458039;15471.45849895254;15476.071435713866;15480;656.2190992718673;798.309462315099;805.1586092533288;805.8267472493412;807.1202389395557;663.9767608133716;796.6773456750026;812.7074253268819;813.4184058398245;823.6540652925786;858.6908712863365;859.1236938322907;860.5998210831962;861.0700443521014;861.3066481482405;691.7060249393987;857.3612658569375;858.1289990659485;860.6385318166385;861.5993562993207;519.2263527344268;599.4395240450193;613.4724137241968;617.1544983372763;621.6549814852755;14365.209913454755;14449.060811047248;14480.565583032527;14502.05736627116;14522.419103235858;13324.333783310796;13902.51341203053;14162.36269367881;14189.219592922385;14487;12400.441980110916;12437.62687119388;12526.74946501074;12575.559855405018;13013.284269365182;4249.405083288342;4278.807453664593;4280.486341638992;4498.8875278117985;4517.299818528133;75910.62044689797;76144.61927690382;78116.99999999943;78859.6057019717;80687.59656201681;11104.722381940515;11499.712507187387;11502.252353596989;11597.710057248467;12169.330686812133;21809;22022.669659955114;22043.11827526913;22043.228487002878;22066.558668826856;8023.6790528378215;8075.717349892726;8230.753077407568;8355;8368.916310836814;4500.504944456107;4640.582347588733;4658.534146585314;4661.207594708908;4682.859514214579;3510.859565617398;3677.5770786359376;3698.537682789651;3700.6854417374825;3709.9797555672408;611.3153268339488;630.6247782569363;633.4109278371159;634.8285962790021;640.2604991235131;567.494929512734;621.316551793024;748.0900883024153;761.6572542355962;767.0833354141747;9395.671151509665;9819.705408837746;9943.651972181084;10033.197344212445;10342.689719308433;626.37675512865;684.4079870911626;708.8496850937788;743.4238465189521;747.1445195251515;4888.535589119028;4961;4962.826301079445;5002.774875130628;5011.799528018912;69393.65303173452;69907;70139.64930175418;94059;124549;59959.40040599625;60105;60986;107091.39362909406;109092;92348;97223.51388243014;98751.50624246977;100660;101666;9251.583678734338;9482;9526;9563.856542152012;9665.806683866424;52372;54134;55378.72310638421;55539;56147.719261405065;73295;74809.25190748023;81121.59439202766;82352;83742.16257837343;13173;13201.20792752438;13218.669533261746;13304.334783260992;13738.86261137376;14487;15054.473093442115;15208.847911521187;15373.923130384277;15687.686246274783;14011.229382384066;14116.435342586181;14288;14725.116493010453;14738.63153421173;13939.651508712363;14129.222892740998;14215.857841421453;14264.286785660883;14469.49356772508;12886.162399444007;13089.672758181121;13437.596872093853;13636.590902272948;13897.652558686113;11061.778764424505;11062.502187401426;11110.388928609003;11548.48031838586;11551.595694150665;11896.345700986529;12006.39968001579;12097.69755756078;12287.877121228674;12439.378031098227 06:21:34 INFO - PROCESS | 25533 | __end_tp_report 06:21:34 INFO - PROCESS | 25533 | __start_cc_report 06:21:34 INFO - PROCESS | 25533 | _x_x_mozilla_cycle_collect,1361 06:21:34 INFO - PROCESS | 25533 | __end_cc_report 06:21:34 INFO - PROCESS | 25533 | __startTimestamp1476278494060__endTimestamp 06:21:34 INFO - PROCESS | 25533 | 06:21:34 INFO - PROCESS | 25533 | ------- Summary: start ------- 06:21:34 INFO - PROCESS | 25533 | Number of tests: 6 06:21:34 INFO - PROCESS | 25533 | 06:21:34 INFO - PROCESS | 25533 | [#0] dojo.html Cycles:165 Average:5111.90 Median:5320.89 stddev:584.23 (11.0%) stddev-sans-first:559.70 06:21:34 INFO - PROCESS | 25533 | Values: 2901.9 2940.5 2942.4 2959.9 3001.2 5040.5 5057.1 5119.6 5144.3 5202.5 5145.8 5149.5 5197.8 5214.3 5238.4 4611.5 4625.7 4688.5 4689.2 4717.0 4192.5 4674.1 4716.5 4722.7 4777.3 4568.7 4680.4 4681.3 4693.4 4796.1 4601.3 4666.4 4667.0 4668.8 4675.5 4632.4 4636.4 4639.7 4645.2 4648.6 5049.5 5059.2 5091.6 5094.4 5125.8 5446.8 5452.4 5453.9 5454.1 5458.6 5469.6 5472.3 5492.9 5493.5 5498.5 5099.5 5108.1 5131.6 5133.6 5135.2 5598.1 5606.8 5608.5 5608.6 5660.6 5387.8 5399.6 5403.5 5403.7 5457.1 5341.1 5381.8 5385.9 5440.8 5461.7 5463.7 5494.2 5500.9 5542.8 5571.9 5520.2 5521.4 5521.8 5523.6 5565.1 4165.8 4204.7 4272.7 4274.3 4332.5 3751.7 3782.3 3794.1 3800.7 3845.5 5228.2 5237.8 5253.1 5254.1 5307.5 5509.2 5514.4 5522.2 5522.8 5525.3 5120.5 5160.7 5219.3 5230.9 5266.3 4795.5 4803.5 4808.5 4831.2 4857.0 5740.0 5751.8 5762.5 5763.1 5768.5 5361.1 5408.6 5416.5 5499.0 5554.6 5743.9 5765.5 5796.8 5799.7 5801.8 5384.8 5394.5 5432.8 5452.7 5515.1 5480.7 5493.1 5508.2 5570.3 5625.2 5268.6 5278.7 5333.1 5400.8 5434.7 5320.9 5343.6 5361.8 5376.2 5379.2 5314.2 5316.1 5358.0 5368.1 5372.3 5453.2 5459.0 5464.4 5472.0 5517.9 5137.3 5182.7 5225.1 5327.2 5350.2 06:21:34 INFO - PROCESS | 25533 | 06:21:34 INFO - PROCESS | 25533 | [#1] ext.html Cycles:180 Average:62642.34 Median:41847.19 stddev:123388.97 (294.9%) stddev-sans-first:123647.02 06:21:34 INFO - PROCESS | 25533 | Values: 544.0 599.3 604.5 614.4 619.3 31658.4 43096.4 43290.6 43371.0 43375.0 45910.3 46217.9 46385.3 46413.0 46414.5 8042.4 8890.0 9049.1 9049.4 9049.9 8170.9 8247.4 8249.3 10562.8 10811.5 10960.3 11042.7 11046.4 11053.3 11068.4 10731.2 10760.4 10805.0 10816.4 10819.9 7982.3 8144.9 8145.2 8394.3 10235.5 40119.8 42706.6 43464.6 43520.8 43544.8 3306.3 3369.3 3431.1 3558.6 3756.2 29367.4 31342.8 32000.2 32070.2 32119.5 4262.1 4461.2 4469.8 4520.3 4616.2 333275.0 333644.0 335344.0 335697.0 335761.0 61228.7 61625.7 61662.7 61670.7 61679.7 65012.0 65042.0 65064.0 65167.0 65178.0 17660.6 17876.8 17886.9 17901.2 17917.2 11200.8 11968.5 11980.6 11981.3 12055.3 16794.7 18034.0 18975.7 19494.8 19536.2 7069.9 7080.9 7113.4 7117.3 7433.4 934.4 952.3 983.4 990.9 1002.4 31814.7 32584.3 33005.8 35319.6 35540.3 1039.8 1066.4 1075.3 1085.5 1143.6 16197.4 16953.7 16988.7 17021.5 17232.5 531704.0 532083.0 533069.0 533585.0 533728.0 44683.3 56636.2 57895.0 57899.7 64110.0 1321.2 1321.6 1350.5 1361.0 1363.8 30239.0 32619.2 32635.7 33116.7 33563.3 54796.2 56290.0 56340.7 61223.4 61267.4 498458.0 503513.0 504240.0 505121.4 506303.0 42971.4 43307.0 43818.6 43987.3 44590.6 47351.8 48983.0 49156.0 49179.5 49750.8 40824.8 40997.2 41125.4 42600.4 43133.8 40861.0 41578.6 41702.8 43449.3 44647.1 40773.6 41264.4 41385.2 41656.6 41991.6 34109.5 37099.8 37184.3 37388.4 38119.6 27805.7 28059.7 28101.9 28135.7 28377.4 06:21:34 INFO - PROCESS | 25533 | 06:21:34 INFO - PROCESS | 25533 | [#2] jquery.html Cycles:180 Average:29979.27 Median:403.79 stddev:84609.86 (20953.9%) stddev-sans-first:84817.99 06:21:34 INFO - PROCESS | 25533 | Values: 367.7 399.2 408.4 412.0 425.9 13199.9 15094.4 18883.3 18906.2 19487.7 19413.9 19736.3 19738.1 19954.4 19961.0 5384.6 5475.7 5625.5 5854.9 5856.5 5695.9 5735.2 5774.4 5785.2 5807.1 5547.4 5653.4 5669.1 5764.5 5766.4 5650.6 5702.3 5709.0 5710.1 5715.9 4902.7 5113.9 5124.4 5153.0 5154.2 22966.5 22989.0 23080.5 23099.5 23141.5 2298.1 2359.1 2377.4 2627.4 2965.3 14465.3 14655.6 14690.3 14785.9 15459.8 1898.3 1974.4 1995.8 1996.4 2020.7 87506.0 89390.6 89907.0 90381.1 91075.1 10723.5 10862.6 10951.6 10959.9 11141.3 15907.8 15919.2 15936.8 15964.7 15989.7 8275.8 8340.6 8364.6 8567.1 8619.4 7945.6 7990.8 8263.7 8378.9 8396.0 4687.5 4757.3 4766.8 4801.8 4910.7 1973.7 1993.0 2033.7 2072.9 2076.9 835.7 928.5 979.2 991.5 1008.9 19100.8 19596.0 19706.1 19731.8 20086.6 943.9 951.6 958.1 972.6 991.3 10218.7 10823.4 10968.2 11058.4 11065.5 501635.0 507203.0 513195.0 517624.0 523184.0 89967.7 90871.0 93366.5 97192.0 97328.0 952.3 987.2 1000.7 1004.6 1004.9 16331.6 16542.8 17055.2 17378.5 17598.0 41185.2 41249.0 42019.2 42202.6 43018.8 58137.4 58805.7 59025.4 60034.4 60836.0 8184.7 8280.3 8371.8 8376.9 8418.5 11517.4 12871.5 13138.5 13249.6 13493.1 10908.4 11147.5 11208.7 11490.5 11567.7 10513.2 10795.2 11412.1 11450.9 11519.3 10732.5 10893.1 10991.2 11039.4 11227.2 7426.0 7788.3 8527.4 8549.1 8956.9 10503.0 10901.1 10916.9 11021.6 11625.9 06:21:34 INFO - PROCESS | 25533 | 06:21:34 INFO - PROCESS | 25533 | [#3] mootools.html Cycles:180 Average:5213.26 Median:5304.73 stddev:2852.98 (53.8%) stddev-sans-first:2845.41 06:21:34 INFO - PROCESS | 25533 | Values: 1248.1 1301.9 1309.4 1364.1 1656.2 6915.8 7430.7 7717.3 7726.5 7892.5 7777.1 7817.4 7831.1 7831.8 7851.9 2232.5 2251.1 2252.1 2252.9 2260.1 2199.7 2251.1 2260.7 2263.9 2264.3 2210.3 2227.8 2236.6 2248.9 2280.4 2164.7 2187.7 2190.7 2190.9 2197.1 2141.2 2143.5 2150.1 2150.5 2152.1 7799.8 7801.9 7854.2 7969.4 8274.6 4917.3 5018.4 5023.8 5030.3 5032.1 3066.7 3227.3 3229.5 3230.2 3270.8 1054.6 1054.8 1064.4 1072.0 1076.6 10415.4 10479.9 10502.4 10530.8 10553.0 4040.8 4150.2 4273.9 4274.6 4303.9 8517.7 8537.6 8550.8 8555.8 8563.7 4897.7 4901.9 4902.2 4903.5 4908.5 4066.7 4189.8 4493.0 4610.4 4611.1 3429.9 3497.9 3501.1 3524.5 3576.5 1062.2 1091.4 1092.4 1104.8 1110.6 915.5 918.8 949.4 953.5 966.3 5189.5 5420.0 5593.3 5691.1 5707.8 918.5 935.7 937.3 938.6 953.7 3604.7 3624.6 3637.3 3789.4 3871.7 9418.9 9632.5 9712.9 9714.1 9776.5 9252.3 9661.6 9701.4 9702.5 9705.5 7204.6 7385.6 7388.7 7431.2 7533.2 5489.9 5505.3 5586.7 5741.5 5751.4 8793.4 9026.5 9039.4 9196.7 9255.7 8919.0 9130.9 9170.3 9292.2 9302.3 6066.7 6085.9 6195.9 7048.0 7189.7 7515.0 7715.5 7718.7 7725.3 7726.7 6905.3 7037.0 7088.0 7092.5 7193.2 6757.2 6881.0 6898.6 6957.3 6966.0 6367.1 6409.6 6427.6 6496.9 6563.7 4579.1 4642.2 4720.9 4757.2 4868.0 4499.6 4511.1 4610.2 4670.5 4731.8 06:21:34 INFO - PROCESS | 25533 | 06:21:34 INFO - PROCESS | 25533 | [#4] prototype.html Cycles:180 Average:4585.35 Median:5218.31 stddev:1332.28 (25.5%) stddev-sans-first:1297.16 06:21:34 INFO - PROCESS | 25533 | Values: 329.4 335.2 340.7 352.7 352.9 5241.1 5255.7 5282.2 5302.8 5317.5 5190.5 5216.2 5251.9 5252.7 5273.4 4072.1 4150.2 4163.2 4171.9 4189.0 4165.7 4173.5 4209.4 4217.8 4224.9 4113.4 4123.9 4128.8 4132.6 4135.8 3946.4 4004.9 4051.7 4106.6 4154.9 3642.4 3658.5 3659.8 3665.7 3671.3 5076.0 5099.5 5108.2 5114.7 5220.4 4396.8 4427.6 4705.4 4710.9 4757.7 5442.7 5452.2 5464.3 5473.6 5475.1 4056.0 4067.3 4070.6 4086.1 4086.7 5428.7 5671.8 5682.2 5726.1 5763.5 4031.1 4050.7 4062.1 4079.9 4103.0 4119.0 4145.0 4159.0 4165.9 4171.7 4403.6 4722.8 4730.6 4751.1 4752.0 5474.8 5483.0 5499.3 5520.4 5529.7 1380.9 1395.2 1398.5 1414.7 1417.9 848.6 917.9 931.9 939.6 945.3 4659.4 4698.8 4708.3 4718.8 4748.1 4867.0 4878.0 4917.3 4943.4 4958.2 4678.9 4691.5 4713.5 4720.7 4970.3 2943.7 2967.6 2977.8 2986.3 2996.7 5808.5 5825.9 5840.6 5857.6 5861.4 5486.5 5730.5 5750.2 5754.2 5773.3 5724.9 5779.4 5799.9 5815.9 5823.7 5415.3 5590.6 5640.7 5644.6 5668.9 5553.5 5573.7 5587.4 5595.4 5610.9 5787.9 5851.6 5854.6 5868.4 5868.9 3901.5 3995.5 4022.4 4028.4 4088.9 5524.5 5550.6 5564.9 5604.6 5617.6 5411.5 5424.9 5485.6 5512.0 5515.0 5272.7 5416.8 5437.4 5443.5 5465.2 5381.0 5383.0 5430.6 5431.9 5441.2 5257.6 5364.7 5391.6 5517.8 5534.3 5406.6 5418.8 5424.8 5434.0 5434.2 06:21:34 INFO - PROCESS | 25533 | 06:21:34 INFO - PROCESS | 25533 | [#5] yui.html Cycles:180 Average:20195.69 Median:4672.03 stddev:28091.49 (601.3%) stddev-sans-first:28132.33 06:21:34 INFO - PROCESS | 25533 | Values: 746.0 806.4 833.6 835.4 842.3 15264.7 16405.8 16527.0 16619.8 16691.8 15318.2 15328.6 15471.5 15476.1 15480.0 656.2 798.3 805.2 805.8 807.1 664.0 796.7 812.7 813.4 823.7 858.7 859.1 860.6 861.1 861.3 691.7 857.4 858.1 860.6 861.6 519.2 599.4 613.5 617.2 621.7 14365.2 14449.1 14480.6 14502.1 14522.4 13324.3 13902.5 14162.4 14189.2 14487.0 12400.4 12437.6 12526.7 12575.6 13013.3 4249.4 4278.8 4280.5 4498.9 4517.3 75910.6 76144.6 78117.0 78859.6 80687.6 11104.7 11499.7 11502.3 11597.7 12169.3 21809.0 22022.7 22043.1 22043.2 22066.6 8023.7 8075.7 8230.8 8355.0 8368.9 4500.5 4640.6 4658.5 4661.2 4682.9 3510.9 3677.6 3698.5 3700.7 3710.0 611.3 630.6 633.4 634.8 640.3 567.5 621.3 748.1 761.7 767.1 9395.7 9819.7 9943.7 10033.2 10342.7 626.4 684.4 708.8 743.4 747.1 4888.5 4961.0 4962.8 5002.8 5011.8 69393.7 69907.0 70139.6 94059.0 124549.0 59959.4 60105.0 60986.0 107091.4 109092.0 92348.0 97223.5 98751.5 100660.0 101666.0 9251.6 9482.0 9526.0 9563.9 9665.8 52372.0 54134.0 55378.7 55539.0 56147.7 73295.0 74809.3 81121.6 82352.0 83742.2 13173.0 13201.2 13218.7 13304.3 13738.9 14487.0 15054.5 15208.8 15373.9 15687.7 14011.2 14116.4 14288.0 14725.1 14738.6 13939.7 14129.2 14215.9 14264.3 14469.5 12886.2 13089.7 13437.6 13636.6 13897.7 11061.8 11062.5 11110.4 11548.5 11551.6 11896.3 12006.4 12097.7 12287.9 12439.4 06:21:34 INFO - PROCESS | 25533 | -------- Summary: end -------- 06:21:34 INFO - PROCESS | 25533 | 06:21:35 INFO - TEST-INFO | 25533: exit 0 06:21:35 INFO - TEST-OK | dromaeo_css | took 1118396ms 06:21:35 INFO - TEST-START | kraken 06:21:35 INFO - operating with platform_type : linux_ 06:21:35 INFO - Initialising browser for kraken test... 06:21:35 INFO - TEST-INFO | started process 25841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdwzCxi/profile http://localhost:38955/getInfo.html) 06:21:39 INFO - PROCESS | 25841 | __metrics Screen width/height:1600/1200 06:21:39 INFO - PROCESS | 25841 | colorDepth:24 06:21:39 INFO - PROCESS | 25841 | Browser inner width/height: 1024/697 06:21:39 INFO - PROCESS | 25841 | __metrics 06:21:40 INFO - PROCESS | 25841 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:21:40 INFO - PROCESS | 25841 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:21:40 INFO - PROCESS | 25841 | console.error: PushService: 06:21:40 INFO - PROCESS | 25841 | stateChangeProcessEnqueue: Error transitioning state 06:21:40 INFO - PROCESS | 25841 | UnknownError 06:21:41 INFO - TEST-INFO | 25841: exit 0 06:21:41 INFO - Browser initialized. 06:21:41 INFO - Running cycle 1/1 for kraken test... 06:21:41 INFO - TEST-INFO | started process 25926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdwzCxi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:21:53 INFO - PROCESS | 25926 | RSS: Main: 176566272 06:21:53 INFO - PROCESS | 25926 | 06:21:55 INFO - PROCESS | 25926 | Cycle 1(1): loaded http://localhost:38955/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38955/tests/kraken/driver.html?testName=audio-beat-detection) 06:21:56 INFO - PROCESS | 25926 | RSS: Main: 236597248 06:21:56 INFO - PROCESS | 25926 | 06:21:59 INFO - PROCESS | 25926 | Cycle 1(1): loaded http://localhost:38955/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38955/tests/kraken/driver.html?testName=audio-dft) 06:22:00 INFO - PROCESS | 25926 | RSS: Main: 221605888 06:22:00 INFO - PROCESS | 25926 | 06:22:03 INFO - PROCESS | 25926 | Cycle 1(1): loaded http://localhost:38955/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38955/tests/kraken/driver.html?testName=audio-fft) 06:22:03 INFO - PROCESS | 25926 | RSS: Main: 302632960 06:22:03 INFO - PROCESS | 25926 | 06:22:05 INFO - PROCESS | 25926 | Cycle 1(1): loaded http://localhost:38955/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38955/tests/kraken/driver.html?testName=audio-oscillator) 06:22:06 INFO - PROCESS | 25926 | RSS: Main: 211197952 06:22:06 INFO - PROCESS | 25926 | 06:22:08 INFO - PROCESS | 25926 | Cycle 1(1): loaded http://localhost:38955/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38955/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:22:09 INFO - PROCESS | 25926 | RSS: Main: 217055232 06:22:09 INFO - PROCESS | 25926 | 06:22:12 INFO - PROCESS | 25926 | Cycle 1(1): loaded http://localhost:38955/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38955/tests/kraken/driver.html?testName=imaging-darkroom) 06:22:12 INFO - PROCESS | 25926 | RSS: Main: 253173760 06:22:12 INFO - PROCESS | 25926 | 06:22:16 INFO - PROCESS | 25926 | Cycle 1(1): loaded http://localhost:38955/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38955/tests/kraken/driver.html?testName=imaging-desaturate) 06:22:16 INFO - PROCESS | 25926 | RSS: Main: 252473344 06:22:16 INFO - PROCESS | 25926 | 06:22:19 INFO - PROCESS | 25926 | Cycle 1(1): loaded http://localhost:38955/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38955/tests/kraken/driver.html?testName=json-parse-financial) 06:22:20 INFO - PROCESS | 25926 | RSS: Main: 251969536 06:22:20 INFO - PROCESS | 25926 | 06:22:21 INFO - PROCESS | 25926 | Cycle 1(1): loaded http://localhost:38955/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38955/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:22:22 INFO - PROCESS | 25926 | RSS: Main: 214351872 06:22:22 INFO - PROCESS | 25926 | 06:22:23 INFO - PROCESS | 25926 | Cycle 1(1): loaded http://localhost:38955/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38955/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:22:24 INFO - PROCESS | 25926 | RSS: Main: 222474240 06:22:24 INFO - PROCESS | 25926 | 06:22:26 INFO - PROCESS | 25926 | Cycle 1(1): loaded http://localhost:38955/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38955/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:22:27 INFO - PROCESS | 25926 | RSS: Main: 226988032 06:22:27 INFO - PROCESS | 25926 | 06:22:29 INFO - PROCESS | 25926 | Cycle 1(1): loaded http://localhost:38955/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38955/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:22:30 INFO - PROCESS | 25926 | RSS: Main: 235933696 06:22:30 INFO - PROCESS | 25926 | 06:22:33 INFO - PROCESS | 25926 | Cycle 1(1): loaded http://localhost:38955/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38955/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:22:34 INFO - PROCESS | 25926 | RSS: Main: 232529920 06:22:34 INFO - PROCESS | 25926 | 06:22:35 INFO - PROCESS | 25926 | Cycle 1(1): loaded http://localhost:38955/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38955/tests/kraken/driver.html?testName=ai-astar) 06:22:36 INFO - PROCESS | 25926 | RSS: Main: 283521024 06:22:36 INFO - PROCESS | 25926 | 06:22:36 INFO - PROCESS | 25926 | __start_tp_report 06:22:36 INFO - PROCESS | 25926 | _x_x_mozilla_page_load 06:22:36 INFO - PROCESS | 25926 | _x_x_mozilla_page_load_details 06:22:36 INFO - PROCESS | 25926 | |i|pagename|runs| 06:22:36 INFO - PROCESS | 25926 | |0;ai-astar;112;110;110;112;114;112;112;112;112;112 06:22:36 INFO - PROCESS | 25926 | |1;audio-beat-detection;152;128;120;162;133;124;123;124;161;121 06:22:36 INFO - PROCESS | 25926 | |2;audio-dft;160;160;161;161;161;162;162;163;161;162 06:22:36 INFO - PROCESS | 25926 | |3;audio-fft;77;80;76;109;77;75;76;77;105;76 06:22:36 INFO - PROCESS | 25926 | |4;audio-oscillator;82;82;115;81;82;82;101;81;82;117 06:22:36 INFO - PROCESS | 25926 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;116;116 06:22:36 INFO - PROCESS | 25926 | |6;imaging-darkroom;145;145;146;145;145;146;146;145;145;147 06:22:36 INFO - PROCESS | 25926 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 06:22:36 INFO - PROCESS | 25926 | |8;json-parse-financial;52;52;51;50;51;53;53;54;51;52 06:22:36 INFO - PROCESS | 25926 | |9;json-stringify-tinderbox;60;61;60;61;61;61;61;61;61;61 06:22:36 INFO - PROCESS | 25926 | |10;stanford-crypto-aes;80;79;81;80;79;84;79;79;87;79 06:22:36 INFO - PROCESS | 25926 | |11;stanford-crypto-ccm;147;131;131;132;143;138;128;143;173;144 06:22:36 INFO - PROCESS | 25926 | |12;stanford-crypto-pbkdf2;172;166;173;167;172;168;168;168;169;170 06:22:36 INFO - PROCESS | 25926 | |13;stanford-crypto-sha256-iterative;66;65;67;65;65;64;66;65;64;64 06:22:36 INFO - PROCESS | 25926 | __end_tp_report 06:22:36 INFO - PROCESS | 25926 | __start_cc_report 06:22:36 INFO - PROCESS | 25926 | _x_x_mozilla_cycle_collect,1710 06:22:36 INFO - PROCESS | 25926 | __end_cc_report 06:22:36 INFO - PROCESS | 25926 | __startTimestamp1476278556041__endTimestamp 06:22:36 INFO - PROCESS | 25926 | 06:22:36 INFO - PROCESS | 25926 | ------- Summary: start ------- 06:22:36 INFO - PROCESS | 25926 | Number of tests: 14 06:22:36 INFO - PROCESS | 25926 | 06:22:36 INFO - PROCESS | 25926 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:1.14 (1.0%) stddev-sans-first:1.20 06:22:36 INFO - PROCESS | 25926 | Values: 112.0 110.0 110.0 112.0 114.0 112.0 112.0 112.0 112.0 112.0 06:22:36 INFO - PROCESS | 25926 | 06:22:36 INFO - PROCESS | 25926 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:130.50 stddev:16.84 (12.9%) stddev-sans-first:16.68 06:22:36 INFO - PROCESS | 25926 | Values: 152.0 128.0 120.0 162.0 133.0 124.0 123.0 124.0 161.0 121.0 06:22:36 INFO - PROCESS | 25926 | 06:22:36 INFO - PROCESS | 25926 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 06:22:36 INFO - PROCESS | 25926 | Values: 160.0 160.0 161.0 161.0 161.0 162.0 162.0 163.0 161.0 162.0 06:22:36 INFO - PROCESS | 25926 | 06:22:36 INFO - PROCESS | 25926 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.50 stddev:12.86 (16.8%) stddev-sans-first:13.46 06:22:36 INFO - PROCESS | 25926 | Values: 77.0 80.0 76.0 109.0 77.0 75.0 76.0 77.0 105.0 76.0 06:22:36 INFO - PROCESS | 25926 | 06:22:36 INFO - PROCESS | 25926 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:82.00 stddev:14.74 (18.0%) stddev-sans-first:15.31 06:22:36 INFO - PROCESS | 25926 | Values: 82.0 82.0 115.0 81.0 82.0 82.0 101.0 81.0 82.0 117.0 06:22:36 INFO - PROCESS | 25926 | 06:22:36 INFO - PROCESS | 25926 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:22:36 INFO - PROCESS | 25926 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 06:22:36 INFO - PROCESS | 25926 | 06:22:36 INFO - PROCESS | 25926 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 06:22:36 INFO - PROCESS | 25926 | Values: 145.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 145.0 147.0 06:22:36 INFO - PROCESS | 25926 | 06:22:36 INFO - PROCESS | 25926 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:22:36 INFO - PROCESS | 25926 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 06:22:36 INFO - PROCESS | 25926 | 06:22:36 INFO - PROCESS | 25926 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:1.20 (2.3%) stddev-sans-first:1.27 06:22:36 INFO - PROCESS | 25926 | Values: 52.0 52.0 51.0 50.0 51.0 53.0 53.0 54.0 51.0 52.0 06:22:36 INFO - PROCESS | 25926 | 06:22:36 INFO - PROCESS | 25926 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 06:22:36 INFO - PROCESS | 25926 | Values: 60.0 61.0 60.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 06:22:36 INFO - PROCESS | 25926 | 06:22:36 INFO - PROCESS | 25926 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:2.71 (3.4%) stddev-sans-first:2.86 06:22:36 INFO - PROCESS | 25926 | Values: 80.0 79.0 81.0 80.0 79.0 84.0 79.0 79.0 87.0 79.0 06:22:36 INFO - PROCESS | 25926 | 06:22:36 INFO - PROCESS | 25926 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:143.00 stddev:13.06 (9.1%) stddev-sans-first:13.67 06:22:36 INFO - PROCESS | 25926 | Values: 147.0 131.0 131.0 132.0 143.0 138.0 128.0 143.0 173.0 144.0 06:22:36 INFO - PROCESS | 25926 | 06:22:36 INFO - PROCESS | 25926 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:169.50 stddev:2.36 (1.4%) stddev-sans-first:2.29 06:22:36 INFO - PROCESS | 25926 | Values: 172.0 166.0 173.0 167.0 172.0 168.0 168.0 168.0 169.0 170.0 06:22:36 INFO - PROCESS | 25926 | 06:22:36 INFO - PROCESS | 25926 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:0.99 (1.5%) stddev-sans-first:1.00 06:22:36 INFO - PROCESS | 25926 | Values: 66.0 65.0 67.0 65.0 65.0 64.0 66.0 65.0 64.0 64.0 06:22:36 INFO - PROCESS | 25926 | -------- Summary: end -------- 06:22:36 INFO - PROCESS | 25926 | 06:22:37 INFO - TEST-INFO | 25926: exit 0 06:22:37 INFO - TEST-OK | kraken | took 62181ms 06:22:37 INFO - SUITE-END | took 1180s 06:22:37 INFO - Completed test suite (00:19:40) 06:22:37 INFO - javascript benchmark 06:22:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2901.8984335548253, 2940.456015637107, 2942.3968086542272, 2959.911202663921, 3001.159675290918, 5040.4959504049575, 5057.0897238497055, 5119.616028797836, 5144.331236939197, 5202.546812029036, 5145.81989630363, 5149.459306772782, 5197.7920883164625, 5214.296070030545, 5238.423773384925, 4611.538846115378, 4625.699329543586, 4688.484266730657, 4689.226277664198, 4717.033008233321, 4192.4759405074365, 4674.11191873543, 4716.504766999467, 4722.669413141081, 4777.307290442884, 4568.725876447391, 4680.4383473983, 4681.297805329194, 4693.413323334583, 4796.08874313881, 4601.28680054592, 4666.393368862026, 4667.0, 4668.836590719343, 4675.532446755331, 4632.374629425019, 4636.397268355126, 4639.744814035227, 4645.163870503308, 4648.558386953234, 5049.4950504949575, 5059.215821547666, 5091.643584949055, 5094.439611642753, 5125.769340379655, 5446.809361672323, 5452.4274951129955, 5453.918191227135, 5454.072807622674, 5458.645188062763, 5469.644473109235, 5472.315960504937, 5492.890142197173, 5493.450654934514, 5498.477644623755, 5099.5410413063, 5108.106081435771, 5131.563817075553, 5133.640645154841, 5135.178371460548, 5598.10430331145, 5606.775728970877, 5608.523275521627, 5608.635438696553, 5660.603757737002, 5387.81142660005, 5399.595030372738, 5403.5136837684795, 5403.729813509309, 5457.126859702428, 5341.118715411992, 5381.7578208980685, 5385.892282154335, 5440.755166017539, 5461.672299662033, 5463.672179669233, 5494.203340515683, 5500.944990550043, 5542.806001789918, 5571.9442805572235, 5520.171974203821, 5521.3926468088475, 5521.779128834882, 5523.558115350843, 5565.109582466866, 4165.75005499671, 4204.705670603028, 4272.700910936204, 4274.294741367639, 4332.545082766264, 3751.737378383487, 3782.3002744492355, 3794.0894185395305, 3800.6959443244473, 3845.5193100862393, 5228.215767634885, 5237.816676416383, 5253.13323301651, 5254.106801843695, 5307.469253074739, 5509.201165830932, 5514.365847927459, 5522.199281104217, 5522.834314970557, 5525.336959564797, 5120.462351453119, 5160.664556803796, 5219.321488206585, 5230.869228269324, 5266.262723218752, 4795.472498025214, 4803.495632958489, 4808.495108013608, 4831.154547954094, 4857.028594281158, 5740.024195886709, 5751.798687045934, 5762.452567006211, 5763.135529670583, 5768.451997060272, 5361.088614935392, 5408.648437851527, 5416.458354164552, 5499.0, 5554.611177217556, 5743.942560574341, 5765.4811067004175, 5796.768129274782, 5799.710014499174, 5801.796937107181, 5384.838454846361, 5394.541463975606, 5432.8047829477455, 5452.727363631723, 5515.062439385234, 5480.698561579152, 5493.09363954943, 5508.228847961209, 5570.303712035996, 5625.21247025425, 5268.552173065333, 5278.70967096798, 5333.12003519415, 5400.810971615974, 5434.728263586726, 5320.8935821282585, 5343.625946183885, 5361.839144825662, 5376.193570964387, 5379.1662292344745, 5314.22943673173, 5316.122839731555, 5358.0, 5368.141097424394, 5372.328458942632, 5453.2365468833605, 5459.0, 5464.371597266365, 5472.042392581362, 5517.917231241454, 5137.280780690631, 5182.663126896739, 5225.085610018307, 5327.227552005015, 5350.2242174885205], "value": 5072.230689755839, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.9620215606766, 599.3107925885231, 604.4650484321377, 614.4163045107148, 619.3311223878206, 31658.366832663363, 43096.35355469667, 43290.567094329046, 43371.0, 43375.0, 45910.31134532976, 46217.920193591286, 46385.30422043672, 46413.0, 46414.53585464144, 8042.3566114710975, 8889.955550222256, 9049.095090490964, 9049.411788233743, 9049.864252036225, 8170.877436838452, 8247.422680412343, 8249.257566818986, 10562.78874422511, 10811.459427028656, 10960.28758130719, 11042.723931901726, 11046.447677616126, 11053.336799791998, 11068.446577671124, 10731.195160362964, 10760.3543787373, 10804.99999999996, 10816.35101893881, 10819.891801082045, 7982.32150267228, 8144.877826832602, 8145.226203510657, 8394.328453723687, 10235.488225588766, 40119.799401002805, 42706.57293427057, 43464.56535434637, 43520.782396087816, 43544.782276088416, 3306.322203948209, 3369.275605744777, 3431.1079119428878, 3558.5907620623443, 3756.211195648917, 29367.412651747058, 31342.843285783427, 32000.19999500008, 32070.198245043826, 32119.51820722691, 4262.12626411588, 4461.174682683682, 4469.7541635210055, 4520.32195170727, 4616.215243408628, 333275.0, 333644.0, 335344.0, 335697.0, 335761.0, 61228.69385653043, 61625.69187154035, 61662.68361214672, 61670.69164654148, 61679.6916015426, 65012.0, 65042.0, 65064.0, 65167.0, 65178.0, 17660.646787064186, 17876.821231787777, 17886.910565447088, 17901.19444624995, 17917.19372628235, 11200.831987520194, 11968.521259149711, 11980.580679676345, 11981.341026243466, 12055.276683399024, 16794.748078778826, 18034.046822434764, 18975.71536426955, 19494.805051949297, 19536.218551258076, 7069.92930070703, 7080.893786593205, 7113.3953613943395, 7117.3238542338395, 7433.368163706037, 934.444005816538, 952.2810278240023, 983.3902980152351, 990.8810942686923, 1002.4436437777103, 31814.681853181173, 32584.348313033606, 33005.834970824995, 35319.64680353215, 35540.2674206747, 1039.8128336899279, 1066.3974854207347, 1075.3386667199773, 1085.46812062089, 1143.6454699043156, 16197.41884552527, 16953.745693814602, 16988.74516882248, 17021.48935531936, 17232.483025509257, 531704.0, 532083.0, 533069.0, 533585.0, 533728.0, 44683.329750053774, 56636.15045774317, 57895.0, 57899.710501447225, 64110.0, 1321.154461144868, 1321.5969129415428, 1350.4598160735784, 1360.9523666671619, 1363.849976502584, 30239.020569437922, 32619.18452038718, 32635.673643264214, 33116.668833312324, 33563.32873342568, 54796.17805732997, 56290.0, 56340.71829640825, 61223.38776612177, 61267.38732612617, 498458.0, 503513.0, 504240.0, 505121.42317866, 506303.0, 42971.35542966796, 43307.0, 43818.56181438272, 43987.34018989654, 44590.554094459934, 47351.76324118357, 48983.0, 49156.0, 49179.508204917496, 49750.75124624499, 40824.79587602043, 40997.1800563993, 41125.383119253835, 42600.360994585724, 43133.784331078146, 40861.0, 41578.598253427415, 41702.79148604359, 43449.3482597755, 44647.06261496448, 40773.59226407698, 41264.381034283906, 41385.1722965533, 41656.58343416527, 41991.580084198766, 34109.48835767515, 37099.81450092732, 37184.256314874096, 37388.43917341297, 38119.618803812715, 27805.721942780314, 28059.719402806528, 28101.859490703235, 28135.71864281331, 28377.43245135127], "value": 20781.616210673335, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.731555964146, 399.20757296765913, 408.37518596547295, 411.9958800411996, 425.9126878989807, 13199.934000329997, 15094.396224151034, 18883.339083132094, 18906.243750249992, 19487.707684384746, 19413.90293048533, 19736.309229176983, 19738.111784969675, 19954.401367958984, 19961.0, 5384.623076384654, 5475.67145971241, 5625.465580769831, 5854.88290234195, 5856.502197313233, 5695.857603559903, 5735.1970724098655, 5774.364819869811, 5785.247917770684, 5807.0998995155815, 5547.389787123413, 5653.406392328788, 5669.0646043402785, 5764.481196692297, 5766.394528574502, 5650.63270887391, 5702.287214098238, 5709.0, 5710.1434784782405, 5715.885682286352, 4902.730349830758, 5113.897722045575, 5124.436312005676, 5153.0, 5154.201098829687, 22966.54066918652, 22988.965496552697, 23080.538389232122, 23099.53800923989, 23141.537169256688, 2298.069281940817, 2359.127122964514, 2377.405648587853, 2627.3694313364845, 2965.3328001199775, 14465.276736163254, 14655.560333190022, 14690.338934747962, 14785.852141478555, 15459.768103478456, 1898.2881419467699, 1974.427416049344, 1995.750531183602, 1996.3511858645852, 2020.737304150451, 87506.0, 89390.553047235, 89907.0, 90381.08712062502, 91075.08924910732, 10723.46382680863, 10862.61980830683, 10951.616693415692, 10959.890401095887, 11141.331520108819, 15907.840921590636, 15919.204039797964, 15936.760948585781, 15964.680706385807, 15989.680206395808, 8275.793105172299, 8340.624671889658, 8364.58177091143, 8567.057623661392, 8619.353548483889, 7945.562994035268, 7990.84018319642, 8263.710770123016, 8378.916210837935, 8396.0, 4687.531246875285, 4757.286407038971, 4766.833160839354, 4801.807927682923, 4910.729909854921, 1973.7434133562833, 1992.9601407971759, 2033.6542787726123, 2072.8859912704643, 2076.9480762981048, 835.6824406725527, 928.4754113925745, 979.2313034268208, 991.548845275398, 1008.8988262712052, 19100.808991909904, 19596.0, 19706.113224904915, 19731.802681973284, 20086.59826803485, 943.9197668198143, 951.5765484359393, 958.1281034258791, 972.5769290358717, 991.3159919655415, 10218.744531386626, 10823.404712740874, 10968.23222374442, 11058.447077646086, 11065.50205240766, 501635.0, 507203.0, 513195.0, 517624.0, 523184.0, 89967.65048524278, 90871.0, 93366.53316733374, 97192.0, 97328.0, 952.3476418653245, 987.225028352754, 1000.7047920863363, 1004.5881188712593, 1004.8693669822876, 16331.59171020734, 16542.83457165413, 17055.232514536627, 17378.52282555997, 17597.984574396236, 41185.1762964745, 41249.0, 42019.1596168081, 42202.577974219865, 43018.78490607527, 58137.4186258132, 58805.70597146987, 59025.40974590199, 60034.39965600288, 60836.0, 8184.672613095648, 8280.337572994267, 8371.786091016647, 8376.916230837614, 8418.536980466133, 11517.424128793695, 12871.485140594647, 13138.474461021835, 13249.602511924657, 13493.122947008413, 10908.400037997986, 11147.498362573866, 11208.719782005515, 11490.48292826808, 11567.652970410902, 10513.211509136998, 10795.244332896937, 11412.087033037504, 11450.885491144982, 11519.25124866881, 10732.51703673321, 10893.128549715846, 10991.175661825235, 11039.448027598748, 11227.157963152633, 7426.034615499951, 7788.299053085249, 8527.403081784216, 8549.059603443491, 8956.910430895608, 10503.0, 10901.127909767041, 10916.890831091587, 11021.614243501439, 11625.88374116282], "value": 9282.25644588309, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1248.138784238875, 1301.8502872169697, 1309.3715016791946, 1364.1269587464026, 1656.2215758593463, 6915.827104322394, 7430.702771889125, 7717.305442510173, 7726.536407815528, 7892.526448413099, 7777.105632852224, 7817.374610031198, 7831.060272767261, 7831.843363132734, 7851.92148078519, 2232.5423288225916, 2251.0658076898067, 2252.087904398721, 2252.8648281103187, 2260.0959616153505, 2199.670049492573, 2251.0658076898067, 2260.672202530632, 2263.9320820375415, 2264.30938563738, 2210.3037543173928, 2227.7883601057874, 2236.552689462106, 2248.921287754929, 2280.372897453197, 2164.6644770060666, 2187.748408932969, 2190.7480639726477, 2190.9014094365793, 2197.055266235518, 2141.1649456711893, 2143.485563464773, 2150.0969592771075, 2150.473134082144, 2152.13914434226, 7799.844003119906, 7801.921980780176, 7854.175311592315, 7969.442139050268, 8274.627641756075, 4917.336159618477, 5018.422881368653, 5023.824166154203, 5030.320906677588, 5032.094223039851, 3066.7242844863995, 3227.273863380744, 3229.531717900915, 3230.224746060952, 3270.8201048942296, 1054.609794376078, 1054.783769327286, 1064.4092528646597, 1071.9678409647645, 1076.6178006807627, 10415.427151506665, 10479.895201048044, 10502.422366769824, 10530.84203736937, 10553.0, 4040.777757223322, 4150.232207041707, 4273.91452170961, 4274.5939135782055, 4303.892402689958, 8517.659293628185, 8537.573121343908, 8550.78623034429, 8555.828883422297, 8563.700270490503, 4897.730624815598, 4901.926471102936, 4902.240152776325, 4903.53416425439, 4908.533689299511, 4066.6949978751713, 4189.832406703758, 4492.9550704493195, 4610.423697037871, 4611.077784443125, 3429.9485507717404, 3497.9125521862156, 3501.072215862798, 3524.488949102366, 3576.46353047045, 1062.2033474893828, 1091.399730148431, 1092.421016861049, 1104.7900898829196, 1110.5502271580024, 915.5056269614466, 918.779492921694, 949.3876449690049, 953.50894289441, 966.3477152921749, 5189.455107213688, 5420.0, 5593.272874526286, 5691.089425691869, 5707.800226992035, 918.5407296351824, 935.7192842147465, 937.315759495572, 938.5541867612966, 953.6900507335143, 3604.6575575320303, 3624.6012938576737, 3637.3452778500123, 3789.3558095123894, 3871.7289789715014, 9418.90581094194, 9632.518374081268, 9712.902870971342, 9714.12572868431, 9776.511174441392, 9252.306077044248, 9661.565229564687, 9701.399269120517, 9702.466364349888, 9705.466199359103, 7204.639768011579, 7385.556866588022, 7388.667509962064, 7431.219721929336, 7533.171351151369, 5489.917651235314, 5505.284313039279, 5586.7306472082055, 5741.5119714824705, 5751.367349591458, 8793.428427152214, 9026.503542304974, 9039.367244292836, 9196.678116265899, 9255.722328330161, 8918.955405222932, 9130.908690913006, 9170.312226582899, 9292.163705266288, 9302.255819534286, 6066.666333351708, 6085.878282434238, 6195.876082478415, 7048.0, 7189.712411503481, 7515.023047003854, 7715.498492597963, 7718.729844455417, 7725.304722574995, 7726.729564465217, 6905.309469053054, 7037.0, 7088.043114179726, 7092.468064895051, 7193.208747037717, 6757.222919364336, 6880.965595171992, 6898.586084834926, 6957.339052789976, 6966.0, 6367.076773867856, 6409.615423074631, 6427.58220715652, 6496.935030649633, 6563.671816409256, 4579.129965306581, 4642.2108241598335, 4720.858374248778, 4757.167495688172, 4868.026394721141, 4499.595036446735, 4511.09778044399, 4610.193216187086, 4670.486246512949, 4731.810727570859], "value": 4231.8207272805275, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.38569567756133, 335.1888429999401, 340.70188584988125, 352.7090150625734, 352.89589571076544, 5241.091194387113, 5255.658382205159, 5282.20766884967, 5302.814401495939, 5317.548008419289, 5190.480951904817, 5216.217567364897, 5251.947480525194, 5252.711100889459, 5273.393559740631, 4072.1448495815766, 4150.190712811003, 4163.2298024865495, 4171.916561668765, 4189.036521600034, 4165.708400411957, 4173.457450531427, 4209.410682504452, 4217.768022758747, 4224.894377640569, 4113.444684967536, 4123.9381409278885, 4128.752274863503, 4132.628063474287, 4135.834566617332, 3946.4277679736565, 4004.9199016019516, 4051.696122790773, 4106.568810274908, 4154.875353739378, 3642.3625865473437, 3658.506101676266, 3659.79871107089, 3665.688416484602, 3671.3391589513876, 5076.035553244872, 5099.4900509949075, 5108.233764935252, 5114.667546609458, 5220.399654039796, 4396.846110386153, 4427.645788336926, 4705.435347758256, 4710.929336059962, 4757.738324392157, 5442.673439593637, 5452.182172674131, 5464.316960379952, 5473.616846820724, 5475.123980163155, 4056.0468289951837, 4067.3288907330257, 4070.61329173728, 4086.1214838809797, 4086.7139300248996, 5428.665673760282, 5671.829845104653, 5682.17608446777, 5726.141078838207, 5763.4812866842185, 4031.1053804711737, 4050.716449848482, 4062.1266427718183, 4079.8572049978106, 4102.99476628228, 4118.9588104119175, 4145.0, 4159.04524873309, 4165.8958526037095, 4171.666266698657, 4403.625691816167, 4722.787474563653, 4730.62155027597, 4751.097291514601, 4751.976240118846, 5474.7810087596845, 5483.040467918098, 5499.340079190522, 5520.3651580068, 5529.654558991832, 1380.9309534523234, 1395.1698739250332, 1398.5175114585452, 1414.7453458377386, 1417.893657975656, 848.6350869126212, 917.866909298148, 931.8835145606799, 939.5771902643837, 945.2674177512346, 4659.4175728034, 4698.8355407560575, 4708.317293992352, 4718.787654555554, 4748.050389922029, 4866.975665121722, 4878.0, 4917.336159618406, 4943.382077240345, 4958.231474121517, 4678.8596342109795, 4691.460482044608, 4713.481517033124, 4720.716756994591, 4970.329005584272, 2943.705629437039, 2967.5548667699586, 2977.76177905767, 2986.283292009902, 2996.6553846307515, 5808.506276966421, 5825.854353641193, 5840.649561026352, 5857.619254748428, 5861.384554621789, 5486.478784515464, 5730.452777749984, 5750.1949727038245, 5754.165645981309, 5773.307203135567, 5724.942750572441, 5779.3642699303045, 5799.88400231993, 5815.94184058154, 5823.708814559171, 5415.2689386933835, 5590.608657393944, 5640.689762062962, 5644.6330988485615, 5668.914966275427, 5553.4724201200825, 5573.665580065209, 5587.385387607279, 5595.35653399848, 5610.9158362623775, 5787.94212057874, 5851.61964472308, 5854.590178687451, 5868.413158684098, 5868.882622347614, 3901.51231096113, 3995.4805875236034, 4022.35642297231, 4028.3957406389277, 4088.855120566246, 5524.502794748492, 5550.555955523468, 5564.916526252028, 5604.607677462538, 5617.6013511826395, 5411.458854114557, 5424.945750542602, 5485.61600687948, 5512.0, 5515.0, 5272.7100009499845, 5416.8104116355735, 5437.429069947599, 5443.510084092451, 5465.180222966586, 5381.0, 5383.0, 5430.619856609999, 5431.9185212221055, 5441.211024401518, 5257.63196576236, 5364.678119312854, 5391.649542779864, 5517.834464966058, 5534.308211473566, 5406.567474602101, 5418.805383819559, 5424.783008679767, 5433.972830135982, 5434.2392065110125], "value": 4164.690456868555, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.9776206713798, 806.4314658165994, 833.6373677450309, 835.4152093534524, 842.3050982939077, 15264.694706105885, 16405.835941640595, 16527.0, 16619.83380166198, 16691.83308166918, 15318.157501337422, 15328.61678458039, 15471.45849895254, 15476.071435713866, 15480.0, 656.2190992718673, 798.309462315099, 805.1586092533288, 805.8267472493412, 807.1202389395557, 663.9767608133716, 796.6773456750026, 812.7074253268819, 813.4184058398245, 823.6540652925786, 858.6908712863365, 859.1236938322907, 860.5998210831962, 861.0700443521014, 861.3066481482405, 691.7060249393987, 857.3612658569375, 858.1289990659485, 860.6385318166385, 861.5993562993207, 519.2263527344268, 599.4395240450193, 613.4724137241968, 617.1544983372763, 621.6549814852755, 14365.209913454755, 14449.060811047248, 14480.565583032527, 14502.05736627116, 14522.419103235858, 13324.333783310796, 13902.51341203053, 14162.36269367881, 14189.219592922385, 14487.0, 12400.441980110916, 12437.62687119388, 12526.74946501074, 12575.559855405018, 13013.284269365182, 4249.405083288342, 4278.807453664593, 4280.486341638992, 4498.8875278117985, 4517.299818528133, 75910.62044689797, 76144.61927690382, 78116.99999999943, 78859.6057019717, 80687.59656201681, 11104.722381940515, 11499.712507187387, 11502.252353596989, 11597.710057248467, 12169.330686812133, 21809.0, 22022.669659955114, 22043.11827526913, 22043.228487002878, 22066.558668826856, 8023.6790528378215, 8075.717349892726, 8230.753077407568, 8355.0, 8368.916310836814, 4500.504944456107, 4640.582347588733, 4658.534146585314, 4661.207594708908, 4682.859514214579, 3510.859565617398, 3677.5770786359376, 3698.537682789651, 3700.6854417374825, 3709.9797555672408, 611.3153268339488, 630.6247782569363, 633.4109278371159, 634.8285962790021, 640.2604991235131, 567.494929512734, 621.316551793024, 748.0900883024153, 761.6572542355962, 767.0833354141747, 9395.671151509665, 9819.705408837746, 9943.651972181084, 10033.197344212445, 10342.689719308433, 626.37675512865, 684.4079870911626, 708.8496850937788, 743.4238465189521, 747.1445195251515, 4888.535589119028, 4961.0, 4962.826301079445, 5002.774875130628, 5011.799528018912, 69393.65303173452, 69907.0, 70139.64930175418, 94059.0, 124549.0, 59959.40040599625, 60105.0, 60986.0, 107091.39362909406, 109092.0, 92348.0, 97223.51388243014, 98751.50624246977, 100660.0, 101666.0, 9251.583678734338, 9482.0, 9526.0, 9563.856542152012, 9665.806683866424, 52372.0, 54134.0, 55378.72310638421, 55539.0, 56147.719261405065, 73295.0, 74809.25190748023, 81121.59439202766, 82352.0, 83742.16257837343, 13173.0, 13201.20792752438, 13218.669533261746, 13304.334783260992, 13738.86261137376, 14487.0, 15054.473093442115, 15208.847911521187, 15373.923130384277, 15687.686246274783, 14011.229382384066, 14116.435342586181, 14288.0, 14725.116493010453, 14738.63153421173, 13939.651508712363, 14129.222892740998, 14215.857841421453, 14264.286785660883, 14469.49356772508, 12886.162399444007, 13089.672758181121, 13437.596872093853, 13636.590902272948, 13897.652558686113, 11061.778764424505, 11062.502187401426, 11110.388928609003, 11548.48031838586, 11551.595694150665, 11896.345700986529, 12006.39968001579, 12097.69755756078, 12287.877121228674, 12439.378031098227], "value": 7597.932677713813, "unit": "score"}], "name": "dromaeo_css", "value": 7126.859118420634, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 110.0, 112.0, 114.0, 112.0, 112.0, 112.0, 112.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 128.0, 120.0, 162.0, 133.0, 124.0, 123.0, 124.0, 161.0, 121.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 161.0, 162.0, 162.0, 163.0, 161.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 76.0, 109.0, 77.0, 75.0, 76.0, 77.0, 105.0, 76.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 115.0, 81.0, 82.0, 82.0, 101.0, 81.0, 82.0, 117.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 147.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 50.0, 51.0, 53.0, 53.0, 54.0, 51.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 81.0, 80.0, 79.0, 84.0, 79.0, 79.0, 87.0, 79.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 131.0, 131.0, 132.0, 143.0, 138.0, 128.0, 143.0, 173.0, 144.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 166.0, 173.0, 167.0, 172.0, 168.0, 168.0, 168.0, 169.0, 170.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 65.0, 65.0, 64.0, 66.0, 65.0, 64.0, 64.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1507.0, "alertThreshold": 2.0}]} 06:22:37 INFO - Return code: 0 06:22:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:22:37 INFO - # TBPL SUCCESS # 06:22:37 INFO - Running post-action listener: _resource_record_post_action 06:22:37 INFO - [mozharness: 2016-10-12 13:22:37.829957Z] Finished run-tests step (success) 06:22:37 INFO - Running post-run listener: _resource_record_post_run 06:22:37 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 410025984; Read time: 16; Write time: 284584 06:22:37 INFO - TinderboxPrint: CPU usage
13.1% 06:22:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:22:37 INFO - TinderboxPrint: I/O write bytes / time
410,025,984 / 284,584 06:22:37 INFO - TinderboxPrint: CPU idle
8,314.7 (86.9%) 06:22:37 INFO - TinderboxPrint: CPU user
1,199.6 (12.5%) 06:22:37 INFO - TinderboxPrint: Swap in / out
0 / 0 06:22:37 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 120864768; Read time: 0; Write time: 69384 06:22:37 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288722944; Read time: 0; Write time: 215088 06:22:38 INFO - Running post-run listener: _upload_blobber_files 06:22:38 INFO - Blob upload gear active. 06:22:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:22:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:22:38 INFO - (blobuploader) - INFO - Open directory for files ... 06:22:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:22:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:22:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:42 INFO - (blobuploader) - INFO - Done attempting. 06:22:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:22:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:22:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:43 INFO - (blobuploader) - INFO - Done attempting. 06:22:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:22:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:22:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:44 INFO - (blobuploader) - INFO - Done attempting. 06:22:44 INFO - (blobuploader) - INFO - Iteration through files over. 06:22:44 INFO - Return code: 0 06:22:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:22:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:22:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49095c9c88e48c78f1960b0ab28538c250aac2d2e24a711bbf957156c04b699277cb4b91dd6448b7038a86fa0e420961b2b33936a3d41b2ffccba9dbd3786862", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d632084dc0ccf3c2ff6d28b33ab35772d4bab79e3f9e7984053481916b4598bfb278c578279f310229710c9492b5257307049c26c2ab0174d86799e28a71f6ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/375a0b916879c79c443fdbd4ea2c5dd872b8ba03cd11e638f63b54b36293c49db2b185a91df5da9061877147213092f1df3cb63693e2337c6074b110cf2b90b9"} 06:22:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:22:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:22:44 INFO - Contents: 06:22:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49095c9c88e48c78f1960b0ab28538c250aac2d2e24a711bbf957156c04b699277cb4b91dd6448b7038a86fa0e420961b2b33936a3d41b2ffccba9dbd3786862", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d632084dc0ccf3c2ff6d28b33ab35772d4bab79e3f9e7984053481916b4598bfb278c578279f310229710c9492b5257307049c26c2ab0174d86799e28a71f6ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/375a0b916879c79c443fdbd4ea2c5dd872b8ba03cd11e638f63b54b36293c49db2b185a91df5da9061877147213092f1df3cb63693e2337c6074b110cf2b90b9"} 06:22:44 INFO - Running post-run listener: copy_logs_to_upload_dir 06:22:44 INFO - Copying logs to upload dir... 06:22:44 INFO - mkdir: /builds/slave/test/build/upload/logs 06:22:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.005580 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-12 06:22:43.451390) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 06:22:43.454587) ========= 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=5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505 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/49095c9c88e48c78f1960b0ab28538c250aac2d2e24a711bbf957156c04b699277cb4b91dd6448b7038a86fa0e420961b2b33936a3d41b2ffccba9dbd3786862", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d632084dc0ccf3c2ff6d28b33ab35772d4bab79e3f9e7984053481916b4598bfb278c578279f310229710c9492b5257307049c26c2ab0174d86799e28a71f6ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/375a0b916879c79c443fdbd4ea2c5dd872b8ba03cd11e638f63b54b36293c49db2b185a91df5da9061877147213092f1df3cb63693e2337c6074b110cf2b90b9"} build_url:https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/I-n7J9RmQO2KVgXu7VqekA/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/49095c9c88e48c78f1960b0ab28538c250aac2d2e24a711bbf957156c04b699277cb4b91dd6448b7038a86fa0e420961b2b33936a3d41b2ffccba9dbd3786862", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d632084dc0ccf3c2ff6d28b33ab35772d4bab79e3f9e7984053481916b4598bfb278c578279f310229710c9492b5257307049c26c2ab0174d86799e28a71f6ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/375a0b916879c79c443fdbd4ea2c5dd872b8ba03cd11e638f63b54b36293c49db2b185a91df5da9061877147213092f1df3cb63693e2337c6074b110cf2b90b9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 06:22:43.479663) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:22:43.479947) ========= 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=5bd038846534b2fdfa68eeae000001e2-1476275778.535013-375442505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:22:43.562790) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 06:22:43.563085) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 06:22:43.563368) ========= ========= Total master_lag: 0.16 =========