builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1485971989.2 results: success (0) buildid: 20170201075009 builduid: a01cb9dc5a3e477aa752e3637331c867 revision: d13a909fc8a10c8a691f4fc386b290a995d18f32 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 09:59:49.202144) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 09:59:49.202561) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 09:59:49.202839) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 09:59:49.218744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:59:49.219008) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-01 09:59:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.2M=0s 2017-02-01 09:59:50 (40.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106633 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:59:49.338762) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:59:49.339121) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018621 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:59:49.388565) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-01 09:59:49.388884) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d13a909fc8a10c8a691f4fc386b290a995d18f32 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d13a909fc8a10c8a691f4fc386b290a995d18f32 --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=a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-01 09:59:50,721 truncating revision to first 12 chars 2017-02-01 09:59:50,721 Setting DEBUG logging. 2017-02-01 09:59:50,721 attempt 1/10 2017-02-01 09:59:50,721 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d13a909fc8a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-01 09:59:51,519 unpacking tar archive at: mozilla-beta-d13a909fc8a1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.195117 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-01 09:59:50.597004) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 09:59:50.597340) ========= script_repo_revision: d13a909fc8a10c8a691f4fc386b290a995d18f32 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 09:59:50.597751) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 09:59:50.598027) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 09:59:50.605520) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-02-01 09:59:50.605785) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:59:52 INFO - MultiFileLogger online at 20170201 09:59:52 in /builds/slave/test 09:59:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:59:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:59:52 INFO - {'append_to_log': False, 09:59:52 INFO - 'base_work_dir': '/builds/slave/test', 09:59:52 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:59:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:59:52 INFO - 'branch': 'Mozilla-Beta', 09:59:52 INFO - 'buildbot_json_path': 'buildprops.json', 09:59:52 INFO - 'config_files': ('talos/linux_config.py',), 09:59:52 INFO - 'default_actions': ('clobber', 09:59:52 INFO - 'read-buildbot-config', 09:59:52 INFO - 'download-and-extract', 09:59:52 INFO - 'populate-webroot', 09:59:52 INFO - 'create-virtualenv', 09:59:52 INFO - 'install', 09:59:52 INFO - 'run-tests'), 09:59:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:59:52 INFO - 'download_minidump_stackwalk': True, 09:59:52 INFO - 'download_symbols': 'ondemand', 09:59:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:59:52 INFO - 'tooltool.py': '/tools/tooltool.py', 09:59:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:59:52 INFO - '/tools/misc-python/virtualenv.py')}, 09:59:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:59:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:59:52 INFO - 'installer_path': 'installer.exe', 09:59:52 INFO - 'log_level': 'info', 09:59:52 INFO - 'log_name': 'talos', 09:59:52 INFO - 'log_to_console': True, 09:59:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:59:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:59:52 INFO - 'opt_config_files': (), 09:59:52 INFO - 'pip_index': False, 09:59:52 INFO - 'sps_profile': False, 09:59:52 INFO - 'sps_profile_interval': 0, 09:59:52 INFO - 'suite': 'dromaeojs', 09:59:52 INFO - 'system_bits': '32', 09:59:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:59:52 INFO - 'title': 'talos-linux64-ix-064', 09:59:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:59:52 INFO - 'use_talos_json': True, 09:59:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:59:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:59:52 INFO - 'work_dir': 'build'} 09:59:52 INFO - [mozharness: 2017-02-01 17:59:52.041022Z] Running clobber step. 09:59:52 INFO - Running pre-action listener: _resource_record_pre_action 09:59:52 INFO - Running main action method: clobber 09:59:52 INFO - rmtree: /builds/slave/test/build 09:59:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:59:52 INFO - Running post-action listener: _resource_record_post_action 09:59:52 INFO - [mozharness: 2017-02-01 17:59:52.494936Z] Finished clobber step (success) 09:59:52 INFO - [mozharness: 2017-02-01 17:59:52.495036Z] Running read-buildbot-config step. 09:59:52 INFO - Running pre-action listener: _resource_record_pre_action 09:59:52 INFO - Running main action method: read_buildbot_config 09:59:52 INFO - Using buildbot properties: 09:59:52 INFO - { 09:59:52 INFO - "project": "", 09:59:52 INFO - "product": "firefox", 09:59:52 INFO - "script_repo_revision": "production", 09:59:52 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:59:52 INFO - "repository": "", 09:59:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:59:52 INFO - "buildid": "20170201075009", 09:59:52 INFO - "pgo_build": "True", 09:59:52 INFO - "basedir": "/builds/slave/test", 09:59:52 INFO - "buildnumber": 3, 09:59:52 INFO - "slavename": "talos-linux64-ix-064", 09:59:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:59:52 INFO - "platform": "ubuntu64_hw", 09:59:52 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:59:52 INFO - "branch": "mozilla-beta", 09:59:52 INFO - "repo_path": "releases/mozilla-beta", 09:59:52 INFO - "revision": "d13a909fc8a10c8a691f4fc386b290a995d18f32", 09:59:52 INFO - "stage_platform": "linux64-pgo", 09:59:52 INFO - "builduid": "a01cb9dc5a3e477aa752e3637331c867", 09:59:52 INFO - "slavebuilddir": "test" 09:59:52 INFO - } 09:59:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 09:59:52 INFO - Running post-action listener: _resource_record_post_action 09:59:52 INFO - [mozharness: 2017-02-01 17:59:52.497488Z] Finished read-buildbot-config step (success) 09:59:52 INFO - [mozharness: 2017-02-01 17:59:52.497577Z] Running download-and-extract step. 09:59:52 INFO - Running pre-action listener: _resource_record_pre_action 09:59:52 INFO - Running main action method: download_and_extract 09:59:52 INFO - mkdir: /builds/slave/test/build/tests 09:59:52 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')]} 09:59:52 INFO - trying https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:59:52 INFO - Downloading https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:59:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:59:53 INFO - Downloaded 1327 bytes. 09:59:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:59:53 INFO - Using the following test package requirements: 09:59:53 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 09:59:53 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:59:53 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:59:53 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:59:53 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 09:59:53 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:59:53 INFO - u'jsshell-linux-x86_64.zip'], 09:59:53 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:59:53 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:59:53 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 09:59:53 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:59:53 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 09:59:53 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:59:53 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 09:59:53 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:59:53 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:59:53 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:59:53 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:59:53 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:59:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 09:59:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:59:53 INFO - Fetch https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 09:59:53 INFO - Http code: 200 09:59:53 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 09:59:53 INFO - x-amz-cf-id: LQ6fn-lL3dACQPdtx94RihXRdB0aYJbq-0Yan4YSmEorWpY3jL4M1A== 09:59:53 INFO - x-amz-version-id: iL5zLeFQcT2sQ.remocZsiNvCgBg5ca3 09:59:53 INFO - Expected file size: 21954885 09:59:53 INFO - Obtained file size: 21954885 09:59:57 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:59:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 09:59:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:59:57 INFO - Fetch https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 09:59:58 INFO - Http code: 200 09:59:58 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 09:59:58 INFO - x-amz-cf-id: Rj0nzu2FogyXK1jpPrmNvDRDhDLTvumEoOHf6iznfGKU7Q-ScIGuaQ== 09:59:58 INFO - x-amz-version-id: iL5zLeFQcT2sQ.remocZsiNvCgBg5ca3 09:59:58 INFO - Expected file size: 21954885 09:59:58 INFO - Obtained file size: 21954885 10:00:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 10:00:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:00:02 INFO - Fetch https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 10:00:03 INFO - Http code: 200 10:00:03 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 10:00:03 INFO - x-amz-cf-id: HLhYKlWMN-ORYucOW9ew1P25xMqwlChDgxEVNcwTlNb0XnuuLR2Ydw== 10:00:03 INFO - x-amz-version-id: EfJp8he04fBfTXGd8ncGpID5sluPaucX 10:00:03 INFO - Expected file size: 14403005 10:00:03 INFO - Obtained file size: 14403005 10:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:04 INFO - trying https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 10:00:04 INFO - Downloading https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 10:00:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:00:05 INFO - Downloaded 57702324 bytes. 10:00:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 10:00:05 INFO - mkdir: /builds/slave/test/properties 10:00:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:00:05 INFO - Writing to file /builds/slave/test/properties/build_url 10:00:05 INFO - Contents: 10:00:05 INFO - build_url:https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 10:00:05 INFO - Running post-action listener: _resource_record_post_action 10:00:05 INFO - Running post-action listener: set_extra_try_arguments 10:00:05 INFO - [mozharness: 2017-02-01 18:00:05.730239Z] Finished download-and-extract step (success) 10:00:05 INFO - [mozharness: 2017-02-01 18:00:05.730467Z] Running populate-webroot step. 10:00:05 INFO - Running pre-action listener: _resource_record_pre_action 10:00:05 INFO - Running main action method: populate_webroot 10:00:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:00:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:00:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:00:05 INFO - '--tppagecycles', 10:00:05 INFO - '7'], 10:00:05 INFO - 'tests': ['tsvgm']}}, 10:00:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:00:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:00:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:00:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:00:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:00:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:00:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:05 INFO - 'talos_options': ['--disable-e10s'], 10:00:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:05 INFO - 'talos_options': ['--disable-e10s'], 10:00:05 INFO - 'tests': ['damp', 'tps']}, 10:00:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:05 INFO - 'tests': ['damp', 'tps']}, 10:00:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:00:05 INFO - 'tests': ['dromaeo_dom']}, 10:00:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:00:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:00:05 INFO - 'tests': ['basic_compositor_video']}, 10:00:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:00:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:00:05 INFO - 'tests': ['a11yr', 10:00:05 INFO - 'ts_paint', 10:00:05 INFO - 'tpaint', 10:00:05 INFO - 'sessionrestore', 10:00:05 INFO - 'sessionrestore_no_auto_restore', 10:00:05 INFO - 'tabpaint']}, 10:00:05 INFO - 'other-e10s': {'tests': ['a11yr', 10:00:05 INFO - 'ts_paint', 10:00:05 INFO - 'tpaint', 10:00:05 INFO - 'sessionrestore', 10:00:05 INFO - 'sessionrestore_no_auto_restore', 10:00:05 INFO - 'tabpaint']}, 10:00:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:00:05 INFO - 'ts_paint', 10:00:05 INFO - 'tpaint', 10:00:05 INFO - 'sessionrestore', 10:00:05 INFO - 'sessionrestore_no_auto_restore', 10:00:05 INFO - 'tabpaint']}, 10:00:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:00:05 INFO - 'ts_paint', 10:00:05 INFO - 'tpaint', 10:00:05 INFO - 'sessionrestore', 10:00:05 INFO - 'sessionrestore_no_auto_restore', 10:00:05 INFO - 'tabpaint']}, 10:00:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:00:05 INFO - 'tests': ['a11yr', 10:00:05 INFO - 'ts_paint', 10:00:05 INFO - 'tpaint', 10:00:05 INFO - 'sessionrestore', 10:00:05 INFO - 'sessionrestore_no_auto_restore', 10:00:05 INFO - 'tabpaint']}, 10:00:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:00:05 INFO - 'tests': ['a11yr', 10:00:05 INFO - 'ts_paint', 10:00:05 INFO - 'tpaint', 10:00:05 INFO - 'sessionrestore', 10:00:05 INFO - 'sessionrestore_no_auto_restore', 10:00:05 INFO - 'tabpaint']}, 10:00:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:00:05 INFO - 'tests': ['tsvgx', 10:00:05 INFO - 'tsvgr_opacity', 10:00:05 INFO - 'tart', 10:00:05 INFO - 'tscrollx', 10:00:05 INFO - 'cart']}, 10:00:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:00:05 INFO - 'tsvgr_opacity', 10:00:05 INFO - 'tart', 10:00:05 INFO - 'tscrollx', 10:00:05 INFO - 'cart']}, 10:00:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:05 INFO - 'talos_options': ['--disable-e10s'], 10:00:05 INFO - 'tests': ['tp5o']}, 10:00:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:05 INFO - 'tests': ['tp5o']}, 10:00:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:05 INFO - 'talos_options': ['--disable-e10s', 10:00:05 INFO - '--xperf_path', 10:00:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:05 INFO - 'tests': ['tp5n']}, 10:00:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:05 INFO - 'talos_options': ['--xperf_path', 10:00:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:05 INFO - 'tests': ['tp5n']}}, 10:00:05 INFO - 'talos.zip': {'path': '', 10:00:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:00:05 INFO - Running post-action listener: _resource_record_post_action 10:00:05 INFO - [mozharness: 2017-02-01 18:00:05.753257Z] Finished populate-webroot step (success) 10:00:05 INFO - [mozharness: 2017-02-01 18:00:05.753346Z] Running create-virtualenv step. 10:00:05 INFO - Running pre-action listener: _resource_record_pre_action 10:00:05 INFO - Running main action method: create_virtualenv 10:00:05 INFO - Creating virtualenv /builds/slave/test/build/venv 10:00:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:00:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:00:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:00:05 INFO - Using real prefix '/usr' 10:00:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:00:06 INFO - Installing distribute.............................................................................................................................................................................................done. 10:00:08 INFO - Installing pip.................done. 10:00:08 INFO - Return code: 0 10:00:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:00:08 INFO - Reading from file tmpfile_stdout 10:00:08 INFO - Output received: 10:00:08 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:00:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:08 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 0x7f01a6241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e3f60>, '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 0x14e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e51d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:00:08 INFO - Using env: {'DISPLAY': ':0', 10:00:08 INFO - 'HOME': '/home/cltbld', 10:00:08 INFO - 'LANG': 'en_US.UTF-8', 10:00:08 INFO - 'LANGUAGE': 'en_US:en', 10:00:08 INFO - 'LOGNAME': 'cltbld', 10:00:08 INFO - 'MAIL': '/var/mail/cltbld', 10:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:08 INFO - 'MOZ_NO_REMOTE': '1', 10:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:08 INFO - 'NO_EM_RESTART': '1', 10:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:08 INFO - 'PWD': '/builds/slave/test', 10:00:08 INFO - 'SHELL': '/bin/bash', 10:00:08 INFO - 'SHLVL': '1', 10:00:08 INFO - 'TERM': 'linux', 10:00:08 INFO - 'TMOUT': '86400', 10:00:08 INFO - 'USER': 'cltbld', 10:00:08 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 10:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:08 INFO - '_': '/tools/buildbot/bin/python'} 10:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:00:08 INFO - Cleaning up... 10:00:08 INFO - Return code: 0 10:00:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:08 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 0x7f01a6241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e3f60>, '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 0x14e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e51d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:00:08 INFO - Using env: {'DISPLAY': ':0', 10:00:08 INFO - 'HOME': '/home/cltbld', 10:00:08 INFO - 'LANG': 'en_US.UTF-8', 10:00:08 INFO - 'LANGUAGE': 'en_US:en', 10:00:08 INFO - 'LOGNAME': 'cltbld', 10:00:08 INFO - 'MAIL': '/var/mail/cltbld', 10:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:08 INFO - 'MOZ_NO_REMOTE': '1', 10:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:08 INFO - 'NO_EM_RESTART': '1', 10:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:08 INFO - 'PWD': '/builds/slave/test', 10:00:08 INFO - 'SHELL': '/bin/bash', 10:00:08 INFO - 'SHLVL': '1', 10:00:08 INFO - 'TERM': 'linux', 10:00:08 INFO - 'TMOUT': '86400', 10:00:08 INFO - 'USER': 'cltbld', 10:00:08 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 10:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:08 INFO - '_': '/tools/buildbot/bin/python'} 10:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:08 INFO - Downloading/unpacking psutil>=3.1.1 10:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:00:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:11 INFO - Installing collected packages: psutil 10:00:11 INFO - Running setup.py install for psutil 10:00:11 INFO - building 'psutil._psutil_linux' extension 10:00:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:00:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:00:11 INFO - building 'psutil._psutil_posix' extension 10:00:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:00:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:00:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:11 INFO - Successfully installed psutil 10:00:11 INFO - Cleaning up... 10:00:11 INFO - Return code: 0 10:00:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:11 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 0x7f01a6241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e3f60>, '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 0x14e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e51d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:00:11 INFO - Using env: {'DISPLAY': ':0', 10:00:11 INFO - 'HOME': '/home/cltbld', 10:00:11 INFO - 'LANG': 'en_US.UTF-8', 10:00:11 INFO - 'LANGUAGE': 'en_US:en', 10:00:11 INFO - 'LOGNAME': 'cltbld', 10:00:11 INFO - 'MAIL': '/var/mail/cltbld', 10:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:11 INFO - 'MOZ_NO_REMOTE': '1', 10:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:11 INFO - 'NO_EM_RESTART': '1', 10:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:11 INFO - 'PWD': '/builds/slave/test', 10:00:11 INFO - 'SHELL': '/bin/bash', 10:00:11 INFO - 'SHLVL': '1', 10:00:11 INFO - 'TERM': 'linux', 10:00:11 INFO - 'TMOUT': '86400', 10:00:11 INFO - 'USER': 'cltbld', 10:00:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 10:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:11 INFO - '_': '/tools/buildbot/bin/python'} 10:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:00:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:00:13 INFO - Installing collected packages: mozsystemmonitor 10:00:13 INFO - Running setup.py install for mozsystemmonitor 10:00:13 INFO - Successfully installed mozsystemmonitor 10:00:13 INFO - Cleaning up... 10:00:14 INFO - Return code: 0 10:00:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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')]} 10:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f01a6241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e3f60>, '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 0x14e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e51d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:00:14 INFO - Using env: {'DISPLAY': ':0', 10:00:14 INFO - 'HOME': '/home/cltbld', 10:00:14 INFO - 'LANG': 'en_US.UTF-8', 10:00:14 INFO - 'LANGUAGE': 'en_US:en', 10:00:14 INFO - 'LOGNAME': 'cltbld', 10:00:14 INFO - 'MAIL': '/var/mail/cltbld', 10:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:14 INFO - 'MOZ_NO_REMOTE': '1', 10:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:14 INFO - 'NO_EM_RESTART': '1', 10:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:14 INFO - 'PWD': '/builds/slave/test', 10:00:14 INFO - 'SHELL': '/bin/bash', 10:00:14 INFO - 'SHLVL': '1', 10:00:14 INFO - 'TERM': 'linux', 10:00:14 INFO - 'TMOUT': '86400', 10:00:14 INFO - 'USER': 'cltbld', 10:00:14 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 10:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:14 INFO - '_': '/tools/buildbot/bin/python'} 10:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:14 INFO - Downloading/unpacking jsonschema==2.5.1 10:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:00:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:16 INFO - Downloading functools32-3.2.3-2.tar.gz 10:00:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:00:16 INFO - warning: no files found matching '*.txt' 10:00:16 INFO - no previously-included directories found matching 'build' 10:00:16 INFO - no previously-included directories found matching 'dist' 10:00:16 INFO - no previously-included directories found matching '.git*' 10:00:16 INFO - Installing collected packages: jsonschema, functools32 10:00:16 INFO - Running setup.py install for functools32 10:00:16 INFO - warning: no files found matching '*.txt' 10:00:16 INFO - no previously-included directories found matching 'build' 10:00:16 INFO - no previously-included directories found matching 'dist' 10:00:16 INFO - no previously-included directories found matching '.git*' 10:00:16 INFO - Successfully installed jsonschema functools32 10:00:16 INFO - Cleaning up... 10:00:16 INFO - Return code: 0 10:00:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:16 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 0x7f01a6241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e3f60>, '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 0x14e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e51d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:00:16 INFO - Using env: {'DISPLAY': ':0', 10:00:16 INFO - 'HOME': '/home/cltbld', 10:00:16 INFO - 'LANG': 'en_US.UTF-8', 10:00:16 INFO - 'LANGUAGE': 'en_US:en', 10:00:16 INFO - 'LOGNAME': 'cltbld', 10:00:16 INFO - 'MAIL': '/var/mail/cltbld', 10:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:16 INFO - 'MOZ_NO_REMOTE': '1', 10:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:16 INFO - 'NO_EM_RESTART': '1', 10:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:16 INFO - 'PWD': '/builds/slave/test', 10:00:16 INFO - 'SHELL': '/bin/bash', 10:00:16 INFO - 'SHLVL': '1', 10:00:16 INFO - 'TERM': 'linux', 10:00:16 INFO - 'TMOUT': '86400', 10:00:16 INFO - 'USER': 'cltbld', 10:00:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 10:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:16 INFO - '_': '/tools/buildbot/bin/python'} 10:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:00:16 INFO - Cleaning up... 10:00:16 INFO - Return code: 0 10:00:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:17 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 0x7f01a6241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e3f60>, '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 0x14e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e51d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:00:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:00:17 INFO - Using env: {'DISPLAY': ':0', 10:00:17 INFO - 'HOME': '/home/cltbld', 10:00:17 INFO - 'LANG': 'en_US.UTF-8', 10:00:17 INFO - 'LANGUAGE': 'en_US:en', 10:00:17 INFO - 'LOGNAME': 'cltbld', 10:00:17 INFO - 'MAIL': '/var/mail/cltbld', 10:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:17 INFO - 'MOZ_NO_REMOTE': '1', 10:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:17 INFO - 'NO_EM_RESTART': '1', 10:00:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:17 INFO - 'PWD': '/builds/slave/test', 10:00:17 INFO - 'SHELL': '/bin/bash', 10:00:17 INFO - 'SHLVL': '1', 10:00:17 INFO - 'TERM': 'linux', 10:00:17 INFO - 'TMOUT': '86400', 10:00:17 INFO - 'USER': 'cltbld', 10:00:17 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 10:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:17 INFO - '_': '/tools/buildbot/bin/python'} 10:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:17 INFO - Downloading/unpacking blobuploader==1.2.4 10:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:19 INFO - Downloading blobuploader-1.2.4.tar.gz 10:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:00:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:00: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 10:00: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 10:00: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 10:00: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 10:00: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 10:00: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 10:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:00:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:00: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 10:00: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 10:00: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 10:00: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 10:00: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 10:00: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 10:00:19 INFO - Downloading docopt-0.6.1.tar.gz 10:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:00:20 INFO - Installing collected packages: blobuploader, requests, docopt 10:00:20 INFO - Running setup.py install for blobuploader 10:00:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:00:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:00:20 INFO - Running setup.py install for requests 10:00:20 INFO - Running setup.py install for docopt 10:00:20 INFO - Successfully installed blobuploader requests docopt 10:00:20 INFO - Cleaning up... 10:00:20 INFO - Return code: 0 10:00:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:20 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 0x7f01a6241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e3f60>, '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 0x14e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e51d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:00:20 INFO - Using env: {'DISPLAY': ':0', 10:00:20 INFO - 'HOME': '/home/cltbld', 10:00:20 INFO - 'LANG': 'en_US.UTF-8', 10:00:20 INFO - 'LANGUAGE': 'en_US:en', 10:00:20 INFO - 'LOGNAME': 'cltbld', 10:00:20 INFO - 'MAIL': '/var/mail/cltbld', 10:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:20 INFO - 'MOZ_NO_REMOTE': '1', 10:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:20 INFO - 'NO_EM_RESTART': '1', 10:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:20 INFO - 'PWD': '/builds/slave/test', 10:00:20 INFO - 'SHELL': '/bin/bash', 10:00:20 INFO - 'SHLVL': '1', 10:00:20 INFO - 'TERM': 'linux', 10:00:20 INFO - 'TMOUT': '86400', 10:00:20 INFO - 'USER': 'cltbld', 10:00:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 10:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:20 INFO - '_': '/tools/buildbot/bin/python'} 10:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:20 INFO - Running setup.py (path:/tmp/pip-iuguwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:20 INFO - Running setup.py (path:/tmp/pip-s6_2HS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:21 INFO - Running setup.py (path:/tmp/pip-0OhHXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:21 INFO - Running setup.py (path:/tmp/pip-uiPohk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:21 INFO - Running setup.py (path:/tmp/pip-4ghDmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:21 INFO - Running setup.py (path:/tmp/pip-JEmsWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:21 INFO - Running setup.py (path:/tmp/pip-a7le_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:21 INFO - Running setup.py (path:/tmp/pip-s100Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:21 INFO - Running setup.py (path:/tmp/pip-CQQvpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:21 INFO - Running setup.py (path:/tmp/pip-js_Bnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:21 INFO - Running setup.py (path:/tmp/pip-iJYjvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:21 INFO - Running setup.py (path:/tmp/pip-4jOXsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:21 INFO - Running setup.py (path:/tmp/pip-1ZNxos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:21 INFO - Running setup.py (path:/tmp/pip-2LdVSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:21 INFO - Running setup.py (path:/tmp/pip-EC29dN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:21 INFO - Running setup.py (path:/tmp/pip-cCxcgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:22 INFO - Running setup.py (path:/tmp/pip-J2_mlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:00:22 INFO - Running setup.py install for manifestparser 10:00:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:00:22 INFO - Running setup.py install for mozcrash 10:00:22 INFO - Running setup.py install for mozdebug 10:00:22 INFO - Running setup.py install for mozdevice 10:00:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:00:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:00:22 INFO - Running setup.py install for mozfile 10:00:22 INFO - Running setup.py install for mozhttpd 10:00:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:00:22 INFO - Running setup.py install for mozinfo 10:00:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:00:22 INFO - Running setup.py install for mozInstall 10:00:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:00:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:00:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:00:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:00:22 INFO - Running setup.py install for mozleak 10:00:22 INFO - Running setup.py install for mozlog 10:00:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:00:23 INFO - Running setup.py install for moznetwork 10:00:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:00:23 INFO - Running setup.py install for mozprocess 10:00:23 INFO - Running setup.py install for mozprofile 10:00:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:00:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:00:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:00:23 INFO - Running setup.py install for mozrunner 10:00:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:00:23 INFO - Running setup.py install for mozscreenshot 10:00:23 INFO - Running setup.py install for moztest 10:00:23 INFO - Running setup.py install for mozversion 10:00:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:00:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:00:23 INFO - Cleaning up... 10:00:23 INFO - Return code: 0 10:00:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:23 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 0x7f01a6241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e3f60>, '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 0x14e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e51d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:00:23 INFO - Using env: {'DISPLAY': ':0', 10:00:23 INFO - 'HOME': '/home/cltbld', 10:00:23 INFO - 'LANG': 'en_US.UTF-8', 10:00:23 INFO - 'LANGUAGE': 'en_US:en', 10:00:23 INFO - 'LOGNAME': 'cltbld', 10:00:23 INFO - 'MAIL': '/var/mail/cltbld', 10:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:23 INFO - 'MOZ_NO_REMOTE': '1', 10:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:23 INFO - 'NO_EM_RESTART': '1', 10:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:23 INFO - 'PWD': '/builds/slave/test', 10:00:23 INFO - 'SHELL': '/bin/bash', 10:00:23 INFO - 'SHLVL': '1', 10:00:23 INFO - 'TERM': 'linux', 10:00:23 INFO - 'TMOUT': '86400', 10:00:23 INFO - 'USER': 'cltbld', 10:00:23 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 10:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:23 INFO - '_': '/tools/buildbot/bin/python'} 10:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:24 INFO - Running setup.py (path:/tmp/pip-rTmzKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:24 INFO - Running setup.py (path:/tmp/pip-y55RKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:24 INFO - Running setup.py (path:/tmp/pip-VYaIRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:24 INFO - Running setup.py (path:/tmp/pip-5FvRsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:24 INFO - Running setup.py (path:/tmp/pip-KWkJtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:24 INFO - Running setup.py (path:/tmp/pip-PHh69Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:24 INFO - Running setup.py (path:/tmp/pip-zd9Fm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:24 INFO - Running setup.py (path:/tmp/pip-dh_W25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:24 INFO - Running setup.py (path:/tmp/pip-nsKfbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:24 INFO - Running setup.py (path:/tmp/pip-_3GKeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:24 INFO - Running setup.py (path:/tmp/pip-P3MqYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:24 INFO - Running setup.py (path:/tmp/pip-LpmRNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:24 INFO - Running setup.py (path:/tmp/pip-DvJgKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:25 INFO - Running setup.py (path:/tmp/pip-5xQuxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:25 INFO - Running setup.py (path:/tmp/pip-64f8ZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:25 INFO - Running setup.py (path:/tmp/pip-b15oE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:25 INFO - Running setup.py (path:/tmp/pip-ErqZ6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:00:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:27 INFO - Downloading blessings-1.6.tar.gz 10:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:00:27 INFO - Installing collected packages: blessings 10:00:27 INFO - Running setup.py install for blessings 10:00:27 INFO - Successfully installed blessings 10:00:27 INFO - Cleaning up... 10:00:27 INFO - Return code: 0 10:00:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:00:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:27 INFO - Reading from file tmpfile_stdout 10:00:27 INFO - Current package versions: 10:00:27 INFO - argparse == 1.2.1 10:00:27 INFO - blessings == 1.6 10:00:27 INFO - blobuploader == 1.2.4 10:00:27 INFO - docopt == 0.6.1 10:00:27 INFO - functools32 == 3.2.3-2 10:00:27 INFO - jsonschema == 2.5.1 10:00:27 INFO - manifestparser == 1.1 10:00:27 INFO - mozInstall == 1.12 10:00:27 INFO - mozcrash == 1.0 10:00:27 INFO - mozdebug == 0.1 10:00:27 INFO - mozdevice == 0.48 10:00:27 INFO - mozfile == 1.2 10:00:27 INFO - mozhttpd == 0.7 10:00:27 INFO - mozinfo == 0.9 10:00:27 INFO - mozleak == 0.1 10:00:27 INFO - mozlog == 3.4 10:00:27 INFO - moznetwork == 0.27 10:00:27 INFO - mozprocess == 0.23 10:00:27 INFO - mozprofile == 0.28 10:00:27 INFO - mozrunner == 6.13 10:00:27 INFO - mozscreenshot == 0.1 10:00:27 INFO - mozsystemmonitor == 0.3 10:00:27 INFO - moztest == 0.8 10:00:27 INFO - mozversion == 1.4 10:00:27 INFO - psutil == 3.1.1 10:00:27 INFO - requests == 1.2.3 10:00:27 INFO - wsgiref == 0.1.2 10:00:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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')]} 10:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:27 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 0x7f01a6241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e3f60>, '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 0x14e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e51d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:00:27 INFO - Using env: {'DISPLAY': ':0', 10:00:27 INFO - 'HOME': '/home/cltbld', 10:00:27 INFO - 'LANG': 'en_US.UTF-8', 10:00:27 INFO - 'LANGUAGE': 'en_US:en', 10:00:27 INFO - 'LOGNAME': 'cltbld', 10:00:27 INFO - 'MAIL': '/var/mail/cltbld', 10:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:27 INFO - 'MOZ_NO_REMOTE': '1', 10:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:27 INFO - 'NO_EM_RESTART': '1', 10:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:27 INFO - 'PWD': '/builds/slave/test', 10:00:27 INFO - 'SHELL': '/bin/bash', 10:00:27 INFO - 'SHLVL': '1', 10:00:27 INFO - 'TERM': 'linux', 10:00:27 INFO - 'TMOUT': '86400', 10:00:27 INFO - 'USER': 'cltbld', 10:00:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 10:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:27 INFO - '_': '/tools/buildbot/bin/python'} 10:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:00:28 INFO - Cleaning up... 10:00:28 INFO - Return code: 0 10:00:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:28 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 0x7f01a6241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e3f60>, '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 0x14e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e51d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:00:28 INFO - Using env: {'DISPLAY': ':0', 10:00:28 INFO - 'HOME': '/home/cltbld', 10:00:28 INFO - 'LANG': 'en_US.UTF-8', 10:00:28 INFO - 'LANGUAGE': 'en_US:en', 10:00:28 INFO - 'LOGNAME': 'cltbld', 10:00:28 INFO - 'MAIL': '/var/mail/cltbld', 10:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:28 INFO - 'MOZ_NO_REMOTE': '1', 10:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:28 INFO - 'NO_EM_RESTART': '1', 10:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:28 INFO - 'PWD': '/builds/slave/test', 10:00:28 INFO - 'SHELL': '/bin/bash', 10:00:28 INFO - 'SHLVL': '1', 10:00:28 INFO - 'TERM': 'linux', 10:00:28 INFO - 'TMOUT': '86400', 10:00:28 INFO - 'USER': 'cltbld', 10:00:28 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 10:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:28 INFO - '_': '/tools/buildbot/bin/python'} 10:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:00:28 INFO - Cleaning up... 10:00:28 INFO - Return code: 0 10:00:28 INFO - Running post-action listener: _resource_record_post_action 10:00:28 INFO - Running post-action listener: _start_resource_monitoring 10:00:28 INFO - Starting resource monitoring. 10:00:28 INFO - [mozharness: 2017-02-01 18:00:28.287570Z] Finished create-virtualenv step (success) 10:00:28 INFO - [mozharness: 2017-02-01 18:00:28.288032Z] Running install step. 10:00:28 INFO - Running pre-action listener: _resource_record_pre_action 10:00:28 INFO - Running main action method: install 10:00:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:28 INFO - Reading from file tmpfile_stdout 10:00:28 INFO - Detecting whether we're running mozinstall >=1.0... 10:00:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:00:28 INFO - Reading from file tmpfile_stdout 10:00:28 INFO - Output received: 10:00:28 INFO - Usage: mozinstall [options] installer 10:00:28 INFO - Options: 10:00:28 INFO - -h, --help show this help message and exit 10:00:28 INFO - -d DEST, --destination=DEST 10:00:28 INFO - Directory to install application into. [default: 10:00:28 INFO - "/builds/slave/test"] 10:00:28 INFO - --app=APP Application being installed. [default: firefox] 10:00:28 INFO - mkdir: /builds/slave/test/build/application 10:00:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:00:42 INFO - Reading from file tmpfile_stdout 10:00:42 INFO - Output received: 10:00:42 INFO - /builds/slave/test/build/application/firefox/firefox 10:00:42 INFO - Running post-action listener: _resource_record_post_action 10:00:42 INFO - [mozharness: 2017-02-01 18:00:42.213163Z] Finished install step (success) 10:00:42 INFO - [mozharness: 2017-02-01 18:00:42.213458Z] Running run-tests step. 10:00:42 INFO - Running pre-action listener: _resource_record_pre_action 10:00:42 INFO - Running main action method: run_tests 10:00:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:00:42 INFO - Python 2.7.3 10:00:42 INFO - Return code: 0 10:00:42 INFO - grabbing minidump binary from tooltool 10:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:42 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 0x14e3f60>, '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 0x14e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e51d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:00:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:00:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:00:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:00:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:00:42 INFO - Return code: 0 10:00:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:00:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:00:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:00:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:00:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:00:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:00:42 INFO - Using env: {'DISPLAY': ':0', 10:00:42 INFO - 'HOME': '/home/cltbld', 10:00:42 INFO - 'LANG': 'en_US.UTF-8', 10:00:42 INFO - 'LANGUAGE': 'en_US:en', 10:00:42 INFO - 'LOGNAME': 'cltbld', 10:00:42 INFO - 'MAIL': '/var/mail/cltbld', 10:00:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:00:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:42 INFO - 'MOZ_NO_REMOTE': '1', 10:00:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:42 INFO - 'NO_EM_RESTART': '1', 10:00:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:42 INFO - 'PWD': '/builds/slave/test', 10:00:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:00:42 INFO - 'SHELL': '/bin/bash', 10:00:42 INFO - 'SHLVL': '1', 10:00:42 INFO - 'TERM': 'linux', 10:00:42 INFO - 'TMOUT': '86400', 10:00:42 INFO - 'USER': 'cltbld', 10:00:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738', 10:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:42 INFO - '_': '/tools/buildbot/bin/python'} 10:00:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:00:42 INFO - mozversion application_buildid: 20170201075009 10:00:42 INFO - mozversion application_changeset: d13a909fc8a10c8a691f4fc386b290a995d18f32 10:00:42 INFO - mozversion application_display_name: Firefox 10:00:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:00:42 INFO - mozversion application_name: Firefox 10:00:42 INFO - mozversion application_remotingname: firefox 10:00:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:00:42 INFO - mozversion application_vendor: Mozilla 10:00:42 INFO - mozversion application_version: 52.0 10:00:42 INFO - mozversion platform_buildid: 20170201075009 10:00:42 INFO - mozversion platform_changeset: d13a909fc8a10c8a691f4fc386b290a995d18f32 10:00:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:00:42 INFO - mozversion platform_version: 52.0 10:00:42 INFO - using testdate: 1485972042 10:00:42 INFO - actual date: 1485972042 10:00:42 INFO - starting webserver on 'localhost:60941' 10:00:42 INFO - SUITE-START | Running 2 tests 10:00:42 INFO - TEST-START | dromaeo_css 10:00:42 INFO - operating with platform_type : linux_ 10:00:42 INFO - Initialising browser for dromaeo_css test... 10:00:42 INFO - TEST-INFO | started process 13089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8zkB9l/profile http://localhost:60941/getInfo.html) 10:00:46 INFO - PROCESS | 13089 | __metrics Screen width/height:1600/1200 10:00:46 INFO - PROCESS | 13089 | colorDepth:24 10:00:46 INFO - PROCESS | 13089 | Browser inner width/height: 1024/697 10:00:46 INFO - PROCESS | 13089 | __metrics 10:00:47 INFO - PROCESS | 13089 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:00:47 INFO - PROCESS | 13089 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:00:48 INFO - PROCESS | 13089 | console.error: PushService: 10:00:48 INFO - PROCESS | 13089 | stateChangeProcessEnqueue: Error transitioning state 10:00:48 INFO - PROCESS | 13089 | UnknownError 10:00:48 INFO - TEST-INFO | 13089: exit 0 10:00:48 INFO - Browser initialized. 10:00:48 INFO - Running cycle 1/1 for dromaeo_css test... 10:00:48 INFO - TEST-INFO | started process 13184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8zkB9l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:01:00 INFO - PROCESS | 13184 | RSS: Main: 141340672 10:01:00 INFO - PROCESS | 13184 | 10:04:01 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:60941/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60941/tests/dromaeo/cssquery-ext.html) 10:04:03 INFO - PROCESS | 13184 | RSS: Main: 243367936 10:04:03 INFO - PROCESS | 13184 | 10:07:05 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:60941/tests/dromaeo/cssquery-ext.html (next: http://localhost:60941/tests/dromaeo/cssquery-jquery.html) 10:07:05 INFO - PROCESS | 13184 | RSS: Main: 238739456 10:07:05 INFO - PROCESS | 13184 | 10:10:07 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:60941/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60941/tests/dromaeo/cssquery-mootools.html) 10:10:08 INFO - PROCESS | 13184 | RSS: Main: 174379008 10:10:08 INFO - PROCESS | 13184 | 10:13:10 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:60941/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60941/tests/dromaeo/cssquery-prototype.html) 10:13:10 INFO - PROCESS | 13184 | RSS: Main: 218497024 10:13:10 INFO - PROCESS | 13184 | 10:16:13 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:60941/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60941/tests/dromaeo/cssquery-yui.html) 10:16:13 INFO - PROCESS | 13184 | RSS: Main: 175996928 10:16:13 INFO - PROCESS | 13184 | 10:19:16 INFO - PROCESS | 13184 | Cycle 1(1): loaded http://localhost:60941/tests/dromaeo/cssquery-yui.html (next: http://localhost:60941/tests/dromaeo/cssquery-dojo.html) 10:19:16 INFO - PROCESS | 13184 | RSS: Main: 269504512 10:19:16 INFO - PROCESS | 13184 | 10:19:16 INFO - PROCESS | 13184 | __start_tp_report 10:19:16 INFO - PROCESS | 13184 | _x_x_mozilla_page_load 10:19:16 INFO - PROCESS | 13184 | _x_x_mozilla_page_load_details 10:19:16 INFO - PROCESS | 13184 | |i|pagename|runs| 10:19:16 INFO - PROCESS | 13184 | |0;dojo.html;3269.3134441767234;3305.8677652893884;3306.3222039481907;3335.966640333596;3355.5637767090275;5591.496765291123;5694.715264236782;5698.373178950317;5699.857503562413;5725.656460612367;5612.298462692163;5652.0391533439315;5653.378128405872;5658.405867383927;5681.091025435931;5074.517920797528;5086.618503612225;5106.387233531963;5140.588752899759;5170.431252562215;5015.272785446108;5021.824236151735;5052.949470505285;5216.356847593015;5254.343207099113;5082.593392528607;5188.792448302063;5195.688258704471;5201.375834899817;5203.1414816555225;5188.195829646411;5197.038547868657;5200.271961925334;5204.713740744258;5232.92150617741;4934.80260789568;5050.444451110375;5090.08378491875;5108.463611320833;5157.922631160535;5501.614886957915;5504;5524.944750552483;5528.695921724304;5580.91628625571;5990.580659353847;6003.369646187175;6055.212822333113;6099.603525770811;6100.572959892809;6137.877242455126;6140.785072522441;6145;6147.354527774609;6153.907691384633;5472.2338872557875;5528.170774383834;5604.579656525736;5649.689267090267;5660.518855897295;6210.757848430332;6215.595986260879;6222.377762223741;6222.564420490522;6233.594816336924;5976.282846058414;5983.341832398432;5992.191054207626;5994.490468310242;5996.610220335664;5764.682942438206;5883.852903677357;5963.731632076567;5991.310999235056;6011.729472173763;6042.093685947055;6049.8487537811025;6050.183225264533;6053;6066.514678825772;6000.699965001732;6041.365656605993;6044.395560443921;6044.486218671462;6087.908681369783;4488.0126372198065;4508.752018639007;4536.138133754576;4598.770061496912;4686.531346865286;4057.5130984282073;4080.7347522410946;4084.4894388201474;4089.7137200395687;4089.9182016359505;5629.746661400247;5689.175069614966;5704.686242256716;5710.057840456278;5718.085106383042;6002;6006.909896351558;6049.153118563405;6054.39456054391;6059.757609695651;5580.91628625571;5600;5672.262605861211;5677.630953987978;5680.7727690892725;5075.796968121308;5153.665011774223;5162.92255616166;5177.430482646906;5245;6304.306526282106;6317.526185536103;6332.6200427973545;6376.872462550816;6382.266039405435;6068.271807383142;6073.423024812636;6113.724882380215;6125.081237814364;6137.877242455215;6086.817395478142;6129.478994285536;6130.325664176848;6208.192934918432;6373.203349581302;5889.352171261072;5892.823215303548;5893.852653683693;5895;5897.3807750185615;5953.958057340034;6064.605800622945;6093.360197179232;6144.2319710036245;6146.354632763674;5934.19888315072;5954.702264886825;5956.493698035715;5957.225560677258;5992.191054207626;5966.105084237399;5984.251968503937;5985.581009329305;5994.760209591567;5997.13041608973;5659.207710920392;5698.430156984434;5706.258186435737;5724.084146536534;5787.594868359174;5794.304683438015;5805;5805;5810.070388737781;5811.854703632443;5642.633228840113;5642.689652069175;5652.604317697722;5653.2085508028085;5656.236408084856 10:19:16 INFO - PROCESS | 13184 | |1;ext.html;589.716935870782;611.9418655227753;651.4234902111631;663.1743479368184;669.7086767256241;36672;45556.088878222414;46799.064018719604;46826.76586617067;51184.23223651648;48067.27899081517;48551.02897942039;48568.757156214255;48621;48683.269750953674;8384.413091083627;9003.09969003101;9062.909370906273;9127.497987610679;9148.17666410023;8442.535660538668;10706.678799636024;10994.945025274863;10995.450227488633;11329.433528323592;10933.781324373507;11004;11004.229703920688;11008.174386920973;11013.559457621686;11003.669889903316;11052.447377631166;11054.944725276362;11066.114710823114;11068.114550835995;10750.784984300348;10798.190135739773;10809.189310801721;10810.405427701473;10821.080208182313;44718;45087;45102.548974510166;45111.32333015007;45113.77443112763;3894.493715816954;3973.4635824163656;4132.235536425771;4232.597903199191;4424.424824772791;32913.177170570685;33117.503237451456;33327.862248019104;33400;33561;4499.055198408339;4522.796474158671;4527.615152712024;4580.381648477446;4711.93981354196;376198;377800;378076;379029;379585.99999999726;37428;62600.373996260365;62959.370406296264;63029;63059;38817.22365552673;41217;41514;41532.58467415348;41556.792216038724;16678.166091695366;16742.74885876713;16797.664046718997;16798.66402671964;16802.831971680127;13049.804252936214;13348.132371395828;13984.930075349557;14595.197264150362;14700.41198352054;9611.519424028771;9622.037796220462;9634.470104144199;9637.518124093767;9712.271579631555;3611.133328001313;3660.7071434285194;3705;3765.548134223911;3776.546814382237;1065.7602039541196;1073.2111897755144;1097.8078836203633;1140.8973192412723;1151.9136064795173;32167.26578240829;33772.49341259883;33822.661773382446;33991.83004085013;34035.65964340374;1100.878903320634;1151.980497259931;1154.468944285638;1160.8955194032578;1228.263042174688;16162.75755863663;16711.498655040366;16717.49847504577;16989.46958462538;16994.49016529506;572344;578006;578094;579116;579650;61249.693751530955;61562.69218653968;61566;61657.69171154205;61719.38280617226;1344.6571124363224;1385.1342910681026;1395.413926151019;1436.5690292912084;1442.0410427066092;32018.679813202503;34308.82845585756;34363.65636343705;34529.30941381209;34613.65386346104;52267.47732522778;52947.20579191238;52968.20547691865;52974.735126325664;53060.469395305554;435759;436078;436992;437041;442244;26408.20775376742;27772.86113569419;28461.146165615064;30083.548746768378;30128.09615711532;46088.769556152;46142.538574615166;46213;46272.30591541197;46671.29993050039;44231.77884110559;44800;45220.77389613031;47173.29240061333;49360;43083.569164307955;43176.784116079216;44243.778781107176;46706.29940550827;47914.760426197645;45887.54112458833;47129.764351178026;47214.29178562393;47382.28926566035;47598.28602570895;42883;43378.566214338716;44292.11415771731;45386.319205211286;45763.54236457593;30180.396392072475;30632.387352253278;30716;30819.383612328078;30966.380672385974 10:19:16 INFO - PROCESS | 13184 | |2;jquery.html;409.9098198396352;420.6298457357525;427.3440269186799;431.85316992222636;439.39583073274247;18632.62734745306;19087.141078651475;20190.192392304307;20346.69479957798;20635;19364.70952935707;19424.417267481964;19663.115159817808;19833.603327933433;19837.603247935032;5533.6956467394175;5807.9419205808035;5812.447817457335;5814.069748840187;5816.214811000503;5487.2317875497465;5569.554435645138;5665.8583535411735;5668.093105103184;5680.0627896397045;5630.352509461403;5638.520725738317;5643.6049476536655;5660.518855897254;5664.688442135681;5571.4428557144365;5591.916121258185;5615.550755939515;5639.182318563806;5646.74589643465;5183.144781111112;5190.4031036430915;5191;5191.896162076775;5193.350831146106;22607.434814129614;23436.53126937469;23439;23505.882470587538;23678.052877884864;2454.779069883701;2549.4391233928504;2618.5417551928335;2623.27859838544;2885.480613489571;10461.68614941553;10994.34033957965;14587.927060364631;14795.926020369829;15129;2016.2741413091276;2022.7673817511027;2026.4224695961727;2030.2285131650026;2032.5629989552317;78399.60800195963;79292.60353698194;80222.19777802206;81467.18532814656;81879;11619.244749091282;11629.941850290863;11953.880461195451;11973.341466219441;12048.939755301342;17098.230579623945;17122.914385427994;17146.228419720894;17146.914265428593;17171.227294771765;8845.601947912231;8916.19754222123;8972.730818075468;9101.590428430736;9134.81730365389;8437.746867593982;8555.828883422297;8590;8590.87113693295;8823.117688231254;5034.647574669812;5138.691678499302;5155.6391052626705;5228.92156617651;5252.44849290819;1838.9356372526897;1899.848012159024;2090.8850013249416;2125.1499400240027;2165.545235500531;946.3044662173297;961.2694352292168;1044.013407330081;1075.4515197249302;1120.7447658622232;20182.89908550448;20224.393268201977;20253.29113481021;20342.389728308175;20387.59224815525;980.7302991677203;988.5057471264367;992.1318846009741;1053.1943063556384;1077.2028698762858;10779.407132607781;11144.164187685956;11150.832737508943;11192.552297908156;11329.660110196708;455650;477533;485555;487343;488323;63140.684296579144;92930;92973.53513232525;93574.53212733893;94891;1008.3042700536606;1015.3704703084135;1032.829583118792;1036.3108532825586;1056.3503445381036;14122;18080.276788928295;18197.272109116017;18310.450686479428;18664.066796660383;30374;43751.56248437602;43837.34243986279;43894;44423.555764443234;59400.40599593949;59421;60705;64346;66573;8774.29805615562;8803.691870784492;8892;8968.68609598687;9139;12541;13389.66525836862;13578.864211358155;13868.791968120284;14399.640008999859;12269.93865030669;12338.75322493563;12407.553459025736;12540.937295313464;12544.686382840502;11535.192536522363;11641.243319184226;11642.476088576204;11726.355050471964;12040.75918481643;6264.091706702594;8773.736787896374;11813.822792657946;12553.874461255271;12601.18092323996;9205.355625106178;9236.16874481273;9269.212116970133;9405.670801521914;9605.711828645151;9089.363744538083;11669.76660466769;12414.62756117318;12470.438830252842;12632 10:19:16 INFO - PROCESS | 13184 | |3;mootools.html;1531.724289627867;1536.7694845773135;1711.5122190175803;1802.2790883646549;1807.5932915094097;8546.230839224469;9108.681196158135;9152.176304132636;9163.95418022909;9172.312076594257;7880.724174653888;8069.757907262777;8090;8301.750947471586;8959.820803583925;2455.054803900498;2534.746525347469;2541.2122242104915;2559.846409215453;2565.9101931432406;2452.362385779701;2481.900723971048;2503.7496250374998;2505.08564374004;2524;2466.839655422401;2474.4679893822827;2493.2021753039035;2498.837575557583;2499.275210189043;2473.6660550825677;2493.4265119022543;2496.400863792695;2499.4376265340334;2505.073122944513;2445.4375493636385;2506.7618576235227;2509.636102765107;2511.384710745879;2515.5094756522485;8934.463932164092;9061.456312621263;9085.454872707658;9119.863202051974;9153.771155721093;5503.091989821674;5646.717664116778;5648.293963254593;5650.180723795068;5652.689102099383;3212.421764082464;3263.282077942849;3408.84660190292;3470.774399664014;3478.808665523395;1028.1671845804922;1030.577463240068;1054.583439541377;1088.472091035847;1092.5848177692505;12047.6385708428;12177.93911030448;12256.509739610405;12681.175723577939;12785.10504264702;4742.502037286035;4752.120857641278;4801.53426508808;4862.027594481047;4907.141250281186;10047.447390393452;10122.493875306205;10125.240606954509;10137.898621013843;10150.492475376202;5585.497305242548;5590.273264475592;5595.776168953278;5599.972000139973;5600.663960162403;4443.133588950123;4986.301917731521;5125.846224613268;5176.559992400613;5250.579953603703;3730.626937306248;3971.980140099281;4118.670506359484;4141.151064031867;4149.149424368058;1221.7678641058171;1267.5943698016547;1278.3033246880473;1280.5582074184392;1299.4477347127433;896.2292428511475;1009.1321463541349;1009.6920439265947;1012.772126271583;1014.9137323327452;5454.481824226692;5613.915791263134;5805.10020946754;5815.82552523425;6018.849528761729;948.800751842107;948.9145976862116;953.5518306395983;969.539468752337;991.1327588360185;4151.750894946313;4167.06241095751;4196.076863090177;4250.149970006011;4266.573342665709;10919.39943303126;11180.832287515694;11434.199606027498;11439.656810295704;11483.827742583868;11129.499172537093;11360.091192704564;11367.147463940073;11368.715782105513;11384.658460246206;8449.32405407566;8728.170823771732;8785.912140878638;8799.560021999003;8803.867941980747;5876;5922.200502932049;5968.97015514937;5999.130126131774;6043.667598282137;10332.225083118647;10426.009529094725;10459.790804184026;10540.051395374454;10556.15550755953;9915.752106197402;10202.030807073315;10318.587256509656;10535.78928421412;10583.894161058599;7264.782056538313;7663.923360766321;7787.4548781584745;7787.610619468891;7792.922070779219;7707.306342429209;8378.371622128243;8530.189631984951;8730.65077396897;8735.606897689491;7506.099268087864;7542.057242844645;7636.427267954815;7807.375409967302;7864.60676966138;7421.777346679608;7581.355584775356;7677.462577619513;7687.923120768721;7850.646720897459;7208.06295181623;7362.889556656547;7365.116186057708;7367.410607151308;7379.3727533158135;5237.8428647140645;5266;5280.524752772269;5283.947160528345;5446.373667028342;5266.210068489757;5275.103232450416;5326.280952071421;5382.111951527954;5382.3541175059245 10:19:16 INFO - PROCESS | 13184 | |4;prototype.html;345.8098046074658;349.355439214649;355.6283683550689;359.186442707268;359.6134155782533;5488.69812160332;5548.250986116873;5561.193626924104;5573.972130139348;5597.300337457823;5127.435982041981;5223.660462069973;5290.7354632268325;5354.866128346794;5408.675479471234;4291.592298731631;4298.806553705075;4305.655547556204;4318.417013703149;4336.56634336567;4317.978410107945;4328.675349348796;4335.609795118438;4342.218400687875;4377.277749171383;4077.7349472284354;4202.684798640099;4234.618884300427;4241.8303267869405;4295.957040429603;4197.139586384784;4228.725132866384;4228.809703563316;4242.8727138185905;4256.212600668886;3745.3445647011663;3754.4743735877;3759.285735710206;3767.9058023549355;3787.7159213058853;5301.799753102497;5307.203919412081;5334.333208348957;5398.379186393576;5439.286624713242;4835.564799168056;4842.297866809293;4901.607871370282;4909.239067944474;4915.599054269552;5666.1784041314195;5676.631018983794;5685.772569097231;5697.629654072513;5750.88498230033;3975.1714211462763;4077.103037331782;4148.709590328678;4180.554375690225;4220.134872351191;5904.822855314347;5911.290645122613;5924.851878703023;5925.822225333247;5939.465448109648;4230.640395566411;4233.682473814476;4234.830606775756;4244.665434011343;4265.914681706348;4199.160167966419;4247.51153617338;4266.253405653998;4304.89237769052;4307.590778876001;4842.128416884924;4842.491538388489;4849.593617850784;4865.854024379274;4868.659193856396;5728.255326807572;5742.483176514133;5749.281339832521;5785.50823180026;5787.131930210502;1407.289318893952;1432.484305649965;1444.7173465923815;1444.8771854392285;1461.5615315405548;978.7357413498315;990.4796137928389;1002.7443002034435;1003.8343673293971;1006.9395836249848;5310.141450492297;5311.3891902431715;5313.946860531345;5333.839984800462;5348.91976620351;5546.195801608744;5626.1842032905815;5649.406812284733;5655.434456554394;5658.245943757448;5170.71561064145;5242.868928276824;5324.3078399808555;5362.490563396471;5368.9731551342775;2976.479116154664;3016.0348688419936;3016.622922134733;3019.5168772996217;3025.243689077731;5875.119961612243;5875.529957603381;5902.61632993854;6031.24609423822;6032.668203248863;5612.214289999403;5719.5996280260815;5749.310082790092;5802.736932596291;5817.476427121494;5821.243238378984;5845.707714614252;5870.26621672291;5881.323647780475;5922.289325280994;5576.414476480073;5646.548276137817;5654.434556544313;5699.544036476989;5928.34788173292;5885.146653735099;5895.349302195392;5896.233489646319;5903.970480147744;5907.9704601476715;6078.422549857756;6090.878182436415;6144.324124346408;6164.4143806338325;6170.290416602148;4049.433079368832;4061.5126184858004;4218.620324170839;4236.364545318227;4255.276612971751;5716.9142462862255;5732.34078081026;5860.706964651836;5862.237909071793;5881.235439392852;5711.971440142773;5720.914186287126;5721.713914304351;5722.942770572241;5732.16883551891;5462.808801691922;5714.771409143587;5719.5138413235345;5722.828315150552;5729.140628905698;5731.5128214100605;5731.684757338387;5736.4550367715;5744.971275143597;5756.107803290497;5627.409122042127;5760.300711290263;5787.884242315215;5790.1893734877995;5811.389804070512;5580.581456390706;5582.274304340573;5612.719364031864;5616.550675945833;5656.69895923948 10:19:16 INFO - PROCESS | 13184 | |5;yui.html;802.0095182449674;809.676129548181;832.2301870769538;836.1429534726906;897.2373482539838;13985.230812305319;14030.719385612281;14091.365888535014;14161.71676566468;14426.134431934079;14377.78433323501;14381.78427323591;14424.278786060708;14742.189179595118;14882.181480018595;747.8018325143842;774.8295375017487;872.201935229266;887.8668199770021;890.0832142892831;846.5597889097666;887.1970866365949;892.7768057985504;896.1486587741672;896.5696465696437;927.8283517549241;929.944203347798;930.2093220762365;930.3487558708897;930.5161316115616;918.2103391083663;919.6781126605634;919.9862002069974;920.4707293306309;920.5397301349359;672.6434989455596;679.1680191765098;679.2426444514381;679.3342524326139;679.8776220280348;14671;15008.774868376982;15099.773503397459;15127.697446051128;15156.1664108474;14479.493217737328;14903.701925961528;15035.323410446555;15489.92255038729;15548.833837462236;11845.822312665317;11972.700682483008;12060.879391206063;12067.758644827054;12123.575674851338;3816.2939856126427;3865.9806700966597;3866.729328946975;3872.9806350968347;3934.3311637021775;61772.69113654403;62597;62605;67575.66212168957;68565.65717171482;10666.946665266623;10785.56857725698;10875.619353322754;11051.115910727123;11136.554537818558;21220;21323.46691332729;21487.892560537097;21514.46213844635;21606.24378146789;7941.404394670423;7959.761207163794;8204.097549269576;8217.506949583045;8249.422540422112;4409.404730361424;4554;4604.654650901196;4610.400647915817;4709;3626.202235508184;3743.513343265358;3749.5875453700073;3752.155764952918;3754.4743735877;696.5437638346891;715.5098757351232;726.3100054947821;726.6911562585985;745.6271864067966;652.2205963873126;780.344510611078;782.8121250899857;786.7167819584945;789.7354386280546;9453.196478299422;9774.218062554979;9777.41335519871;10139.087482126644;10215.897841021644;691.7820886420761;701.4038067642463;730.4193166432699;765.9808504787425;783.2363445640569;4578.908421831611;4692.202325604655;4803.735794531264;4883.682560633548;4921.089598424303;89747;92875.53562232146;93463.53268233615;93903.53048234715;95093.52453237827;77915.61042194752;81532;81787.5910620443;81908.59045704734;83150.16849831425;75168.24831751722;76281;76305.61847190729;76539.61730191424;78228.60885695649;9100.817983640158;9450.196733277473;9539.713808585753;9688.660896868576;9731.805363892825;49972.75013624909;51154;51198;51242.23136653028;51637.48362516477;60013;60652.39347606644;67392.6630366845;69889.65055174692;71020.64489677518;11230.831537527107;11445.828312575484;11455.770884582429;11557.28603934387;11790.174687771774;13587.728245435233;13620.046596738133;13671.521496747964;13737.793933091212;13807.51673691416;12087.274763514217;12357.567485137977;12605.558805441766;12657.810132848199;13063.346832658139;12258.754824903273;12277.570285039981;12282.81575776382;12855.935720321339;12974.740505189655;11718.23831450953;12027.879721202677;12112.697182570153;12576.496940122293;12724.1729287596;10359.896401036194;10477;10665.573377064831;10815.945920270347;10869.239153259512;10106.140978016656;10229.335093218917;10234.48827558634;10306.433146177033;10328.586856525655 10:19:16 INFO - PROCESS | 13184 | __end_tp_report 10:19:16 INFO - PROCESS | 13184 | __start_cc_report 10:19:16 INFO - PROCESS | 13184 | _x_x_mozilla_cycle_collect,1001 10:19:16 INFO - PROCESS | 13184 | __end_cc_report 10:19:16 INFO - PROCESS | 13184 | __startTimestamp1485973156538__endTimestamp 10:19:16 INFO - PROCESS | 13184 | 10:19:16 INFO - PROCESS | 13184 | ------- Summary: start ------- 10:19:16 INFO - PROCESS | 13184 | Number of tests: 6 10:19:16 INFO - PROCESS | 13184 | 10:19:16 INFO - PROCESS | 13184 | [#0] dojo.html Cycles:165 Average:5598.56 Median:5724.08 stddev:641.96 (11.2%) stddev-sans-first:617.38 10:19:16 INFO - PROCESS | 13184 | Values: 3269.3 3305.9 3306.3 3336.0 3355.6 5591.5 5694.7 5698.4 5699.9 5725.7 5612.3 5652.0 5653.4 5658.4 5681.1 5074.5 5086.6 5106.4 5140.6 5170.4 5015.3 5021.8 5052.9 5216.4 5254.3 5082.6 5188.8 5195.7 5201.4 5203.1 5188.2 5197.0 5200.3 5204.7 5232.9 4934.8 5050.4 5090.1 5108.5 5157.9 5501.6 5504.0 5524.9 5528.7 5580.9 5990.6 6003.4 6055.2 6099.6 6100.6 6137.9 6140.8 6145.0 6147.4 6153.9 5472.2 5528.2 5604.6 5649.7 5660.5 6210.8 6215.6 6222.4 6222.6 6233.6 5976.3 5983.3 5992.2 5994.5 5996.6 5764.7 5883.9 5963.7 5991.3 6011.7 6042.1 6049.8 6050.2 6053.0 6066.5 6000.7 6041.4 6044.4 6044.5 6087.9 4488.0 4508.8 4536.1 4598.8 4686.5 4057.5 4080.7 4084.5 4089.7 4089.9 5629.7 5689.2 5704.7 5710.1 5718.1 6002.0 6006.9 6049.2 6054.4 6059.8 5580.9 5600.0 5672.3 5677.6 5680.8 5075.8 5153.7 5162.9 5177.4 5245.0 6304.3 6317.5 6332.6 6376.9 6382.3 6068.3 6073.4 6113.7 6125.1 6137.9 6086.8 6129.5 6130.3 6208.2 6373.2 5889.4 5892.8 5893.9 5895.0 5897.4 5954.0 6064.6 6093.4 6144.2 6146.4 5934.2 5954.7 5956.5 5957.2 5992.2 5966.1 5984.3 5985.6 5994.8 5997.1 5659.2 5698.4 5706.3 5724.1 5787.6 5794.3 5805.0 5805.0 5810.1 5811.9 5642.6 5642.7 5652.6 5653.2 5656.2 10:19:16 INFO - PROCESS | 13184 | 10:19:16 INFO - PROCESS | 13184 | [#1] ext.html Cycles:180 Average:62782.82 Median:22823.12 stddev:125216.22 (548.6%) stddev-sans-first:125480.42 10:19:16 INFO - PROCESS | 13184 | Values: 589.7 611.9 651.4 663.2 669.7 36672.0 45556.1 46799.1 46826.8 51184.2 48067.3 48551.0 48568.8 48621.0 48683.3 8384.4 9003.1 9062.9 9127.5 9148.2 8442.5 10706.7 10994.9 10995.5 11329.4 10933.8 11004.0 11004.2 11008.2 11013.6 11003.7 11052.4 11054.9 11066.1 11068.1 10750.8 10798.2 10809.2 10810.4 10821.1 44718.0 45087.0 45102.5 45111.3 45113.8 3894.5 3973.5 4132.2 4232.6 4424.4 32913.2 33117.5 33327.9 33400.0 33561.0 4499.1 4522.8 4527.6 4580.4 4711.9 376198.0 377800.0 378076.0 379029.0 379586.0 37428.0 62600.4 62959.4 63029.0 63059.0 38817.2 41217.0 41514.0 41532.6 41556.8 16678.2 16742.7 16797.7 16798.7 16802.8 13049.8 13348.1 13984.9 14595.2 14700.4 9611.5 9622.0 9634.5 9637.5 9712.3 3611.1 3660.7 3705.0 3765.5 3776.5 1065.8 1073.2 1097.8 1140.9 1151.9 32167.3 33772.5 33822.7 33991.8 34035.7 1100.9 1152.0 1154.5 1160.9 1228.3 16162.8 16711.5 16717.5 16989.5 16994.5 572344.0 578006.0 578094.0 579116.0 579650.0 61249.7 61562.7 61566.0 61657.7 61719.4 1344.7 1385.1 1395.4 1436.6 1442.0 32018.7 34308.8 34363.7 34529.3 34613.7 52267.5 52947.2 52968.2 52974.7 53060.5 435759.0 436078.0 436992.0 437041.0 442244.0 26408.2 27772.9 28461.1 30083.5 30128.1 46088.8 46142.5 46213.0 46272.3 46671.3 44231.8 44800.0 45220.8 47173.3 49360.0 43083.6 43176.8 44243.8 46706.3 47914.8 45887.5 47129.8 47214.3 47382.3 47598.3 42883.0 43378.6 44292.1 45386.3 45763.5 30180.4 30632.4 30716.0 30819.4 30966.4 10:19:16 INFO - PROCESS | 13184 | 10:19:16 INFO - PROCESS | 13184 | [#2] jquery.html Cycles:180 Average:28959.20 Median:2754.38 stddev:78951.65 (2866.4%) stddev-sans-first:79144.03 10:19:16 INFO - PROCESS | 13184 | Values: 409.9 420.6 427.3 431.9 439.4 18632.6 19087.1 20190.2 20346.7 20635.0 19364.7 19424.4 19663.1 19833.6 19837.6 5533.7 5807.9 5812.4 5814.1 5816.2 5487.2 5569.6 5665.9 5668.1 5680.1 5630.4 5638.5 5643.6 5660.5 5664.7 5571.4 5591.9 5615.6 5639.2 5646.7 5183.1 5190.4 5191.0 5191.9 5193.4 22607.4 23436.5 23439.0 23505.9 23678.1 2454.8 2549.4 2618.5 2623.3 2885.5 10461.7 10994.3 14587.9 14795.9 15129.0 2016.3 2022.8 2026.4 2030.2 2032.6 78399.6 79292.6 80222.2 81467.2 81879.0 11619.2 11629.9 11953.9 11973.3 12048.9 17098.2 17122.9 17146.2 17146.9 17171.2 8845.6 8916.2 8972.7 9101.6 9134.8 8437.7 8555.8 8590.0 8590.9 8823.1 5034.6 5138.7 5155.6 5228.9 5252.4 1838.9 1899.8 2090.9 2125.1 2165.5 946.3 961.3 1044.0 1075.5 1120.7 20182.9 20224.4 20253.3 20342.4 20387.6 980.7 988.5 992.1 1053.2 1077.2 10779.4 11144.2 11150.8 11192.6 11329.7 455650.0 477533.0 485555.0 487343.0 488323.0 63140.7 92930.0 92973.5 93574.5 94891.0 1008.3 1015.4 1032.8 1036.3 1056.4 14122.0 18080.3 18197.3 18310.5 18664.1 30374.0 43751.6 43837.3 43894.0 44423.6 59400.4 59421.0 60705.0 64346.0 66573.0 8774.3 8803.7 8892.0 8968.7 9139.0 12541.0 13389.7 13578.9 13868.8 14399.6 12269.9 12338.8 12407.6 12540.9 12544.7 11535.2 11641.2 11642.5 11726.4 12040.8 6264.1 8773.7 11813.8 12553.9 12601.2 9205.4 9236.2 9269.2 9405.7 9605.7 9089.4 11669.8 12414.6 12470.4 12632.0 10:19:16 INFO - PROCESS | 13184 | 10:19:16 INFO - PROCESS | 13184 | [#3] mootools.html Cycles:180 Average:5919.65 Median:4776.83 stddev:3322.40 (69.6%) stddev-sans-first:3315.35 10:19:16 INFO - PROCESS | 13184 | Values: 1531.7 1536.8 1711.5 1802.3 1807.6 8546.2 9108.7 9152.2 9164.0 9172.3 7880.7 8069.8 8090.0 8301.8 8959.8 2455.1 2534.7 2541.2 2559.8 2565.9 2452.4 2481.9 2503.7 2505.1 2524.0 2466.8 2474.5 2493.2 2498.8 2499.3 2473.7 2493.4 2496.4 2499.4 2505.1 2445.4 2506.8 2509.6 2511.4 2515.5 8934.5 9061.5 9085.5 9119.9 9153.8 5503.1 5646.7 5648.3 5650.2 5652.7 3212.4 3263.3 3408.8 3470.8 3478.8 1028.2 1030.6 1054.6 1088.5 1092.6 12047.6 12177.9 12256.5 12681.2 12785.1 4742.5 4752.1 4801.5 4862.0 4907.1 10047.4 10122.5 10125.2 10137.9 10150.5 5585.5 5590.3 5595.8 5600.0 5600.7 4443.1 4986.3 5125.8 5176.6 5250.6 3730.6 3972.0 4118.7 4141.2 4149.1 1221.8 1267.6 1278.3 1280.6 1299.4 896.2 1009.1 1009.7 1012.8 1014.9 5454.5 5613.9 5805.1 5815.8 6018.8 948.8 948.9 953.6 969.5 991.1 4151.8 4167.1 4196.1 4250.1 4266.6 10919.4 11180.8 11434.2 11439.7 11483.8 11129.5 11360.1 11367.1 11368.7 11384.7 8449.3 8728.2 8785.9 8799.6 8803.9 5876.0 5922.2 5969.0 5999.1 6043.7 10332.2 10426.0 10459.8 10540.1 10556.2 9915.8 10202.0 10318.6 10535.8 10583.9 7264.8 7663.9 7787.5 7787.6 7792.9 7707.3 8378.4 8530.2 8730.7 8735.6 7506.1 7542.1 7636.4 7807.4 7864.6 7421.8 7581.4 7677.5 7687.9 7850.6 7208.1 7362.9 7365.1 7367.4 7379.4 5237.8 5266.0 5280.5 5283.9 5446.4 5266.2 5275.1 5326.3 5382.1 5382.4 10:19:16 INFO - PROCESS | 13184 | 10:19:16 INFO - PROCESS | 13184 | [#4] prototype.html Cycles:180 Average:4793.88 Median:5403.53 stddev:1398.24 (25.9%) stddev-sans-first:1361.73 10:19:16 INFO - PROCESS | 13184 | Values: 345.8 349.4 355.6 359.2 359.6 5488.7 5548.3 5561.2 5574.0 5597.3 5127.4 5223.7 5290.7 5354.9 5408.7 4291.6 4298.8 4305.7 4318.4 4336.6 4318.0 4328.7 4335.6 4342.2 4377.3 4077.7 4202.7 4234.6 4241.8 4296.0 4197.1 4228.7 4228.8 4242.9 4256.2 3745.3 3754.5 3759.3 3767.9 3787.7 5301.8 5307.2 5334.3 5398.4 5439.3 4835.6 4842.3 4901.6 4909.2 4915.6 5666.2 5676.6 5685.8 5697.6 5750.9 3975.2 4077.1 4148.7 4180.6 4220.1 5904.8 5911.3 5924.9 5925.8 5939.5 4230.6 4233.7 4234.8 4244.7 4265.9 4199.2 4247.5 4266.3 4304.9 4307.6 4842.1 4842.5 4849.6 4865.9 4868.7 5728.3 5742.5 5749.3 5785.5 5787.1 1407.3 1432.5 1444.7 1444.9 1461.6 978.7 990.5 1002.7 1003.8 1006.9 5310.1 5311.4 5313.9 5333.8 5348.9 5546.2 5626.2 5649.4 5655.4 5658.2 5170.7 5242.9 5324.3 5362.5 5369.0 2976.5 3016.0 3016.6 3019.5 3025.2 5875.1 5875.5 5902.6 6031.2 6032.7 5612.2 5719.6 5749.3 5802.7 5817.5 5821.2 5845.7 5870.3 5881.3 5922.3 5576.4 5646.5 5654.4 5699.5 5928.3 5885.1 5895.3 5896.2 5904.0 5908.0 6078.4 6090.9 6144.3 6164.4 6170.3 4049.4 4061.5 4218.6 4236.4 4255.3 5716.9 5732.3 5860.7 5862.2 5881.2 5712.0 5720.9 5721.7 5722.9 5732.2 5462.8 5714.8 5719.5 5722.8 5729.1 5731.5 5731.7 5736.5 5745.0 5756.1 5627.4 5760.3 5787.9 5790.2 5811.4 5580.6 5582.3 5612.7 5616.6 5656.7 10:19:16 INFO - PROCESS | 13184 | 10:19:16 INFO - PROCESS | 13184 | [#5] yui.html Cycles:180 Average:18625.03 Median:4902.39 stddev:25175.07 (513.5%) stddev-sans-first:25210.12 10:19:16 INFO - PROCESS | 13184 | Values: 802.0 809.7 832.2 836.1 897.2 13985.2 14030.7 14091.4 14161.7 14426.1 14377.8 14381.8 14424.3 14742.2 14882.2 747.8 774.8 872.2 887.9 890.1 846.6 887.2 892.8 896.1 896.6 927.8 929.9 930.2 930.3 930.5 918.2 919.7 920.0 920.5 920.5 672.6 679.2 679.2 679.3 679.9 14671.0 15008.8 15099.8 15127.7 15156.2 14479.5 14903.7 15035.3 15489.9 15548.8 11845.8 11972.7 12060.9 12067.8 12123.6 3816.3 3866.0 3866.7 3873.0 3934.3 61772.7 62597.0 62605.0 67575.7 68565.7 10666.9 10785.6 10875.6 11051.1 11136.6 21220.0 21323.5 21487.9 21514.5 21606.2 7941.4 7959.8 8204.1 8217.5 8249.4 4409.4 4554.0 4604.7 4610.4 4709.0 3626.2 3743.5 3749.6 3752.2 3754.5 696.5 715.5 726.3 726.7 745.6 652.2 780.3 782.8 786.7 789.7 9453.2 9774.2 9777.4 10139.1 10215.9 691.8 701.4 730.4 766.0 783.2 4578.9 4692.2 4803.7 4883.7 4921.1 89747.0 92875.5 93463.5 93903.5 95093.5 77915.6 81532.0 81787.6 81908.6 83150.2 75168.2 76281.0 76305.6 76539.6 78228.6 9100.8 9450.2 9539.7 9688.7 9731.8 49972.8 51154.0 51198.0 51242.2 51637.5 60013.0 60652.4 67392.7 69889.7 71020.6 11230.8 11445.8 11455.8 11557.3 11790.2 13587.7 13620.0 13671.5 13737.8 13807.5 12087.3 12357.6 12605.6 12657.8 13063.3 12258.8 12277.6 12282.8 12855.9 12974.7 11718.2 12027.9 12112.7 12576.5 12724.2 10359.9 10477.0 10665.6 10815.9 10869.2 10106.1 10229.3 10234.5 10306.4 10328.6 10:19:16 INFO - PROCESS | 13184 | -------- Summary: end -------- 10:19:16 INFO - PROCESS | 13184 | 10:19:17 INFO - TEST-INFO | 13184: exit 0 10:19:17 INFO - TEST-OK | dromaeo_css | took 1114906ms 10:19:17 INFO - TEST-START | kraken 10:19:17 INFO - operating with platform_type : linux_ 10:19:17 INFO - Initialising browser for kraken test... 10:19:17 INFO - TEST-INFO | started process 13489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoQ96pC/profile http://localhost:60941/getInfo.html) 10:19:21 INFO - PROCESS | 13489 | __metrics Screen width/height:1600/1200 10:19:21 INFO - PROCESS | 13489 | colorDepth:24 10:19:21 INFO - PROCESS | 13489 | Browser inner width/height: 1024/697 10:19:21 INFO - PROCESS | 13489 | __metrics 10:19:22 INFO - PROCESS | 13489 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:19:22 INFO - PROCESS | 13489 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:19:22 INFO - PROCESS | 13489 | console.error: PushService: 10:19:22 INFO - PROCESS | 13489 | stateChangeProcessEnqueue: Error transitioning state 10:19:22 INFO - PROCESS | 13489 | UnknownError 10:19:23 INFO - TEST-INFO | 13489: exit 0 10:19:23 INFO - Browser initialized. 10:19:23 INFO - Running cycle 1/1 for kraken test... 10:19:23 INFO - TEST-INFO | started process 13582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoQ96pC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:35 INFO - PROCESS | 13582 | RSS: Main: 145473536 10:19:35 INFO - PROCESS | 13582 | 10:19:37 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:60941/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60941/tests/kraken/driver.html?testName=audio-beat-detection) 10:19:38 INFO - PROCESS | 13582 | RSS: Main: 185999360 10:19:38 INFO - PROCESS | 13582 | 10:19:40 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:60941/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60941/tests/kraken/driver.html?testName=audio-dft) 10:19:41 INFO - PROCESS | 13582 | RSS: Main: 176979968 10:19:41 INFO - PROCESS | 13582 | 10:19:44 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:60941/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60941/tests/kraken/driver.html?testName=audio-fft) 10:19:44 INFO - PROCESS | 13582 | RSS: Main: 268075008 10:19:44 INFO - PROCESS | 13582 | 10:19:46 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:60941/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60941/tests/kraken/driver.html?testName=audio-oscillator) 10:19:47 INFO - PROCESS | 13582 | RSS: Main: 174690304 10:19:47 INFO - PROCESS | 13582 | 10:19:49 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:60941/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60941/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:19:50 INFO - PROCESS | 13582 | RSS: Main: 177455104 10:19:50 INFO - PROCESS | 13582 | 10:19:53 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:60941/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60941/tests/kraken/driver.html?testName=imaging-darkroom) 10:19:53 INFO - PROCESS | 13582 | RSS: Main: 216035328 10:19:53 INFO - PROCESS | 13582 | 10:19:57 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:60941/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60941/tests/kraken/driver.html?testName=imaging-desaturate) 10:19:57 INFO - PROCESS | 13582 | RSS: Main: 214319104 10:19:57 INFO - PROCESS | 13582 | 10:20:00 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:60941/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60941/tests/kraken/driver.html?testName=json-parse-financial) 10:20:00 INFO - PROCESS | 13582 | RSS: Main: 213291008 10:20:00 INFO - PROCESS | 13582 | 10:20:02 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:60941/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60941/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:20:02 INFO - PROCESS | 13582 | RSS: Main: 174759936 10:20:02 INFO - PROCESS | 13582 | 10:20:04 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:60941/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60941/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:20:05 INFO - PROCESS | 13582 | RSS: Main: 182738944 10:20:05 INFO - PROCESS | 13582 | 10:20:07 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:60941/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60941/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:20:07 INFO - PROCESS | 13582 | RSS: Main: 188485632 10:20:07 INFO - PROCESS | 13582 | 10:20:10 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:60941/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60941/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:20:11 INFO - PROCESS | 13582 | RSS: Main: 196767744 10:20:11 INFO - PROCESS | 13582 | 10:20:13 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:60941/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60941/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:20:14 INFO - PROCESS | 13582 | RSS: Main: 193503232 10:20:14 INFO - PROCESS | 13582 | 10:20:16 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:60941/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60941/tests/kraken/driver.html?testName=ai-astar) 10:20:16 INFO - PROCESS | 13582 | RSS: Main: 245010432 10:20:16 INFO - PROCESS | 13582 | 10:20:16 INFO - PROCESS | 13582 | __start_tp_report 10:20:16 INFO - PROCESS | 13582 | _x_x_mozilla_page_load 10:20:16 INFO - PROCESS | 13582 | _x_x_mozilla_page_load_details 10:20:16 INFO - PROCESS | 13582 | |i|pagename|runs| 10:20:16 INFO - PROCESS | 13582 | |0;ai-astar;100;110;111;110;112;111;110;110;112;111 10:20:16 INFO - PROCESS | 13582 | |1;audio-beat-detection;145;119;117;161;121;122;122;116;146;116 10:20:16 INFO - PROCESS | 13582 | |2;audio-dft;160;160;162;162;161;159;159;160;159;160 10:20:16 INFO - PROCESS | 13582 | |3;audio-fft;74;76;75;118;74;75;75;74;96;75 10:20:16 INFO - PROCESS | 13582 | |4;audio-oscillator;82;81;118;82;82;82;98;82;81;105 10:20:16 INFO - PROCESS | 13582 | |5;imaging-gaussian-blur;119;118;117;117;116;117;117;118;118;116 10:20:16 INFO - PROCESS | 13582 | |6;imaging-darkroom;146;147;146;146;146;146;147;147;147;146 10:20:16 INFO - PROCESS | 13582 | |7;imaging-desaturate;85;85;85;85;85;84;84;85;84;85 10:20:16 INFO - PROCESS | 13582 | |8;json-parse-financial;50;49;50;49;49;48;50;50;50;49 10:20:16 INFO - PROCESS | 13582 | |9;json-stringify-tinderbox;61;61;58;58;59;60;60;59;59;59 10:20:16 INFO - PROCESS | 13582 | |10;stanford-crypto-aes;74;74;74;74;73;81;74;83;74;74 10:20:16 INFO - PROCESS | 13582 | |11;stanford-crypto-ccm;124;126;122;123;127;121;122;121;159;128 10:20:16 INFO - PROCESS | 13582 | |12;stanford-crypto-pbkdf2;160;155;156;157;154;161;157;157;160;157 10:20:16 INFO - PROCESS | 13582 | |13;stanford-crypto-sha256-iterative;62;63;63;64;62;64;64;68;61;63 10:20:16 INFO - PROCESS | 13582 | __end_tp_report 10:20:16 INFO - PROCESS | 13582 | __start_cc_report 10:20:16 INFO - PROCESS | 13582 | _x_x_mozilla_cycle_collect,1542 10:20:16 INFO - PROCESS | 13582 | __end_cc_report 10:20:16 INFO - PROCESS | 13582 | __startTimestamp1485973216266__endTimestamp 10:20:16 INFO - PROCESS | 13582 | 10:20:16 INFO - PROCESS | 13582 | ------- Summary: start ------- 10:20:16 INFO - PROCESS | 13582 | Number of tests: 14 10:20:16 INFO - PROCESS | 13582 | 10:20:16 INFO - PROCESS | 13582 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.50 (3.2%) stddev-sans-first:0.83 10:20:16 INFO - PROCESS | 13582 | Values: 100.0 110.0 111.0 110.0 112.0 111.0 110.0 110.0 112.0 111.0 10:20:16 INFO - PROCESS | 13582 | 10:20:16 INFO - PROCESS | 13582 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:122.00 stddev:16.02 (13.1%) stddev-sans-first:15.84 10:20:16 INFO - PROCESS | 13582 | Values: 145.0 119.0 117.0 161.0 121.0 122.0 122.0 116.0 146.0 116.0 10:20:16 INFO - PROCESS | 13582 | 10:20:16 INFO - PROCESS | 13582 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 10:20:16 INFO - PROCESS | 13582 | Values: 160.0 160.0 162.0 162.0 161.0 159.0 159.0 160.0 159.0 160.0 10:20:16 INFO - PROCESS | 13582 | 10:20:16 INFO - PROCESS | 13582 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.00 stddev:14.57 (19.4%) stddev-sans-first:15.22 10:20:16 INFO - PROCESS | 13582 | Values: 74.0 76.0 75.0 118.0 74.0 75.0 75.0 74.0 96.0 75.0 10:20:16 INFO - PROCESS | 13582 | 10:20:16 INFO - PROCESS | 13582 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:82.00 stddev:13.12 (16.0%) stddev-sans-first:13.65 10:20:16 INFO - PROCESS | 13582 | Values: 82.0 81.0 118.0 82.0 82.0 82.0 98.0 82.0 81.0 105.0 10:20:16 INFO - PROCESS | 13582 | 10:20:16 INFO - PROCESS | 13582 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.95 (0.8%) stddev-sans-first:0.78 10:20:16 INFO - PROCESS | 13582 | Values: 119.0 118.0 117.0 117.0 116.0 117.0 117.0 118.0 118.0 116.0 10:20:16 INFO - PROCESS | 13582 | 10:20:16 INFO - PROCESS | 13582 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:20:16 INFO - PROCESS | 13582 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 146.0 10:20:16 INFO - PROCESS | 13582 | 10:20:16 INFO - PROCESS | 13582 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 10:20:16 INFO - PROCESS | 13582 | Values: 85.0 85.0 85.0 85.0 85.0 84.0 84.0 85.0 84.0 85.0 10:20:16 INFO - PROCESS | 13582 | 10:20:16 INFO - PROCESS | 13582 | [#8] json-parse-financial Cycles:10 Average:49.40 Median:50.00 stddev:0.70 (1.4%) stddev-sans-first:0.71 10:20:16 INFO - PROCESS | 13582 | Values: 50.0 49.0 50.0 49.0 49.0 48.0 50.0 50.0 50.0 49.0 10:20:16 INFO - PROCESS | 13582 | 10:20:16 INFO - PROCESS | 13582 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:1.07 (1.8%) stddev-sans-first:0.97 10:20:16 INFO - PROCESS | 13582 | Values: 61.0 61.0 58.0 58.0 59.0 60.0 60.0 59.0 59.0 59.0 10:20:16 INFO - PROCESS | 13582 | 10:20:16 INFO - PROCESS | 13582 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:74.00 stddev:3.47 (4.7%) stddev-sans-first:3.64 10:20:16 INFO - PROCESS | 13582 | Values: 74.0 74.0 74.0 74.0 73.0 81.0 74.0 83.0 74.0 74.0 10:20:16 INFO - PROCESS | 13582 | 10:20:16 INFO - PROCESS | 13582 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:125.00 stddev:11.41 (9.1%) stddev-sans-first:12.04 10:20:16 INFO - PROCESS | 13582 | Values: 124.0 126.0 122.0 123.0 127.0 121.0 122.0 121.0 159.0 128.0 10:20:16 INFO - PROCESS | 13582 | 10:20:16 INFO - PROCESS | 13582 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:157.00 stddev:2.27 (1.4%) stddev-sans-first:2.20 10:20:16 INFO - PROCESS | 13582 | Values: 160.0 155.0 156.0 157.0 154.0 161.0 157.0 157.0 160.0 157.0 10:20:16 INFO - PROCESS | 13582 | 10:20:16 INFO - PROCESS | 13582 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:1.90 (3.0%) stddev-sans-first:1.94 10:20:16 INFO - PROCESS | 13582 | Values: 62.0 63.0 63.0 64.0 62.0 64.0 64.0 68.0 61.0 63.0 10:20:16 INFO - PROCESS | 13582 | -------- Summary: end -------- 10:20:16 INFO - PROCESS | 13582 | 10:20:17 INFO - TEST-INFO | 13582: exit 0 10:20:17 INFO - TEST-OK | kraken | took 59903ms 10:20:17 INFO - SUITE-END | took 1174s 10:20:17 INFO - Completed test suite (00:19:34) 10:20:17 INFO - javascript benchmark 10:20:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3269.3134441767234, 3305.8677652893884, 3306.3222039481907, 3335.966640333596, 3355.5637767090275, 5591.496765291123, 5694.715264236782, 5698.373178950317, 5699.857503562413, 5725.656460612367, 5612.298462692163, 5652.0391533439315, 5653.378128405872, 5658.405867383927, 5681.091025435931, 5074.517920797528, 5086.618503612225, 5106.387233531963, 5140.588752899759, 5170.431252562215, 5015.272785446108, 5021.824236151735, 5052.949470505285, 5216.356847593015, 5254.343207099113, 5082.593392528607, 5188.792448302063, 5195.688258704471, 5201.375834899817, 5203.1414816555225, 5188.195829646411, 5197.038547868657, 5200.271961925334, 5204.713740744258, 5232.92150617741, 4934.80260789568, 5050.444451110375, 5090.08378491875, 5108.463611320833, 5157.922631160535, 5501.614886957915, 5504.0, 5524.944750552483, 5528.695921724304, 5580.91628625571, 5990.580659353847, 6003.369646187175, 6055.212822333113, 6099.603525770811, 6100.572959892809, 6137.877242455126, 6140.785072522441, 6145.0, 6147.354527774609, 6153.907691384633, 5472.2338872557875, 5528.170774383834, 5604.579656525736, 5649.689267090267, 5660.518855897295, 6210.757848430332, 6215.595986260879, 6222.377762223741, 6222.564420490522, 6233.594816336924, 5976.282846058414, 5983.341832398432, 5992.191054207626, 5994.490468310242, 5996.610220335664, 5764.682942438206, 5883.852903677357, 5963.731632076567, 5991.310999235056, 6011.729472173763, 6042.093685947055, 6049.8487537811025, 6050.183225264533, 6053.0, 6066.514678825772, 6000.699965001732, 6041.365656605993, 6044.395560443921, 6044.486218671462, 6087.908681369783, 4488.0126372198065, 4508.752018639007, 4536.138133754576, 4598.770061496912, 4686.531346865286, 4057.5130984282073, 4080.7347522410946, 4084.4894388201474, 4089.7137200395687, 4089.9182016359505, 5629.746661400247, 5689.175069614966, 5704.686242256716, 5710.057840456278, 5718.085106383042, 6002.0, 6006.909896351558, 6049.153118563405, 6054.39456054391, 6059.757609695651, 5580.91628625571, 5600.0, 5672.262605861211, 5677.630953987978, 5680.7727690892725, 5075.796968121308, 5153.665011774223, 5162.92255616166, 5177.430482646906, 5245.0, 6304.306526282106, 6317.526185536103, 6332.6200427973545, 6376.872462550816, 6382.266039405435, 6068.271807383142, 6073.423024812636, 6113.724882380215, 6125.081237814364, 6137.877242455215, 6086.817395478142, 6129.478994285536, 6130.325664176848, 6208.192934918432, 6373.203349581302, 5889.352171261072, 5892.823215303548, 5893.852653683693, 5895.0, 5897.3807750185615, 5953.958057340034, 6064.605800622945, 6093.360197179232, 6144.2319710036245, 6146.354632763674, 5934.19888315072, 5954.702264886825, 5956.493698035715, 5957.225560677258, 5992.191054207626, 5966.105084237399, 5984.251968503937, 5985.581009329305, 5994.760209591567, 5997.13041608973, 5659.207710920392, 5698.430156984434, 5706.258186435737, 5724.084146536534, 5787.594868359174, 5794.304683438015, 5805.0, 5805.0, 5810.070388737781, 5811.854703632443, 5642.633228840113, 5642.689652069175, 5652.604317697722, 5653.2085508028085, 5656.236408084856], "value": 5555.2672715762565, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.716935870782, 611.9418655227753, 651.4234902111631, 663.1743479368184, 669.7086767256241, 36672.0, 45556.088878222414, 46799.064018719604, 46826.76586617067, 51184.23223651648, 48067.27899081517, 48551.02897942039, 48568.757156214255, 48621.0, 48683.269750953674, 8384.413091083627, 9003.09969003101, 9062.909370906273, 9127.497987610679, 9148.17666410023, 8442.535660538668, 10706.678799636024, 10994.945025274863, 10995.450227488633, 11329.433528323592, 10933.781324373507, 11004.0, 11004.229703920688, 11008.174386920973, 11013.559457621686, 11003.669889903316, 11052.447377631166, 11054.944725276362, 11066.114710823114, 11068.114550835995, 10750.784984300348, 10798.190135739773, 10809.189310801721, 10810.405427701473, 10821.080208182313, 44718.0, 45087.0, 45102.548974510166, 45111.32333015007, 45113.77443112763, 3894.493715816954, 3973.4635824163656, 4132.235536425771, 4232.597903199191, 4424.424824772791, 32913.177170570685, 33117.503237451456, 33327.862248019104, 33400.0, 33561.0, 4499.055198408339, 4522.796474158671, 4527.615152712024, 4580.381648477446, 4711.93981354196, 376198.0, 377800.0, 378076.0, 379029.0, 379585.99999999726, 37428.0, 62600.373996260365, 62959.370406296264, 63029.0, 63059.0, 38817.22365552673, 41217.0, 41514.0, 41532.58467415348, 41556.792216038724, 16678.166091695366, 16742.74885876713, 16797.664046718997, 16798.66402671964, 16802.831971680127, 13049.804252936214, 13348.132371395828, 13984.930075349557, 14595.197264150362, 14700.41198352054, 9611.519424028771, 9622.037796220462, 9634.470104144199, 9637.518124093767, 9712.271579631555, 3611.133328001313, 3660.7071434285194, 3705.0, 3765.548134223911, 3776.546814382237, 1065.7602039541196, 1073.2111897755144, 1097.8078836203633, 1140.8973192412723, 1151.9136064795173, 32167.26578240829, 33772.49341259883, 33822.661773382446, 33991.83004085013, 34035.65964340374, 1100.878903320634, 1151.980497259931, 1154.468944285638, 1160.8955194032578, 1228.263042174688, 16162.75755863663, 16711.498655040366, 16717.49847504577, 16989.46958462538, 16994.49016529506, 572344.0, 578006.0, 578094.0, 579116.0, 579650.0, 61249.693751530955, 61562.69218653968, 61566.0, 61657.69171154205, 61719.38280617226, 1344.6571124363224, 1385.1342910681026, 1395.413926151019, 1436.5690292912084, 1442.0410427066092, 32018.679813202503, 34308.82845585756, 34363.65636343705, 34529.30941381209, 34613.65386346104, 52267.47732522778, 52947.20579191238, 52968.20547691865, 52974.735126325664, 53060.469395305554, 435759.0, 436078.0, 436992.0, 437041.0, 442244.0, 26408.20775376742, 27772.86113569419, 28461.146165615064, 30083.548746768378, 30128.09615711532, 46088.769556152, 46142.538574615166, 46213.0, 46272.30591541197, 46671.29993050039, 44231.77884110559, 44800.0, 45220.77389613031, 47173.29240061333, 49360.0, 43083.569164307955, 43176.784116079216, 44243.778781107176, 46706.29940550827, 47914.760426197645, 45887.54112458833, 47129.764351178026, 47214.29178562393, 47382.28926566035, 47598.28602570895, 42883.0, 43378.566214338716, 44292.11415771731, 45386.319205211286, 45763.54236457593, 30180.396392072475, 30632.387352253278, 30716.0, 30819.383612328078, 30966.380672385974], "value": 20545.269748681472, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.9098198396352, 420.6298457357525, 427.3440269186799, 431.85316992222636, 439.39583073274247, 18632.62734745306, 19087.141078651475, 20190.192392304307, 20346.69479957798, 20635.0, 19364.70952935707, 19424.417267481964, 19663.115159817808, 19833.603327933433, 19837.603247935032, 5533.6956467394175, 5807.9419205808035, 5812.447817457335, 5814.069748840187, 5816.214811000503, 5487.2317875497465, 5569.554435645138, 5665.8583535411735, 5668.093105103184, 5680.0627896397045, 5630.352509461403, 5638.520725738317, 5643.6049476536655, 5660.518855897254, 5664.688442135681, 5571.4428557144365, 5591.916121258185, 5615.550755939515, 5639.182318563806, 5646.74589643465, 5183.144781111112, 5190.4031036430915, 5191.0, 5191.896162076775, 5193.350831146106, 22607.434814129614, 23436.53126937469, 23439.0, 23505.882470587538, 23678.052877884864, 2454.779069883701, 2549.4391233928504, 2618.5417551928335, 2623.27859838544, 2885.480613489571, 10461.68614941553, 10994.34033957965, 14587.927060364631, 14795.926020369829, 15129.0, 2016.2741413091276, 2022.7673817511027, 2026.4224695961727, 2030.2285131650026, 2032.5629989552317, 78399.60800195963, 79292.60353698194, 80222.19777802206, 81467.18532814656, 81879.0, 11619.244749091282, 11629.941850290863, 11953.880461195451, 11973.341466219441, 12048.939755301342, 17098.230579623945, 17122.914385427994, 17146.228419720894, 17146.914265428593, 17171.227294771765, 8845.601947912231, 8916.19754222123, 8972.730818075468, 9101.590428430736, 9134.81730365389, 8437.746867593982, 8555.828883422297, 8590.0, 8590.87113693295, 8823.117688231254, 5034.647574669812, 5138.691678499302, 5155.6391052626705, 5228.92156617651, 5252.44849290819, 1838.9356372526897, 1899.848012159024, 2090.8850013249416, 2125.1499400240027, 2165.545235500531, 946.3044662173297, 961.2694352292168, 1044.013407330081, 1075.4515197249302, 1120.7447658622232, 20182.89908550448, 20224.393268201977, 20253.29113481021, 20342.389728308175, 20387.59224815525, 980.7302991677203, 988.5057471264367, 992.1318846009741, 1053.1943063556384, 1077.2028698762858, 10779.407132607781, 11144.164187685956, 11150.832737508943, 11192.552297908156, 11329.660110196708, 455650.0, 477533.0, 485555.0, 487343.0, 488323.0, 63140.684296579144, 92930.0, 92973.53513232525, 93574.53212733893, 94891.0, 1008.3042700536606, 1015.3704703084135, 1032.829583118792, 1036.3108532825586, 1056.3503445381036, 14122.0, 18080.276788928295, 18197.272109116017, 18310.450686479428, 18664.066796660383, 30374.0, 43751.56248437602, 43837.34243986279, 43894.0, 44423.555764443234, 59400.40599593949, 59421.0, 60705.0, 64346.0, 66573.0, 8774.29805615562, 8803.691870784492, 8892.0, 8968.68609598687, 9139.0, 12541.0, 13389.66525836862, 13578.864211358155, 13868.791968120284, 14399.640008999859, 12269.93865030669, 12338.75322493563, 12407.553459025736, 12540.937295313464, 12544.686382840502, 11535.192536522363, 11641.243319184226, 11642.476088576204, 11726.355050471964, 12040.75918481643, 6264.091706702594, 8773.736787896374, 11813.822792657946, 12553.874461255271, 12601.18092323996, 9205.355625106178, 9236.16874481273, 9269.212116970133, 9405.670801521914, 9605.711828645151, 9089.363744538083, 11669.76660466769, 12414.62756117318, 12470.438830252842, 12632.0], "value": 9524.86664898091, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1531.724289627867, 1536.7694845773135, 1711.5122190175803, 1802.2790883646549, 1807.5932915094097, 8546.230839224469, 9108.681196158135, 9152.176304132636, 9163.95418022909, 9172.312076594257, 7880.724174653888, 8069.757907262777, 8090.0, 8301.750947471586, 8959.820803583925, 2455.054803900498, 2534.746525347469, 2541.2122242104915, 2559.846409215453, 2565.9101931432406, 2452.362385779701, 2481.900723971048, 2503.7496250374998, 2505.08564374004, 2524.0, 2466.839655422401, 2474.4679893822827, 2493.2021753039035, 2498.837575557583, 2499.275210189043, 2473.6660550825677, 2493.4265119022543, 2496.400863792695, 2499.4376265340334, 2505.073122944513, 2445.4375493636385, 2506.7618576235227, 2509.636102765107, 2511.384710745879, 2515.5094756522485, 8934.463932164092, 9061.456312621263, 9085.454872707658, 9119.863202051974, 9153.771155721093, 5503.091989821674, 5646.717664116778, 5648.293963254593, 5650.180723795068, 5652.689102099383, 3212.421764082464, 3263.282077942849, 3408.84660190292, 3470.774399664014, 3478.808665523395, 1028.1671845804922, 1030.577463240068, 1054.583439541377, 1088.472091035847, 1092.5848177692505, 12047.6385708428, 12177.93911030448, 12256.509739610405, 12681.175723577939, 12785.10504264702, 4742.502037286035, 4752.120857641278, 4801.53426508808, 4862.027594481047, 4907.141250281186, 10047.447390393452, 10122.493875306205, 10125.240606954509, 10137.898621013843, 10150.492475376202, 5585.497305242548, 5590.273264475592, 5595.776168953278, 5599.972000139973, 5600.663960162403, 4443.133588950123, 4986.301917731521, 5125.846224613268, 5176.559992400613, 5250.579953603703, 3730.626937306248, 3971.980140099281, 4118.670506359484, 4141.151064031867, 4149.149424368058, 1221.7678641058171, 1267.5943698016547, 1278.3033246880473, 1280.5582074184392, 1299.4477347127433, 896.2292428511475, 1009.1321463541349, 1009.6920439265947, 1012.772126271583, 1014.9137323327452, 5454.481824226692, 5613.915791263134, 5805.10020946754, 5815.82552523425, 6018.849528761729, 948.800751842107, 948.9145976862116, 953.5518306395983, 969.539468752337, 991.1327588360185, 4151.750894946313, 4167.06241095751, 4196.076863090177, 4250.149970006011, 4266.573342665709, 10919.39943303126, 11180.832287515694, 11434.199606027498, 11439.656810295704, 11483.827742583868, 11129.499172537093, 11360.091192704564, 11367.147463940073, 11368.715782105513, 11384.658460246206, 8449.32405407566, 8728.170823771732, 8785.912140878638, 8799.560021999003, 8803.867941980747, 5876.0, 5922.200502932049, 5968.97015514937, 5999.130126131774, 6043.667598282137, 10332.225083118647, 10426.009529094725, 10459.790804184026, 10540.051395374454, 10556.15550755953, 9915.752106197402, 10202.030807073315, 10318.587256509656, 10535.78928421412, 10583.894161058599, 7264.782056538313, 7663.923360766321, 7787.4548781584745, 7787.610619468891, 7792.922070779219, 7707.306342429209, 8378.371622128243, 8530.189631984951, 8730.65077396897, 8735.606897689491, 7506.099268087864, 7542.057242844645, 7636.427267954815, 7807.375409967302, 7864.60676966138, 7421.777346679608, 7581.355584775356, 7677.462577619513, 7687.923120768721, 7850.646720897459, 7208.06295181623, 7362.889556656547, 7365.116186057708, 7367.410607151308, 7379.3727533158135, 5237.8428647140645, 5266.0, 5280.524752772269, 5283.947160528345, 5446.373667028342, 5266.210068489757, 5275.103232450416, 5326.280952071421, 5382.111951527954, 5382.3541175059245], "value": 4759.952861080171, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.8098046074658, 349.355439214649, 355.6283683550689, 359.186442707268, 359.6134155782533, 5488.69812160332, 5548.250986116873, 5561.193626924104, 5573.972130139348, 5597.300337457823, 5127.435982041981, 5223.660462069973, 5290.7354632268325, 5354.866128346794, 5408.675479471234, 4291.592298731631, 4298.806553705075, 4305.655547556204, 4318.417013703149, 4336.56634336567, 4317.978410107945, 4328.675349348796, 4335.609795118438, 4342.218400687875, 4377.277749171383, 4077.7349472284354, 4202.684798640099, 4234.618884300427, 4241.8303267869405, 4295.957040429603, 4197.139586384784, 4228.725132866384, 4228.809703563316, 4242.8727138185905, 4256.212600668886, 3745.3445647011663, 3754.4743735877, 3759.285735710206, 3767.9058023549355, 3787.7159213058853, 5301.799753102497, 5307.203919412081, 5334.333208348957, 5398.379186393576, 5439.286624713242, 4835.564799168056, 4842.297866809293, 4901.607871370282, 4909.239067944474, 4915.599054269552, 5666.1784041314195, 5676.631018983794, 5685.772569097231, 5697.629654072513, 5750.88498230033, 3975.1714211462763, 4077.103037331782, 4148.709590328678, 4180.554375690225, 4220.134872351191, 5904.822855314347, 5911.290645122613, 5924.851878703023, 5925.822225333247, 5939.465448109648, 4230.640395566411, 4233.682473814476, 4234.830606775756, 4244.665434011343, 4265.914681706348, 4199.160167966419, 4247.51153617338, 4266.253405653998, 4304.89237769052, 4307.590778876001, 4842.128416884924, 4842.491538388489, 4849.593617850784, 4865.854024379274, 4868.659193856396, 5728.255326807572, 5742.483176514133, 5749.281339832521, 5785.50823180026, 5787.131930210502, 1407.289318893952, 1432.484305649965, 1444.7173465923815, 1444.8771854392285, 1461.5615315405548, 978.7357413498315, 990.4796137928389, 1002.7443002034435, 1003.8343673293971, 1006.9395836249848, 5310.141450492297, 5311.3891902431715, 5313.946860531345, 5333.839984800462, 5348.91976620351, 5546.195801608744, 5626.1842032905815, 5649.406812284733, 5655.434456554394, 5658.245943757448, 5170.71561064145, 5242.868928276824, 5324.3078399808555, 5362.490563396471, 5368.9731551342775, 2976.479116154664, 3016.0348688419936, 3016.622922134733, 3019.5168772996217, 3025.243689077731, 5875.119961612243, 5875.529957603381, 5902.61632993854, 6031.24609423822, 6032.668203248863, 5612.214289999403, 5719.5996280260815, 5749.310082790092, 5802.736932596291, 5817.476427121494, 5821.243238378984, 5845.707714614252, 5870.26621672291, 5881.323647780475, 5922.289325280994, 5576.414476480073, 5646.548276137817, 5654.434556544313, 5699.544036476989, 5928.34788173292, 5885.146653735099, 5895.349302195392, 5896.233489646319, 5903.970480147744, 5907.9704601476715, 6078.422549857756, 6090.878182436415, 6144.324124346408, 6164.4143806338325, 6170.290416602148, 4049.433079368832, 4061.5126184858004, 4218.620324170839, 4236.364545318227, 4255.276612971751, 5716.9142462862255, 5732.34078081026, 5860.706964651836, 5862.237909071793, 5881.235439392852, 5711.971440142773, 5720.914186287126, 5721.713914304351, 5722.942770572241, 5732.16883551891, 5462.808801691922, 5714.771409143587, 5719.5138413235345, 5722.828315150552, 5729.140628905698, 5731.5128214100605, 5731.684757338387, 5736.4550367715, 5744.971275143597, 5756.107803290497, 5627.409122042127, 5760.300711290263, 5787.884242315215, 5790.1893734877995, 5811.389804070512, 5580.581456390706, 5582.274304340573, 5612.719364031864, 5616.550675945833, 5656.69895923948], "value": 4352.195678442927, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.0095182449674, 809.676129548181, 832.2301870769538, 836.1429534726906, 897.2373482539838, 13985.230812305319, 14030.719385612281, 14091.365888535014, 14161.71676566468, 14426.134431934079, 14377.78433323501, 14381.78427323591, 14424.278786060708, 14742.189179595118, 14882.181480018595, 747.8018325143842, 774.8295375017487, 872.201935229266, 887.8668199770021, 890.0832142892831, 846.5597889097666, 887.1970866365949, 892.7768057985504, 896.1486587741672, 896.5696465696437, 927.8283517549241, 929.944203347798, 930.2093220762365, 930.3487558708897, 930.5161316115616, 918.2103391083663, 919.6781126605634, 919.9862002069974, 920.4707293306309, 920.5397301349359, 672.6434989455596, 679.1680191765098, 679.2426444514381, 679.3342524326139, 679.8776220280348, 14671.0, 15008.774868376982, 15099.773503397459, 15127.697446051128, 15156.1664108474, 14479.493217737328, 14903.701925961528, 15035.323410446555, 15489.92255038729, 15548.833837462236, 11845.822312665317, 11972.700682483008, 12060.879391206063, 12067.758644827054, 12123.575674851338, 3816.2939856126427, 3865.9806700966597, 3866.729328946975, 3872.9806350968347, 3934.3311637021775, 61772.69113654403, 62597.0, 62605.0, 67575.66212168957, 68565.65717171482, 10666.946665266623, 10785.56857725698, 10875.619353322754, 11051.115910727123, 11136.554537818558, 21220.0, 21323.46691332729, 21487.892560537097, 21514.46213844635, 21606.24378146789, 7941.404394670423, 7959.761207163794, 8204.097549269576, 8217.506949583045, 8249.422540422112, 4409.404730361424, 4554.0, 4604.654650901196, 4610.400647915817, 4709.0, 3626.202235508184, 3743.513343265358, 3749.5875453700073, 3752.155764952918, 3754.4743735877, 696.5437638346891, 715.5098757351232, 726.3100054947821, 726.6911562585985, 745.6271864067966, 652.2205963873126, 780.344510611078, 782.8121250899857, 786.7167819584945, 789.7354386280546, 9453.196478299422, 9774.218062554979, 9777.41335519871, 10139.087482126644, 10215.897841021644, 691.7820886420761, 701.4038067642463, 730.4193166432699, 765.9808504787425, 783.2363445640569, 4578.908421831611, 4692.202325604655, 4803.735794531264, 4883.682560633548, 4921.089598424303, 89747.0, 92875.53562232146, 93463.53268233615, 93903.53048234715, 95093.52453237827, 77915.61042194752, 81532.0, 81787.5910620443, 81908.59045704734, 83150.16849831425, 75168.24831751722, 76281.0, 76305.61847190729, 76539.61730191424, 78228.60885695649, 9100.817983640158, 9450.196733277473, 9539.713808585753, 9688.660896868576, 9731.805363892825, 49972.75013624909, 51154.0, 51198.0, 51242.23136653028, 51637.48362516477, 60013.0, 60652.39347606644, 67392.6630366845, 69889.65055174692, 71020.64489677518, 11230.831537527107, 11445.828312575484, 11455.770884582429, 11557.28603934387, 11790.174687771774, 13587.728245435233, 13620.046596738133, 13671.521496747964, 13737.793933091212, 13807.51673691416, 12087.274763514217, 12357.567485137977, 12605.558805441766, 12657.810132848199, 13063.346832658139, 12258.754824903273, 12277.570285039981, 12282.81575776382, 12855.935720321339, 12974.740505189655, 11718.23831450953, 12027.879721202677, 12112.697182570153, 12576.496940122293, 12724.1729287596, 10359.896401036194, 10477.0, 10665.573377064831, 10815.945920270347, 10869.239153259512, 10106.140978016656, 10229.335093218917, 10234.48827558634, 10306.433146177033, 10328.586856525655], "value": 7392.043092298487, "unit": "score"}], "name": "dromaeo_css", "value": 7417.071015699676, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 111.0, 110.0, 112.0, 111.0, 110.0, 110.0, 112.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 119.0, 117.0, 161.0, 121.0, 122.0, 122.0, 116.0, 146.0, 116.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 162.0, 161.0, 159.0, 159.0, 160.0, 159.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 118.0, 74.0, 75.0, 75.0, 74.0, 96.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 118.0, 82.0, 82.0, 82.0, 98.0, 82.0, 81.0, 105.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 118.0, 116.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 50.0, 49.0, 49.0, 48.0, 50.0, 50.0, 50.0, 49.0], "value": 49.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 58.0, 58.0, 59.0, 60.0, 60.0, 59.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 74.0, 73.0, 81.0, 74.0, 83.0, 74.0, 74.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 126.0, 122.0, 123.0, 127.0, 121.0, 122.0, 121.0, 159.0, 128.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 155.0, 156.0, 157.0, 154.0, 161.0, 157.0, 157.0, 160.0, 157.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 64.0, 62.0, 64.0, 64.0, 68.0, 61.0, 63.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1449.7, "alertThreshold": 2.0}]} 10:20:17 INFO - Return code: 0 10:20:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:20:17 INFO - # TBPL SUCCESS # 10:20:17 INFO - Running post-action listener: _resource_record_post_action 10:20:17 INFO - [mozharness: 2017-02-01 18:20:17.556348Z] Finished run-tests step (success) 10:20:17 INFO - Running post-run listener: _resource_record_post_run 10:20:17 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 320225280; Read time: 0; Write time: 212872 10:20:17 INFO - TinderboxPrint: CPU usage
12.9% 10:20:17 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:20:17 INFO - TinderboxPrint: I/O write bytes / time
320,225,280 / 212,872 10:20:17 INFO - TinderboxPrint: CPU idle
8,262.3 (87.0%) 10:20:17 INFO - TinderboxPrint: CPU user
1,186.2 (12.5%) 10:20:17 INFO - TinderboxPrint: Swap in / out
0 / 0 10:20:17 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101318656; Read time: 0; Write time: 113404 10:20:17 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 218906624; Read time: 0; Write time: 99468 10:20:18 INFO - Running post-run listener: _upload_blobber_files 10:20:18 INFO - Blob upload gear active. 10:20:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:20:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:20:18 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:20:18 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:20:18 INFO - (blobuploader) - INFO - Open directory for files ... 10:20:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:20:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:20:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:19 INFO - (blobuploader) - INFO - Done attempting. 10:20:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:20:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:20:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:22 INFO - (blobuploader) - INFO - Done attempting. 10:20:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:20:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:20:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:23 INFO - (blobuploader) - INFO - Done attempting. 10:20:23 INFO - (blobuploader) - INFO - Iteration through files over. 10:20:23 INFO - Return code: 0 10:20:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:20:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:20:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d5d0e73efcc5136eee46248ffe25a89cb78bba57f4a5dd7942e6f1b5b74c4f3b5d0b3471ffc165cd18e0c284682050f14b46d9a68a0b8b1121e4cd5975e9cac7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a2ed882c8d5927abb0b5690511c5494c0d80c5ed52b34aa86f10f4fcea5a6bf630272b1a50006a1b141698dd8819695b93dcea2190bd53d0a2e51c9dad379494", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7da3e97087af8c44c0740e7c833f2c7efceb738b89d03169e2f05ccab5fc9a4bf4136a1541531c2bc5c22d3b7c8299f36b7b25b71c755995dcc3823927a8cb50"} 10:20:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:20:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:20:23 INFO - Contents: 10:20:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d5d0e73efcc5136eee46248ffe25a89cb78bba57f4a5dd7942e6f1b5b74c4f3b5d0b3471ffc165cd18e0c284682050f14b46d9a68a0b8b1121e4cd5975e9cac7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a2ed882c8d5927abb0b5690511c5494c0d80c5ed52b34aa86f10f4fcea5a6bf630272b1a50006a1b141698dd8819695b93dcea2190bd53d0a2e51c9dad379494", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7da3e97087af8c44c0740e7c833f2c7efceb738b89d03169e2f05ccab5fc9a4bf4136a1541531c2bc5c22d3b7c8299f36b7b25b71c755995dcc3823927a8cb50"} 10:20:23 INFO - Running post-run listener: copy_logs_to_upload_dir 10:20:23 INFO - Copying logs to upload dir... 10:20:23 INFO - mkdir: /builds/slave/test/build/upload/logs 10:20:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.683076 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-02-01 10:20:22.278738) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 10:20:22.282367) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d5d0e73efcc5136eee46248ffe25a89cb78bba57f4a5dd7942e6f1b5b74c4f3b5d0b3471ffc165cd18e0c284682050f14b46d9a68a0b8b1121e4cd5975e9cac7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a2ed882c8d5927abb0b5690511c5494c0d80c5ed52b34aa86f10f4fcea5a6bf630272b1a50006a1b141698dd8819695b93dcea2190bd53d0a2e51c9dad379494", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7da3e97087af8c44c0740e7c833f2c7efceb738b89d03169e2f05ccab5fc9a4bf4136a1541531c2bc5c22d3b7c8299f36b7b25b71c755995dcc3823927a8cb50"} build_url:https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/ESf-draETsaXr0w_aGqphw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d5d0e73efcc5136eee46248ffe25a89cb78bba57f4a5dd7942e6f1b5b74c4f3b5d0b3471ffc165cd18e0c284682050f14b46d9a68a0b8b1121e4cd5975e9cac7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a2ed882c8d5927abb0b5690511c5494c0d80c5ed52b34aa86f10f4fcea5a6bf630272b1a50006a1b141698dd8819695b93dcea2190bd53d0a2e51c9dad379494", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7da3e97087af8c44c0740e7c833f2c7efceb738b89d03169e2f05ccab5fc9a4bf4136a1541531c2bc5c22d3b7c8299f36b7b25b71c755995dcc3823927a8cb50"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 10:20:22.306295) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 10:20:22.306573) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1485971989.894340-1328780738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 10:20:22.391810) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 10:20:22.392142) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 10:20:22.392417) ========= ========= Total master_lag: 0.14 =========