builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1482381944.86 results: success (0) buildid: 20161221190653 builduid: 23ac1708019340188cfe92e225d73e1c revision: 62eb5ff8893e7803da94b2e52bd108285aa1f5fe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 20:45:44.861433) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 20:45:44.861969) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 20:45:44.862291) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 20:45:44.877300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 20:45:44.877771) ========= 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=03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-21 20:45:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.5M=0s 2016-12-21 20:45:45 (37.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107190 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 20:45:44.999974) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 20:45:45.000347) ========= 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=03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020151 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 20:45:45.050649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 20:45:45.051044) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 62eb5ff8893e7803da94b2e52bd108285aa1f5fe --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-aurora --rev 62eb5ff8893e7803da94b2e52bd108285aa1f5fe --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=03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-21 20:45:45,400 truncating revision to first 12 chars 2016-12-21 20:45:45,400 Setting DEBUG logging. 2016-12-21 20:45:45,400 attempt 1/10 2016-12-21 20:45:45,400 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/62eb5ff8893e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 20:45:46,934 unpacking tar archive at: mozilla-aurora-62eb5ff8893e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.875917 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 20:45:46.941034) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 20:45:46.941404) ========= script_repo_revision: 62eb5ff8893e7803da94b2e52bd108285aa1f5fe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 20:45:46.941917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 20:45:46.942224) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 20:45:46.953175) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-21 20:45:46.953501) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:45:47 INFO - MultiFileLogger online at 20161221 20:45:47 in /builds/slave/test 20:45:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 20:45:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:45:47 INFO - {'append_to_log': False, 20:45:47 INFO - 'base_work_dir': '/builds/slave/test', 20:45:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:45:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:45:47 INFO - 'branch': 'Mozilla-Aurora', 20:45:47 INFO - 'buildbot_json_path': 'buildprops.json', 20:45:47 INFO - 'config_files': ('talos/linux_config.py',), 20:45:47 INFO - 'default_actions': ('clobber', 20:45:47 INFO - 'read-buildbot-config', 20:45:47 INFO - 'download-and-extract', 20:45:47 INFO - 'populate-webroot', 20:45:47 INFO - 'create-virtualenv', 20:45:47 INFO - 'install', 20:45:47 INFO - 'run-tests'), 20:45:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:45:47 INFO - 'download_minidump_stackwalk': True, 20:45:47 INFO - 'download_symbols': 'ondemand', 20:45:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:45:47 INFO - 'tooltool.py': '/tools/tooltool.py', 20:45:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:45:47 INFO - '/tools/misc-python/virtualenv.py')}, 20:45:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:45:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:45:47 INFO - 'installer_path': 'installer.exe', 20:45:47 INFO - 'log_level': 'info', 20:45:47 INFO - 'log_name': 'talos', 20:45:47 INFO - 'log_to_console': True, 20:45:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:45:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:45:47 INFO - 'opt_config_files': (), 20:45:47 INFO - 'pip_index': False, 20:45:47 INFO - 'sps_profile': False, 20:45:47 INFO - 'sps_profile_interval': 0, 20:45:47 INFO - 'suite': 'dromaeojs', 20:45:47 INFO - 'system_bits': '32', 20:45:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:45:47 INFO - 'title': 'talos-linux64-ix-047', 20:45:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:45:47 INFO - 'use_talos_json': True, 20:45:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:45:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:45:47 INFO - 'work_dir': 'build'} 20:45:47 INFO - [mozharness: 2016-12-22 04:45:47.404487Z] Running clobber step. 20:45:47 INFO - Running pre-action listener: _resource_record_pre_action 20:45:47 INFO - Running main action method: clobber 20:45:47 INFO - rmtree: /builds/slave/test/build 20:45:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:45:47 INFO - Running post-action listener: _resource_record_post_action 20:45:47 INFO - [mozharness: 2016-12-22 04:45:47.869646Z] Finished clobber step (success) 20:45:47 INFO - [mozharness: 2016-12-22 04:45:47.869747Z] Running read-buildbot-config step. 20:45:47 INFO - Running pre-action listener: _resource_record_pre_action 20:45:47 INFO - Running main action method: read_buildbot_config 20:45:47 INFO - Using buildbot properties: 20:45:47 INFO - { 20:45:47 INFO - "project": "", 20:45:47 INFO - "product": "firefox", 20:45:47 INFO - "script_repo_revision": "production", 20:45:47 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 20:45:47 INFO - "repository": "", 20:45:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 20:45:47 INFO - "buildid": "20161221190653", 20:45:47 INFO - "pgo_build": "True", 20:45:47 INFO - "basedir": "/builds/slave/test", 20:45:47 INFO - "buildnumber": 981, 20:45:47 INFO - "slavename": "talos-linux64-ix-047", 20:45:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:45:47 INFO - "platform": "ubuntu64_hw", 20:45:47 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 20:45:47 INFO - "branch": "mozilla-aurora", 20:45:47 INFO - "repo_path": "releases/mozilla-aurora", 20:45:47 INFO - "revision": "62eb5ff8893e7803da94b2e52bd108285aa1f5fe", 20:45:47 INFO - "stage_platform": "linux64-pgo", 20:45:47 INFO - "builduid": "23ac1708019340188cfe92e225d73e1c", 20:45:47 INFO - "slavebuilddir": "test" 20:45:47 INFO - } 20:45:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 20:45:47 INFO - Running post-action listener: _resource_record_post_action 20:45:47 INFO - [mozharness: 2016-12-22 04:45:47.872168Z] Finished read-buildbot-config step (success) 20:45:47 INFO - [mozharness: 2016-12-22 04:45:47.872256Z] Running download-and-extract step. 20:45:47 INFO - Running pre-action listener: _resource_record_pre_action 20:45:47 INFO - Running main action method: download_and_extract 20:45:47 INFO - mkdir: /builds/slave/test/build/tests 20:45:47 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')]} 20:45:47 INFO - trying https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 20:45:47 INFO - Downloading https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 20:45:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:45:48 INFO - Downloaded 1361 bytes. 20:45:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 20:45:48 INFO - Using the following test package requirements: 20:45:48 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 20:45:48 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:45:48 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 20:45:48 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:45:48 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 20:45:48 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:45:48 INFO - u'jsshell-linux-x86_64.zip'], 20:45:48 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:45:48 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 20:45:48 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 20:45:48 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:45:48 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 20:45:48 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:45:48 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 20:45:48 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:45:48 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 20:45:48 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:45:48 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 20:45:48 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:45:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 20:45:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:45:48 INFO - Fetch https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 20:45:49 INFO - Http code: 200 20:45:49 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 20:45:49 INFO - x-amz-cf-id: W_QACuSZI8UhkY-rG2tpMPKxYgxtTGRWuFsb0w9JnBFpvGlJWub3KA== 20:45:49 INFO - x-amz-version-id: ExVpCYbw0YErLs5vpF.WlvxTLq4exPOi 20:45:49 INFO - Expected file size: 21942624 20:45:49 INFO - Obtained file size: 21942624 20:45:53 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:45:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 20:45:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:45:53 INFO - Fetch https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 20:45:53 INFO - Http code: 200 20:45:53 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 20:45:53 INFO - x-amz-cf-id: wHUSOnEQH7p3t-RzhoncADIxJxtPq6xgNWkuHw-kZMV3hubizd2DBw== 20:45:53 INFO - x-amz-version-id: ExVpCYbw0YErLs5vpF.WlvxTLq4exPOi 20:45:56 INFO - Expected file size: 21942624 20:45:56 INFO - Obtained file size: 21942624 20:46:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 20:46:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:46:00 INFO - Fetch https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 20:46:01 INFO - Http code: 200 20:46:01 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 20:46:01 INFO - x-amz-cf-id: DG0kMX_IFJEDI5byjHHV0AGfq4yIAG5WAZXx_VUUUdw91WlOtEZKEg== 20:46:01 INFO - x-amz-version-id: ntsbe7RZt96wW4stGPUJH0s4OD3Rf9_H 20:46:01 INFO - Expected file size: 14409038 20:46:01 INFO - Obtained file size: 14409038 20:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:01 INFO - trying https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 20:46:01 INFO - Downloading https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 20:46:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:46:03 INFO - Downloaded 63994066 bytes. 20:46:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 20:46:03 INFO - mkdir: /builds/slave/test/properties 20:46:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:46:03 INFO - Writing to file /builds/slave/test/properties/build_url 20:46:03 INFO - Contents: 20:46:03 INFO - build_url:https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 20:46:03 INFO - Running post-action listener: _resource_record_post_action 20:46:03 INFO - Running post-action listener: set_extra_try_arguments 20:46:03 INFO - [mozharness: 2016-12-22 04:46:03.832536Z] Finished download-and-extract step (success) 20:46:03 INFO - [mozharness: 2016-12-22 04:46:03.832762Z] Running populate-webroot step. 20:46:03 INFO - Running pre-action listener: _resource_record_pre_action 20:46:03 INFO - Running main action method: populate_webroot 20:46:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:46:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:46:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:46:03 INFO - '--tppagecycles', 20:46:03 INFO - '7'], 20:46:03 INFO - 'tests': ['tsvgm']}}, 20:46:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:46:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:46:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:46:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:46:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:46:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:46:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:03 INFO - 'talos_options': ['--disable-e10s'], 20:46:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:46:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:46:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:03 INFO - 'talos_options': ['--disable-e10s'], 20:46:03 INFO - 'tests': ['damp', 'tps']}, 20:46:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:03 INFO - 'tests': ['damp', 'tps']}, 20:46:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:46:03 INFO - 'tests': ['dromaeo_dom']}, 20:46:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:46:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:46:03 INFO - 'tests': ['basic_compositor_video']}, 20:46:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:46:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:46:03 INFO - 'tests': ['a11yr', 20:46:03 INFO - 'ts_paint', 20:46:03 INFO - 'tpaint', 20:46:03 INFO - 'sessionrestore', 20:46:03 INFO - 'sessionrestore_no_auto_restore', 20:46:03 INFO - 'tabpaint']}, 20:46:03 INFO - 'other-e10s': {'tests': ['a11yr', 20:46:03 INFO - 'ts_paint', 20:46:03 INFO - 'tpaint', 20:46:03 INFO - 'sessionrestore', 20:46:03 INFO - 'sessionrestore_no_auto_restore', 20:46:03 INFO - 'tabpaint']}, 20:46:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:46:03 INFO - 'ts_paint', 20:46:03 INFO - 'tpaint', 20:46:03 INFO - 'sessionrestore', 20:46:03 INFO - 'sessionrestore_no_auto_restore', 20:46:03 INFO - 'tabpaint']}, 20:46:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:46:03 INFO - 'ts_paint', 20:46:03 INFO - 'tpaint', 20:46:03 INFO - 'sessionrestore', 20:46:03 INFO - 'sessionrestore_no_auto_restore', 20:46:03 INFO - 'tabpaint']}, 20:46:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:46:03 INFO - 'tests': ['a11yr', 20:46:03 INFO - 'ts_paint', 20:46:03 INFO - 'tpaint', 20:46:03 INFO - 'sessionrestore', 20:46:03 INFO - 'sessionrestore_no_auto_restore', 20:46:03 INFO - 'tabpaint']}, 20:46:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:46:03 INFO - 'tests': ['a11yr', 20:46:03 INFO - 'ts_paint', 20:46:03 INFO - 'tpaint', 20:46:03 INFO - 'sessionrestore', 20:46:03 INFO - 'sessionrestore_no_auto_restore', 20:46:03 INFO - 'tabpaint']}, 20:46:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:46:03 INFO - 'tests': ['tsvgx', 20:46:03 INFO - 'tsvgr_opacity', 20:46:03 INFO - 'tart', 20:46:03 INFO - 'tscrollx', 20:46:03 INFO - 'cart']}, 20:46:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:46:03 INFO - 'tsvgr_opacity', 20:46:03 INFO - 'tart', 20:46:03 INFO - 'tscrollx', 20:46:03 INFO - 'cart']}, 20:46:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:03 INFO - 'talos_options': ['--disable-e10s'], 20:46:03 INFO - 'tests': ['tp5o']}, 20:46:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:03 INFO - 'tests': ['tp5o']}, 20:46:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:03 INFO - 'talos_options': ['--disable-e10s', 20:46:03 INFO - '--xperf_path', 20:46:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:46:03 INFO - 'tests': ['tp5n']}, 20:46:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:03 INFO - 'talos_options': ['--xperf_path', 20:46:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:46:03 INFO - 'tests': ['tp5n']}}, 20:46:03 INFO - 'talos.zip': {'path': '', 20:46:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:46:03 INFO - Running post-action listener: _resource_record_post_action 20:46:03 INFO - [mozharness: 2016-12-22 04:46:03.854063Z] Finished populate-webroot step (success) 20:46:03 INFO - [mozharness: 2016-12-22 04:46:03.854150Z] Running create-virtualenv step. 20:46:03 INFO - Running pre-action listener: _resource_record_pre_action 20:46:03 INFO - Running main action method: create_virtualenv 20:46:03 INFO - Creating virtualenv /builds/slave/test/build/venv 20:46:03 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 20:46:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:46:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:46:03 INFO - Using real prefix '/usr' 20:46:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:46:04 INFO - Installing distribute.............................................................................................................................................................................................done. 20:46:06 INFO - Installing pip.................done. 20:46:06 INFO - Return code: 0 20:46:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:46:06 INFO - Reading from file tmpfile_stdout 20:46:06 INFO - Output received: 20:46:06 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) 20:46:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:06 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 0x7f38987faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1529ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526f60>, '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 0x1527d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', '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 20:46:06 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 20:46:06 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 20:46:06 INFO - Using env: {'DISPLAY': ':0', 20:46:06 INFO - 'HOME': '/home/cltbld', 20:46:06 INFO - 'LANG': 'en_US.UTF-8', 20:46:06 INFO - 'LANGUAGE': 'en_US:en', 20:46:06 INFO - 'LOGNAME': 'cltbld', 20:46:06 INFO - 'MAIL': '/var/mail/cltbld', 20:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:06 INFO - 'MOZ_NO_REMOTE': '1', 20:46:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:06 INFO - 'NO_EM_RESTART': '1', 20:46:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:06 INFO - 'PWD': '/builds/slave/test', 20:46:06 INFO - 'SHELL': '/bin/bash', 20:46:06 INFO - 'SHLVL': '1', 20:46:06 INFO - 'TERM': 'linux', 20:46:06 INFO - 'TMOUT': '86400', 20:46:06 INFO - 'USER': 'cltbld', 20:46:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', 20:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:06 INFO - '_': '/tools/buildbot/bin/python'} 20:46:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:06 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 20:46:06 INFO - Cleaning up... 20:46:06 INFO - Return code: 0 20:46:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:06 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 0x7f38987faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1529ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526f60>, '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 0x1527d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', '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 20:46:06 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 20:46:06 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 20:46:06 INFO - Using env: {'DISPLAY': ':0', 20:46:06 INFO - 'HOME': '/home/cltbld', 20:46:06 INFO - 'LANG': 'en_US.UTF-8', 20:46:06 INFO - 'LANGUAGE': 'en_US:en', 20:46:06 INFO - 'LOGNAME': 'cltbld', 20:46:06 INFO - 'MAIL': '/var/mail/cltbld', 20:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:06 INFO - 'MOZ_NO_REMOTE': '1', 20:46:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:06 INFO - 'NO_EM_RESTART': '1', 20:46:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:06 INFO - 'PWD': '/builds/slave/test', 20:46:06 INFO - 'SHELL': '/bin/bash', 20:46:06 INFO - 'SHLVL': '1', 20:46:06 INFO - 'TERM': 'linux', 20:46:06 INFO - 'TMOUT': '86400', 20:46:06 INFO - 'USER': 'cltbld', 20:46:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', 20:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:06 INFO - '_': '/tools/buildbot/bin/python'} 20:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:07 INFO - Downloading/unpacking psutil>=3.1.1 20:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:46:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:46:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:46:09 INFO - Installing collected packages: psutil 20:46:09 INFO - Running setup.py install for psutil 20:46:09 INFO - building 'psutil._psutil_linux' extension 20:46:09 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 20:46:09 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 20:46:09 INFO - building 'psutil._psutil_posix' extension 20:46:09 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 20:46:09 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 20:46:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:46:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:46:09 INFO - Successfully installed psutil 20:46:09 INFO - Cleaning up... 20:46:09 INFO - Return code: 0 20:46:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:46:09 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')]} 20:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:09 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')]} 20:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:09 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 0x7f38987faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1529ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526f60>, '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 0x1527d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', '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 20:46:09 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 20:46:09 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 20:46:09 INFO - Using env: {'DISPLAY': ':0', 20:46:09 INFO - 'HOME': '/home/cltbld', 20:46:09 INFO - 'LANG': 'en_US.UTF-8', 20:46:09 INFO - 'LANGUAGE': 'en_US:en', 20:46:09 INFO - 'LOGNAME': 'cltbld', 20:46:09 INFO - 'MAIL': '/var/mail/cltbld', 20:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:09 INFO - 'MOZ_NO_REMOTE': '1', 20:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:09 INFO - 'NO_EM_RESTART': '1', 20:46:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:09 INFO - 'PWD': '/builds/slave/test', 20:46:09 INFO - 'SHELL': '/bin/bash', 20:46:09 INFO - 'SHLVL': '1', 20:46:09 INFO - 'TERM': 'linux', 20:46:09 INFO - 'TMOUT': '86400', 20:46:09 INFO - 'USER': 'cltbld', 20:46:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', 20:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:09 INFO - '_': '/tools/buildbot/bin/python'} 20:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:46:09 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 20:46:09 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 20:46:09 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 20:46:09 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 20:46:09 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 20:46:09 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 20:46:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:46:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:46:12 INFO - Installing collected packages: mozsystemmonitor 20:46:12 INFO - Running setup.py install for mozsystemmonitor 20:46:12 INFO - Successfully installed mozsystemmonitor 20:46:12 INFO - Cleaning up... 20:46:12 INFO - Return code: 0 20:46:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:46:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f38987faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1529ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526f60>, '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 0x1527d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', '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 20:46:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:46:12 INFO - Using env: {'DISPLAY': ':0', 20:46:12 INFO - 'HOME': '/home/cltbld', 20:46:12 INFO - 'LANG': 'en_US.UTF-8', 20:46:12 INFO - 'LANGUAGE': 'en_US:en', 20:46:12 INFO - 'LOGNAME': 'cltbld', 20:46:12 INFO - 'MAIL': '/var/mail/cltbld', 20:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:12 INFO - 'MOZ_NO_REMOTE': '1', 20:46:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:12 INFO - 'NO_EM_RESTART': '1', 20:46:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:12 INFO - 'PWD': '/builds/slave/test', 20:46:12 INFO - 'SHELL': '/bin/bash', 20:46:12 INFO - 'SHLVL': '1', 20:46:12 INFO - 'TERM': 'linux', 20:46:12 INFO - 'TMOUT': '86400', 20:46:12 INFO - 'USER': 'cltbld', 20:46:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', 20:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:12 INFO - '_': '/tools/buildbot/bin/python'} 20:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:12 INFO - Downloading/unpacking jsonschema==2.5.1 20:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:46:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46:14 INFO - Downloading functools32-3.2.3-2.tar.gz 20:46:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:46:14 INFO - warning: no files found matching '*.txt' 20:46:14 INFO - no previously-included directories found matching 'build' 20:46:14 INFO - no previously-included directories found matching 'dist' 20:46:14 INFO - no previously-included directories found matching '.git*' 20:46:14 INFO - Installing collected packages: jsonschema, functools32 20:46:14 INFO - Running setup.py install for functools32 20:46:14 INFO - warning: no files found matching '*.txt' 20:46:14 INFO - no previously-included directories found matching 'build' 20:46:14 INFO - no previously-included directories found matching 'dist' 20:46:14 INFO - no previously-included directories found matching '.git*' 20:46:14 INFO - Successfully installed jsonschema functools32 20:46:14 INFO - Cleaning up... 20:46:14 INFO - Return code: 0 20:46:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:46: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')]} 20:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46: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')]} 20:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46: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', '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 0x7f38987faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1529ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526f60>, '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 0x1527d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', '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 20:46: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:46: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 functools32==3.2.3-2 20:46:14 INFO - Using env: {'DISPLAY': ':0', 20:46:14 INFO - 'HOME': '/home/cltbld', 20:46:14 INFO - 'LANG': 'en_US.UTF-8', 20:46:14 INFO - 'LANGUAGE': 'en_US:en', 20:46:14 INFO - 'LOGNAME': 'cltbld', 20:46:14 INFO - 'MAIL': '/var/mail/cltbld', 20:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:14 INFO - 'MOZ_NO_REMOTE': '1', 20:46:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:14 INFO - 'NO_EM_RESTART': '1', 20:46:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:14 INFO - 'PWD': '/builds/slave/test', 20:46:14 INFO - 'SHELL': '/bin/bash', 20:46:14 INFO - 'SHLVL': '1', 20:46:14 INFO - 'TERM': 'linux', 20:46:14 INFO - 'TMOUT': '86400', 20:46:14 INFO - 'USER': 'cltbld', 20:46:14 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', 20:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:14 INFO - '_': '/tools/buildbot/bin/python'} 20:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:46:15 INFO - Cleaning up... 20:46:15 INFO - Return code: 0 20:46:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f38987faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1529ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526f60>, '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 0x1527d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', '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 20:46:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:46:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:46:15 INFO - Using env: {'DISPLAY': ':0', 20:46:15 INFO - 'HOME': '/home/cltbld', 20:46:15 INFO - 'LANG': 'en_US.UTF-8', 20:46:15 INFO - 'LANGUAGE': 'en_US:en', 20:46:15 INFO - 'LOGNAME': 'cltbld', 20:46:15 INFO - 'MAIL': '/var/mail/cltbld', 20:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:15 INFO - 'MOZ_NO_REMOTE': '1', 20:46:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:15 INFO - 'NO_EM_RESTART': '1', 20:46:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:15 INFO - 'PWD': '/builds/slave/test', 20:46:15 INFO - 'SHELL': '/bin/bash', 20:46:15 INFO - 'SHLVL': '1', 20:46:15 INFO - 'TERM': 'linux', 20:46:15 INFO - 'TMOUT': '86400', 20:46:15 INFO - 'USER': 'cltbld', 20:46:15 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', 20:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:15 INFO - '_': '/tools/buildbot/bin/python'} 20:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:15 INFO - Downloading/unpacking blobuploader==1.2.4 20:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:17 INFO - Downloading blobuploader-1.2.4.tar.gz 20:46:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:46:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:46:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46:18 INFO - Downloading docopt-0.6.1.tar.gz 20:46:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:46:18 INFO - Installing collected packages: blobuploader, requests, docopt 20:46:18 INFO - Running setup.py install for blobuploader 20:46:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:46:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:46:18 INFO - Running setup.py install for requests 20:46:18 INFO - Running setup.py install for docopt 20:46:18 INFO - Successfully installed blobuploader requests docopt 20:46:18 INFO - Cleaning up... 20:46:18 INFO - Return code: 0 20:46:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46:18 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')]} 20:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:18 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')]} 20:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:18 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 0x7f38987faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1529ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526f60>, '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 0x1527d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', '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 20:46:18 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 20:46:18 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 20:46:18 INFO - Using env: {'DISPLAY': ':0', 20:46:18 INFO - 'HOME': '/home/cltbld', 20:46:18 INFO - 'LANG': 'en_US.UTF-8', 20:46:18 INFO - 'LANGUAGE': 'en_US:en', 20:46:18 INFO - 'LOGNAME': 'cltbld', 20:46:18 INFO - 'MAIL': '/var/mail/cltbld', 20:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:18 INFO - 'MOZ_NO_REMOTE': '1', 20:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:18 INFO - 'NO_EM_RESTART': '1', 20:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:18 INFO - 'PWD': '/builds/slave/test', 20:46:18 INFO - 'SHELL': '/bin/bash', 20:46:18 INFO - 'SHLVL': '1', 20:46:18 INFO - 'TERM': 'linux', 20:46:18 INFO - 'TMOUT': '86400', 20:46:18 INFO - 'USER': 'cltbld', 20:46:18 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', 20:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:18 INFO - '_': '/tools/buildbot/bin/python'} 20:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:46:19 INFO - Running setup.py (path:/tmp/pip-SEXxya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:46:19 INFO - Running setup.py (path:/tmp/pip-s3DdnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:46:19 INFO - Running setup.py (path:/tmp/pip-WdST8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:46:19 INFO - Running setup.py (path:/tmp/pip-PLtZHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:46:19 INFO - Running setup.py (path:/tmp/pip-ocImQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:46:19 INFO - Running setup.py (path:/tmp/pip-gfE4bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:46:19 INFO - Running setup.py (path:/tmp/pip-xjJtAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:46:19 INFO - Running setup.py (path:/tmp/pip-7b5y5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:46:19 INFO - Running setup.py (path:/tmp/pip-BqMGPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:46:19 INFO - Running setup.py (path:/tmp/pip-UBCsQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:46:19 INFO - Running setup.py (path:/tmp/pip-P7Ft6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:46:19 INFO - Running setup.py (path:/tmp/pip-xnXymM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:46:19 INFO - Running setup.py (path:/tmp/pip-yqjcdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:46:19 INFO - Running setup.py (path:/tmp/pip-NYTUPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:20 INFO - Running setup.py (path:/tmp/pip-LtTyuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:46:20 INFO - Running setup.py (path:/tmp/pip-zWkNUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:46:20 INFO - Running setup.py (path:/tmp/pip-5i9WYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:46:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:46:20 INFO - Running setup.py install for manifestparser 20:46:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:46:20 INFO - Running setup.py install for mozcrash 20:46:20 INFO - Running setup.py install for mozdebug 20:46:20 INFO - Running setup.py install for mozdevice 20:46:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:46:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:46:20 INFO - Running setup.py install for mozfile 20:46:20 INFO - Running setup.py install for mozhttpd 20:46:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:46:20 INFO - Running setup.py install for mozinfo 20:46:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:46:20 INFO - Running setup.py install for mozInstall 20:46:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:46:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:46:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:46:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:46:21 INFO - Running setup.py install for mozleak 20:46:21 INFO - Running setup.py install for mozlog 20:46:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:46:21 INFO - Running setup.py install for moznetwork 20:46:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:46:21 INFO - Running setup.py install for mozprocess 20:46:21 INFO - Running setup.py install for mozprofile 20:46:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:46:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:46:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:46:21 INFO - Running setup.py install for mozrunner 20:46:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:46:21 INFO - Running setup.py install for mozscreenshot 20:46:21 INFO - Running setup.py install for moztest 20:46:21 INFO - Running setup.py install for mozversion 20:46:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:46:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:46:22 INFO - Cleaning up... 20:46:22 INFO - Return code: 0 20:46:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:22 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 0x7f38987faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1529ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526f60>, '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 0x1527d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', '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 20:46:22 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 20:46:22 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 20:46:22 INFO - Using env: {'DISPLAY': ':0', 20:46:22 INFO - 'HOME': '/home/cltbld', 20:46:22 INFO - 'LANG': 'en_US.UTF-8', 20:46:22 INFO - 'LANGUAGE': 'en_US:en', 20:46:22 INFO - 'LOGNAME': 'cltbld', 20:46:22 INFO - 'MAIL': '/var/mail/cltbld', 20:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:22 INFO - 'MOZ_NO_REMOTE': '1', 20:46:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:22 INFO - 'NO_EM_RESTART': '1', 20:46:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:22 INFO - 'PWD': '/builds/slave/test', 20:46:22 INFO - 'SHELL': '/bin/bash', 20:46:22 INFO - 'SHLVL': '1', 20:46:22 INFO - 'TERM': 'linux', 20:46:22 INFO - 'TMOUT': '86400', 20:46:22 INFO - 'USER': 'cltbld', 20:46:22 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', 20:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:22 INFO - '_': '/tools/buildbot/bin/python'} 20:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:46:22 INFO - Running setup.py (path:/tmp/pip-XDlyXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:46:22 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)) 20:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:46:22 INFO - Running setup.py (path:/tmp/pip-9l4eiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:46:22 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)) 20:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:46:22 INFO - Running setup.py (path:/tmp/pip-Cigiu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:46:22 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)) 20:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:46:22 INFO - Running setup.py (path:/tmp/pip-hbA6wI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:46:22 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)) 20:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:46:22 INFO - Running setup.py (path:/tmp/pip-SecqCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:46:22 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)) 20:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:46:22 INFO - Running setup.py (path:/tmp/pip-lTMcSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:46:22 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)) 20:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:46:22 INFO - Running setup.py (path:/tmp/pip-2Qvsj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:46:22 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)) 20:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:46:22 INFO - Running setup.py (path:/tmp/pip-TH4n43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:46:22 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)) 20:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:46:22 INFO - Running setup.py (path:/tmp/pip-K3bGsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:46:22 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)) 20:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:46:22 INFO - Running setup.py (path:/tmp/pip-sWByNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:46:22 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)) 20:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:46:22 INFO - Running setup.py (path:/tmp/pip-gV7Gb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:46:23 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)) 20:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:46:23 INFO - Running setup.py (path:/tmp/pip-72Tt4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:46:23 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)) 20:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:46:23 INFO - Running setup.py (path:/tmp/pip-uEmtBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:46:23 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)) 20:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:46:23 INFO - Running setup.py (path:/tmp/pip-QjW0zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:46:23 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)) 20:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:23 INFO - Running setup.py (path:/tmp/pip-pvWyTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:23 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)) 20:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:46:23 INFO - Running setup.py (path:/tmp/pip-ZFBL67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:46:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:46:23 INFO - Running setup.py (path:/tmp/pip-ijbH_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:46:23 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)) 20:46:23 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)) 20:46:23 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)) 20:46:23 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)) 20:46:23 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)) 20:46:23 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)) 20:46:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:46:23 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 20:46:23 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 20:46:23 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 20:46:23 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 20:46:23 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 20:46:23 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 20:46:25 INFO - Downloading blessings-1.6.tar.gz 20:46:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:46:25 INFO - Installing collected packages: blessings 20:46:25 INFO - Running setup.py install for blessings 20:46:25 INFO - Successfully installed blessings 20:46:25 INFO - Cleaning up... 20:46:25 INFO - Return code: 0 20:46:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:46:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:46:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:46:25 INFO - Reading from file tmpfile_stdout 20:46:25 INFO - Current package versions: 20:46:25 INFO - argparse == 1.2.1 20:46:25 INFO - blessings == 1.6 20:46:25 INFO - blobuploader == 1.2.4 20:46:25 INFO - docopt == 0.6.1 20:46:25 INFO - functools32 == 3.2.3-2 20:46:25 INFO - jsonschema == 2.5.1 20:46:25 INFO - manifestparser == 1.1 20:46:25 INFO - mozInstall == 1.12 20:46:25 INFO - mozcrash == 1.0 20:46:25 INFO - mozdebug == 0.1 20:46:25 INFO - mozdevice == 0.48 20:46:25 INFO - mozfile == 1.2 20:46:25 INFO - mozhttpd == 0.7 20:46:25 INFO - mozinfo == 0.9 20:46:25 INFO - mozleak == 0.1 20:46:25 INFO - mozlog == 3.4 20:46:25 INFO - moznetwork == 0.27 20:46:25 INFO - mozprocess == 0.23 20:46:25 INFO - mozprofile == 0.28 20:46:25 INFO - mozrunner == 6.13 20:46:25 INFO - mozscreenshot == 0.1 20:46:25 INFO - mozsystemmonitor == 0.3 20:46:25 INFO - moztest == 0.7 20:46:25 INFO - mozversion == 1.4 20:46:25 INFO - psutil == 3.1.1 20:46:25 INFO - requests == 1.2.3 20:46:25 INFO - wsgiref == 0.1.2 20:46:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46:25 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')]} 20:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:25 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')]} 20:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:25 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 0x7f38987faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1529ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526f60>, '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 0x1527d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', '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 20:46:25 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 20:46:25 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 20:46:25 INFO - Using env: {'DISPLAY': ':0', 20:46:25 INFO - 'HOME': '/home/cltbld', 20:46:25 INFO - 'LANG': 'en_US.UTF-8', 20:46:25 INFO - 'LANGUAGE': 'en_US:en', 20:46:25 INFO - 'LOGNAME': 'cltbld', 20:46:25 INFO - 'MAIL': '/var/mail/cltbld', 20:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:25 INFO - 'MOZ_NO_REMOTE': '1', 20:46:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:25 INFO - 'NO_EM_RESTART': '1', 20:46:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:25 INFO - 'PWD': '/builds/slave/test', 20:46:25 INFO - 'SHELL': '/bin/bash', 20:46:25 INFO - 'SHLVL': '1', 20:46:25 INFO - 'TERM': 'linux', 20:46:25 INFO - 'TMOUT': '86400', 20:46:25 INFO - 'USER': 'cltbld', 20:46:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', 20:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:25 INFO - '_': '/tools/buildbot/bin/python'} 20:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:26 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)) 20:46:26 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)) 20:46:26 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)) 20:46:26 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)) 20:46:26 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)) 20:46:26 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)) 20:46:26 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)) 20:46:26 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)) 20:46:26 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)) 20:46:26 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)) 20:46:26 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)) 20:46:26 INFO - Cleaning up... 20:46:26 INFO - Return code: 0 20:46:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:26 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 0x7f38987faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1529ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526f60>, '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 0x1527d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', '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 20:46:26 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 20:46:26 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 20:46:26 INFO - Using env: {'DISPLAY': ':0', 20:46:26 INFO - 'HOME': '/home/cltbld', 20:46:26 INFO - 'LANG': 'en_US.UTF-8', 20:46:26 INFO - 'LANGUAGE': 'en_US:en', 20:46:26 INFO - 'LOGNAME': 'cltbld', 20:46:26 INFO - 'MAIL': '/var/mail/cltbld', 20:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:26 INFO - 'MOZ_NO_REMOTE': '1', 20:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:26 INFO - 'NO_EM_RESTART': '1', 20:46:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:26 INFO - 'PWD': '/builds/slave/test', 20:46:26 INFO - 'SHELL': '/bin/bash', 20:46:26 INFO - 'SHLVL': '1', 20:46:26 INFO - 'TERM': 'linux', 20:46:26 INFO - 'TMOUT': '86400', 20:46:26 INFO - 'USER': 'cltbld', 20:46:26 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', 20:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:26 INFO - '_': '/tools/buildbot/bin/python'} 20:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:46:26 INFO - Cleaning up... 20:46:26 INFO - Return code: 0 20:46:26 INFO - Running post-action listener: _resource_record_post_action 20:46:26 INFO - Running post-action listener: _start_resource_monitoring 20:46:26 INFO - Starting resource monitoring. 20:46:26 INFO - [mozharness: 2016-12-22 04:46:26.477435Z] Finished create-virtualenv step (success) 20:46:26 INFO - [mozharness: 2016-12-22 04:46:26.477887Z] Running install step. 20:46:26 INFO - Running pre-action listener: _resource_record_pre_action 20:46:26 INFO - Running main action method: install 20:46:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:46:26 INFO - Reading from file tmpfile_stdout 20:46:26 INFO - Detecting whether we're running mozinstall >=1.0... 20:46:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:46:26 INFO - Reading from file tmpfile_stdout 20:46:26 INFO - Output received: 20:46:26 INFO - Usage: mozinstall [options] installer 20:46:26 INFO - Options: 20:46:26 INFO - -h, --help show this help message and exit 20:46:26 INFO - -d DEST, --destination=DEST 20:46:26 INFO - Directory to install application into. [default: 20:46:26 INFO - "/builds/slave/test"] 20:46:26 INFO - --app=APP Application being installed. [default: firefox] 20:46:26 INFO - mkdir: /builds/slave/test/build/application 20:46:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:46:42 INFO - Reading from file tmpfile_stdout 20:46:42 INFO - Output received: 20:46:42 INFO - /builds/slave/test/build/application/firefox/firefox 20:46:42 INFO - Running post-action listener: _resource_record_post_action 20:46:42 INFO - [mozharness: 2016-12-22 04:46:42.696554Z] Finished install step (success) 20:46:42 INFO - [mozharness: 2016-12-22 04:46:42.696797Z] Running run-tests step. 20:46:42 INFO - Running pre-action listener: _resource_record_pre_action 20:46:42 INFO - Running main action method: run_tests 20:46:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:46:42 INFO - Python 2.7.3 20:46:42 INFO - Return code: 0 20:46:42 INFO - grabbing minidump binary from tooltool 20:46: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')]} 20:46: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 0x1526f60>, '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 0x1527d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:46: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 20:46: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 20:46: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 20:46:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:46:42 INFO - Return code: 0 20:46:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:46:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:46:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:46:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:46:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:46:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 20:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 20:46:42 INFO - Using env: {'DISPLAY': ':0', 20:46:42 INFO - 'HOME': '/home/cltbld', 20:46:42 INFO - 'LANG': 'en_US.UTF-8', 20:46:42 INFO - 'LANGUAGE': 'en_US:en', 20:46:42 INFO - 'LOGNAME': 'cltbld', 20:46:42 INFO - 'MAIL': '/var/mail/cltbld', 20:46:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:46:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:42 INFO - 'MOZ_NO_REMOTE': '1', 20:46:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:46:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:42 INFO - 'NO_EM_RESTART': '1', 20:46:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:42 INFO - 'PWD': '/builds/slave/test', 20:46:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:46:42 INFO - 'SHELL': '/bin/bash', 20:46:42 INFO - 'SHLVL': '1', 20:46:42 INFO - 'TERM': 'linux', 20:46:42 INFO - 'TMOUT': '86400', 20:46:42 INFO - 'USER': 'cltbld', 20:46:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391', 20:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:42 INFO - '_': '/tools/buildbot/bin/python'} 20:46:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 20:46:42 INFO - mozversion application_buildid: 20161221190653 20:46:42 INFO - mozversion application_changeset: 62eb5ff8893e7803da94b2e52bd108285aa1f5fe 20:46:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:46:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:46:42 INFO - mozversion application_name: Firefox 20:46:42 INFO - mozversion application_remotingname: firefox-dev 20:46:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:46:42 INFO - mozversion application_vendor: Mozilla 20:46:42 INFO - mozversion application_version: 52.0a2 20:46:42 INFO - mozversion platform_buildid: 20161221190653 20:46:42 INFO - mozversion platform_changeset: 62eb5ff8893e7803da94b2e52bd108285aa1f5fe 20:46:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:46:42 INFO - mozversion platform_version: 52.0a2 20:46:42 INFO - using testdate: 1482382002 20:46:42 INFO - actual date: 1482382002 20:46:42 INFO - starting webserver on 'localhost:60400' 20:46:42 INFO - SUITE-START | Running 2 tests 20:46:42 INFO - TEST-START | dromaeo_css 20:46:42 INFO - operating with platform_type : linux_ 20:46:42 INFO - Initialising browser for dromaeo_css test... 20:46:42 INFO - TEST-INFO | started process 31613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeFyERU/profile http://localhost:60400/getInfo.html) 20:46:47 INFO - PROCESS | 31613 | __metrics Screen width/height:1600/1200 20:46:47 INFO - PROCESS | 31613 | colorDepth:24 20:46:47 INFO - PROCESS | 31613 | Browser inner width/height: 1024/697 20:46:47 INFO - PROCESS | 31613 | __metrics 20:46:47 INFO - PROCESS | 31613 | 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" 20:46:47 INFO - PROCESS | 31613 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:46:48 INFO - PROCESS | 31613 | console.error: PushService: 20:46:48 INFO - PROCESS | 31613 | stateChangeProcessEnqueue: Error transitioning state 20:46:48 INFO - PROCESS | 31613 | UnknownError 20:46:48 INFO - TEST-INFO | 31613: exit 0 20:46:48 INFO - Browser initialized. 20:46:48 INFO - Running cycle 1/1 for dromaeo_css test... 20:46:48 INFO - TEST-INFO | started process 31709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeFyERU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:47:00 INFO - PROCESS | 31709 | RSS: Main: 144826368 20:47:00 INFO - PROCESS | 31709 | 20:47:51 INFO - PROCESS | 31709 | 1482382071963 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:50:01 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:60400/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60400/tests/dromaeo/cssquery-ext.html) 20:50:03 INFO - PROCESS | 31709 | RSS: Main: 245321728 20:50:03 INFO - PROCESS | 31709 | 20:53:05 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:60400/tests/dromaeo/cssquery-ext.html (next: http://localhost:60400/tests/dromaeo/cssquery-jquery.html) 20:53:06 INFO - PROCESS | 31709 | RSS: Main: 239460352 20:53:06 INFO - PROCESS | 31709 | 20:56:08 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:60400/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60400/tests/dromaeo/cssquery-mootools.html) 20:56:08 INFO - PROCESS | 31709 | RSS: Main: 177065984 20:56:08 INFO - PROCESS | 31709 | 20:59:10 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:60400/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60400/tests/dromaeo/cssquery-prototype.html) 20:59:11 INFO - PROCESS | 31709 | RSS: Main: 213311488 20:59:11 INFO - PROCESS | 31709 | 21:02:13 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:60400/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60400/tests/dromaeo/cssquery-yui.html) 21:02:14 INFO - PROCESS | 31709 | RSS: Main: 175607808 21:02:14 INFO - PROCESS | 31709 | 21:05:16 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:60400/tests/dromaeo/cssquery-yui.html (next: http://localhost:60400/tests/dromaeo/cssquery-dojo.html) 21:05:17 INFO - PROCESS | 31709 | RSS: Main: 267616256 21:05:17 INFO - PROCESS | 31709 | 21:05:17 INFO - PROCESS | 31709 | __start_tp_report 21:05:17 INFO - PROCESS | 31709 | _x_x_mozilla_page_load 21:05:17 INFO - PROCESS | 31709 | _x_x_mozilla_page_load_details 21:05:17 INFO - PROCESS | 31709 | |i|pagename|runs| 21:05:17 INFO - PROCESS | 31709 | |0;dojo.html;3174.7618928580355;3201.9679803201975;3210.293735378216;3230.77384583079;3252.170696472399;5429.267048948391;5431.4568543145615;5472.206530053145;5474.42518535554;5490.423505531921;5422.566194704424;5504.4770746779095;5513.393526712059;5521.171824226368;5522.751476183571;4893.730844803535;4930.728809915453;4959.380077490314;4999.675021123633;5036.722980236085;4870.610351171916;5025.0954828130925;5066.923996140061;5085.440601533828;5103.897922041557;4859.1010663027455;4919.60643148549;4929.309896614477;4965.453800081988;4974.651774375795;4942.827001054964;4980.626453016002;4982.352294201767;5050.065737838475;5079.187330027178;4806.1829488986605;4934.210526315772;4954.3063971044085;4981.950180498185;5009.524095210949;5291.497307755757;5321.600879934021;5355.544778693816;5357.330333708286;5430.809921652763;5801.53587712982;5815.273090863642;5856.32652244993;5860.267466566679;5860.648361098348;5691.06097493913;5873.383294754032;5900.616459930091;5903.380145084747;5905.616134951258;5299.761510732026;5337.332833395825;5364.195370694388;5413.675179489164;5431.049566325877;5833.591648584643;5858.238429004287;5864.149698293723;5869.618474799125;5870.970645146747;5546.55627549795;5654.519365853948;5656.2929633795775;5656.60403771732;5663.9716801415725;5632.60571759981;5768.105943578752;5774.855628609318;5782.566307526952;5878.470937615635;5809.3609702932645;5824.912626310609;5830.679312637845;5842.532597392198;5850.970745146332;5783.132530120515;5827.184194212814;5828.766849326064;5831.329397119301;5855.092460668518;4433.6009759121835;4464.374987501752;4469.687121901436;4503.68474206809;4512.481064677539;4015.13674559971;4061.248668996245;4064.532578753422;4089.5501494835544;4090.590940905945;5527.834164975057;5528.19841123043;5541.418151094077;5575.163725441216;5578.497935185853;5696.544276457957;5744.167095771173;5805.419458054161;5815.912761308584;5822.883542329215;5556.388797232301;5560.777568897199;5561.860953476195;5578.497935185853;5597.188407680864;5059.671121377099;5080.74596270185;5082.949170508322;5086.364204474441;5111.821086261963;5864.530837532901;5886.970565147147;6008.399160083956;6162.568620196544;6165.0444181152;5853.0635098384055;5895.056790913605;5897.262842144732;5929.466348028525;5937.910931335947;6014.578979471395;6043.667598282137;6051.75792968294;6054.27348718139;6089.634621922699;5588.524975377139;5640.069388551007;5740.540756739534;5793.536517078539;5795.159701843125;5753.884922301614;5769.94230057694;5831.183634291117;5884.323302820059;5922.615030023035;5673.950319190963;5711.057675483498;5726;5731.570132240182;5732.283464566929;5586.329640443173;5717.599768016199;5732.971335143465;5733.0540460823495;5740.741666624928;5529.944700553104;5598.440155984369;5616.21373007771;5616.69108199053;5679.744411501575;5651.491365777099;5674.092145256739;5705.343885453226;5708.628939118944;5721;5422.810201643081;5477.589180811535;5481.972590137024;5571.247881535941;5574.804881829116 21:05:17 INFO - PROCESS | 31709 | |1;ext.html;584.9766009359626;605.8788242351529;621.2327775197632;654.1300070905696;667.9499037572183;34202.14494637636;43533;44773.328400074024;44902;44903.999999999956;45945.08109837801;46320.305195422094;46405;46412.76793616027;46481;8044.436889417743;8742.912570874289;8868.733937981839;8876.600552975131;8894.466332020067;7987.960060199691;10276.691699249035;10480.79038419231;10485.842712359283;10703.250772445932;10565.415187721826;10630.415327157003;10631.096356809681;10646.893531064707;10650.201234907374;10442.269041167121;10481.161507079492;10483.056524912718;10485.056344928917;10496.842547361719;10372.792544149075;10432.269741118125;10434.008769166918;10444.321119127233;10446.582136714522;43524.78237608792;43648;43750.562494375285;43753;43879.561204387865;3665.706743460517;3801.7909015004166;3843.942340864889;3923.156521347924;4269.316909294498;32589.511157332658;32799;32910;33160.17099572506;33757.49363759546;4486.932696009562;4494.910101797946;4581.42399114433;4592.3800286961505;4710.905781884378;351756;351854;353164;353956;354278.2286088579;61690;61715.38284617096;62042;62060.68969655213;62126;39444.21111577752;40187;40420.79789601033;42575.787121064815;42648.36027459591;16175.595610109842;16305.429309974332;16319.510414687578;16322.918385407997;16326.591835203977;10635;10841.566337346418;11732.472038758277;12098.092643051807;12182.939085304517;19783.505412364517;20506.79493205049;20606.58786824255;20637.484062898548;20650.690239646417;6833.589984600841;7032.507724459341;7118.327193109615;7127.46544009191;7324.560526368435;999.5152351109706;1060.4591658254346;1083.8916108389099;1105.723569107723;1127.9210455268053;33790;33872.322553548795;33933;34164;34496.655033449846;1119.5297974850582;1136.9147313951487;1148.7070796946725;1175.6884425627215;1220.5544976083843;17170.141492925304;18092;19212.903935480514;19665.705014424795;19723;549211;551695;553424;553447;553793;61084.69457652772;61395.69302153461;61626.38373616296;61666.383336166065;61709;1281.1736430002782;1326.907116501855;1347.5351003903638;1380.130517773796;1415.504573399302;32663.836680816443;34242.31515369629;34650.30699385948;34969;35162.824185878904;53688;54285;54376;54383.18425223546;54422.183667245816;404789;407183;407669;407829;408150;30292;32568.51147232746;32588.83705581457;32983.67016329902;33010.83494582512;50385.49614503808;50506.24240636467;50516;51020;51931.22103168531;42331.365029523964;42519.78740106404;42614.5738542623;43244;43659.78170109129;42859.57140428556;43726.56273437225;43922.560774391844;44429.55570444383;45029.774851125534;43362;44232.778836105615;44406.77796610996;44425.33361999508;44440.33339499975;35695.64304357027;38485.615143848205;38755.6124438752;38772.80613596914;39262.80368598139;28696.713032869404;29167.708322917348;29181.7081829179;29368.706312936596;29482.262943426587 21:05:17 INFO - PROCESS | 31709 | |2;jquery.html;395.57673289580123;427.06046697266015;431.01370180022946;434.3875136058157;441.4481897627963;16277.674446511077;19427.805721942776;20905.895470522628;20980.999999999964;21107.2612458564;19571.902140489314;19713.11290991905;19912.90043549784;20040.59918801627;20465.897670511626;5580.804671836477;5830.82507524775;5837.182794408786;5837.474627283544;5895.528357731371;5727.083666613343;5997.820065398045;6016.729247183887;6097.5426842986735;6101.2983506896835;6085.204864564942;6097.298810636767;6109.327973922865;6117;6479.287278399396;6468.773592924249;6587.868242635144;6615.603063816162;6621.039949207386;6624.701888414985;5654.293213348332;5673.461021202979;5720.542356611461;5726.599138060337;5958.314793798725;12974.156679815782;13132.277724725136;13193.868061319456;13538.661533461644;13799.724005519833;2345.4839935214227;2377.5244951009695;2415.0943396226417;2502.637117617935;2555.3483861615355;10224.437655928921;10412.531436085394;10801.513931873005;10985.560577576887;11295.548178072868;1959.8530110241647;1999.2003198720483;2012.87922724637;2026.6149431607948;2070.12019891547;91578.08421915829;91861.54069229611;92237;92466;96238;9958.153556947596;10444.321119127233;11135;11898.46456909441;12188.146829721834;13808.861911380958;14974.850251497563;15847.366105355888;15969.840301596836;15981.121038343003;7571.091469023752;7744.92255077442;7874.527528348203;7874.527528348317;8194.877076843852;7365.705371785069;7384.630768461556;7415.073115860518;7533.924660753432;7588.203238659971;5080.669756465892;5128.230765385148;5140.691558506502;5211.42674305826;5256.9211461827335;2069.3378119001777;2091.4771307173205;2112.102356498482;2125.330520885916;2171.250918433138;916.8349697054595;948.743839163422;1029.917606591471;1051.206339213904;1060.6446840308583;20212.989350532414;20354.491137721674;20606.793932060787;20634.27780027692;20699.379018629163;993.8310487217191;995.2485873165714;996.5764550066338;1019.3934608907688;1035.3735989726258;10609.681709548726;11502.482388292547;11509.827352589718;11746.412679365998;11825.526978920747;483870;485461;489432;496035;498080;59140.7042964791;89251.55374223087;92933;99744.5012774946;100899.49550252348;1007.1640538353149;1016.6594190945968;1018.4195008844887;1029.0943969306961;1032.932859364139;17535.736963945295;17633.823661763217;17976.820231797516;18178.636427271646;18273.3604323848;43880.78059609682;44479.77760111179;44984.1003179928;45090.323645146;45129.548704512534;59589.40410595838;59712.402875970685;60345.698271508365;60852;61813.690931545054;7828.686852526063;8879.200871921557;8903.688370906988;8931.668140951504;9517.381370210915;12488.25070495773;13559.389827457591;13707.862921371057;14003.789943151065;14126.293685315899;6390.073439351361;9233.58448869789;10897.891021089688;12142.85004915941;12432.191907525981;12032.639020829389;12078.879211207775;12081.456334464794;12164.148509604243;12291.50833966667;12267.75464490723;12313.753724925631;12340.629781106582;12372.62882113538;12623.495060197489;7944.920550794418;8204.54874981858;8364.539950302791;8463.195996380335;8613.69852055175;8864.64541418336;11615.245009074382;12217.266963982189;12221;12262.816057759319 21:05:17 INFO - PROCESS | 31709 | |3;mootools.html;1371.4445649511938;1469.2947385255081;1481.2889812889814;1614.5882799886028;1792.9820701792978;7028.61342626156;7519.924800751991;7556.3577095946775;7795.3763698904095;7805.297523222909;7836.96081519593;7898.723544675938;7901.762947111596;7902.40731945105;7904.446688731791;2396.820238482112;2413.3363325085566;2423.987880060597;2426.2357357432443;2427.3810178404483;2394.461246219604;2409.373562873648;2463.051725085846;2477.3896966971524;2477.5044991001782;2397.736249012607;2439.1828737373003;2468.7160976487667;2474.1711526638596;2474.3690358958443;2304;2334.789868911806;2352.764723527659;2359.49270906755;2374.6912901322717;2357.328161473989;2371.91698290559;2394.6288325309606;2395.5807733646543;2396.5446565152565;7616.352610028154;7791.766247012599;7854.8821767673535;7884.64519096642;7973.800654983614;5024.547790698818;5146.536811686929;5151.819686310999;5156.303898973628;5167;3298.356820420019;3311.933761324784;3321.086701157177;3380.6112297085906;3418.8461519231696;1080.6811990462832;1126.2791813239533;1131.7906187355366;1135.7955567997758;1139.4302848575712;10704.732381690443;10748.892511074868;10814.243002989715;10830.296030757976;10832.40421776802;4037.7577345359373;4316;4348.652107831366;4422.20400327944;4424.269995450779;8708.608112634947;8717;8722.433041852386;8722.651093956298;8729.650813967497;4996.950030499721;5002.724850133205;5003.099442100384;5003.949960500348;5011.323471331323;4290.549492303326;4409.889752756207;4507.909841803145;4567.566081222279;4680.110778951988;3780.584135745066;3870.2259548089933;3886.7279290449396;3910.56983731795;3977.423273625308;1281.8397700287464;1286.9292188929699;1287.2019348004296;1293.1982171054008;1312.967175820612;622.6948795090373;832.496339714464;889.3418870036256;909.486140330711;928;5533.861653458615;5567.860803479945;5603.803866864721;5620.4660557247;5647.407022262685;933.7945651956559;962.6486332488591;990.7968866382374;994.8955359687274;998.2164001258977;3575.1419659282105;3686.4101743721412;3802.9809850951124;3877.2827027000094;3884.76691398517;9174.724758257264;9785.07041831025;9785.608575657036;9787.16809071237;9812.215022798158;9469.857952130724;9512.667056652985;9675.371100878421;9715.36850104741;9734.269929755297;7507.924920750832;7527.209642987407;7605.6957721691615;7629.351505122127;7632.3512501438;5525.254090697705;5549.889002220014;5637.774489020393;5675.31896172462;5725.255716756795;8978.236849867835;9042.819143617222;9080.909190908007;9084.591193396182;9098.590563424794;9025.819483610423;9268.53657317145;9373.671921482715;9382.859257111013;9385.483798391155;6872.312768723088;6907.620080895398;6909.689063992032;6919.342662447059;6938.098047253825;7692.9615351922885;7694.769156925301;7704.499207551491;7771.689132434639;7786.221377862168;6892.517523773287;6978.232394436506;6983.790486285419;6984.196817365864;7037.612931288828;6911.688973996082;7078.53989490702;7099.858002840017;7104.644767761488;7114.0396046535125;6418.165638467156;6554.63949482783;6555.836104097436;6557.1147895035465;6558.868822623616;4881.29221262922;4956.306117143675;4991.376077990251;5012.724300163381;5134.075866344094;4845.878853028703;4879.853604391874;4906.95093049065;4907.288443175791;5037.445880953165 21:05:17 INFO - PROCESS | 31709 | |4;prototype.html;348;349.5124301599269;352.8447483107434;356.90363601827505;358.1011660731563;5478.9726051369735;5533.170024496318;5545.77816887324;5586.972065139674;5605.299337582802;5185.107435785939;5200.661956972804;5326.547243484309;5328.17413300939;5510.862228444281;4229.830806767725;4235.343521754117;4249.725082475261;4250.511191213003;4283.400323954649;4232.470941132358;4233.597808208231;4248.936265956013;4276.246738837078;4321.157374312011;4001.339778936472;4052.959470405288;4179.026957920066;4246.532881383046;4265.848220980349;4232.46052368578;4233.301505251629;4234.449521562193;4242.109157077018;4243.215005224043;3815.9809200954096;3825.8087095645383;3832.6550610444915;3834.9808250958845;3837.1174629835295;5132.613334799336;5233.267342572043;5246.973765131188;5249.527542521153;5354.223637572569;4804.4234691836855;4825.793551612097;4861.173600487926;4867.415910090812;4881.145799485076;5562.582806289544;5562.7774889004395;5567.610267281292;5571.192177134333;5625.774969001235;4083.9387409188885;4130.607592278729;4187.8324867005285;4193.098483825962;4247.660187185018;5830.242068531106;5830.4169583041785;5840.912386314209;5846.7953621623465;5853.32686741026;4300.763458009839;4312.374705667723;4312.805923733376;4333.7833108345085;4334.869953901388;4258.297380932174;4310.4611923509565;4327.675424343187;4345.391645169679;4363.825446982149;4850.102730994778;4863.975680121577;4864.318995340655;4864.810835124137;4893.608511319086;5653.462921022497;5653.575981801381;5661.716914154275;5672.376038635747;5688.146777983253;1360.8366995960548;1382.67507135825;1400.4888215801363;1445.262915912892;1453.1644304524941;985.3841349156777;994.472929347447;1017.8066167428314;1021.4382089850552;1023.8771347438355;5246.193286591655;5290.735463226823;5297.894042119136;5312.787488500417;5342.679439233659;5568.972155139199;5594.636348637326;5597.496225339739;5597.580181486404;5620.932022915715;5098.872528186825;5252.343457067866;5298.8940221196135;5309.840704778863;5337.839864804062;2922.6931172227037;2929;2934.8385838779072;2946.67399670145;2959.896403625906;5751.597388182787;5761.9135712964335;5763.7982670606325;5770.826875193751;5785.363610002896;5415.783368665288;5634.4365563443325;5643.153526970905;5681.886362272731;5724.112762521816;5756.683382414008;5769.009691656372;5782.768689252467;5825.446582574734;5902.881942361215;5424.2134890439875;5465.584024901411;5611.943880561305;5699.971500142473;5707.600467967369;5519.917201242065;5526.972365138148;5528.91706624409;5556.972215138899;5578.525825304894;5768.990426675231;5789.899919015374;5797.652140871562;5800.564957628279;5834.533237340917;3992.9001774954695;4184.769837658958;4199.614127338033;4244.389700334334;4271.893202669834;5816.7605471892775;5822.417758224144;5831.7375718091935;5834.716362400265;5845;5476.315460567429;5627.480580243393;5635.492805647511;5639.379668236409;5657.264555607745;5349.631706787265;5647.576431767716;5684.152650388558;5685.829425117253;5698.971505142447;5460.754266058117;5662.433756624469;5665;5686.914696279477;5703.5722320826935;5700.543956483554;5755.7409916553015;5774.509166720875;5774.942250577608;5775.33583637887;5625.437456254342;5641.323041235078;5644.294463192101;5655.9253741788925;5722.141678748221 21:05:17 INFO - PROCESS | 31709 | |5;yui.html;741.6291854072964;758.2455456820461;810.8580998325295;833.9374546908982;848.3128665780716;14040.789388159186;14631.926840365782;14744.6313842154;14918.850811491882;15041.172735499544;12920.935395323033;14275.4289828407;14412;14417.134971901667;14452.349644266007;841.1882533355326;852.7910661887846;859.5573279760928;860.0324634785866;861.130258438978;835.9289460395873;842.061101871412;843.3969711656165;844.1811442900377;844.4089137603671;878.7846977490492;879.2833840420069;879.8284334554764;879.9956000219989;883.3860466975455;873.8383399071192;875.9956200218958;876.2902049340055;876.4478378621492;877.0177401310541;643.8326035230826;648.5168549430657;648.8507643242081;649.7433513762085;649.7953144759385;11863.46614402354;12250.816237756351;12265.938670306592;12295.016398688083;12446.128770986035;12716.872831271754;12784.232946023269;13067.803982940264;13246.536371227057;13353.465861365534;10930.605595726509;11067.50196241171;11150.553977840877;11158.330500169935;11261.774764504664;3828.5979972102805;3837.6929845612563;3898.8245528951265;3928.8428462861452;3955.7230993830444;56743.432565674644;57134.428655713324;59027;63606.3639363605;63977.360226397606;10694.144468442506;10876.347419154876;10977.341359518296;10990.890091099147;11050.06074483678;18138.818611813713;18280.90859545694;18435.72346414805;18436.907815460836;18467;8554.700585479479;8578.742637720878;8591.656333746705;8692.608832602547;8775.736727898173;4596.080783843245;4642.141203877293;4662.347271382009;4719.197736384823;4772.188727916263;3351.6648335166287;3426.194844211608;3454.809985450774;3459.1870910336556;3465.358908601917;602.2321540036401;606.6390497653889;619.3899009475663;620.8416853702277;621.7481919822479;714.5426926766874;754.1176823116966;760.3954855889581;769.2499812682702;771.3713323641215;9375.90624093764;9602.471864047404;9638.373505722106;9780.853287200698;9822.214222862154;587.8030859661976;666.4368608525788;687.7214728035153;773.3697036914897;801.8837268596137;4490.685652004394;4805.203161891002;4906.435759887588;4965.577925876341;4971.975140124277;50932.49067509278;51861.740691296305;69636;80880.19119808727;84919;72344.63827680828;73195;73311.26688733151;74342.6282868593;75777.62111189519;65217;67203;67343;67527.32472675308;67601;8448.281896038905;8553.230209281195;8702.216800487986;8715.30277577805;8753.518556479456;44731;45548.31677524774;45896.770516147204;46199.76900115612;47560.286595701786;39216.411753823144;39356;45872.54127458816;61509.384906152154;61811.38188618236;10825;10892.40091794959;11104.111671066134;11691.473883675086;11875.881241187477;12544;12734.235945843278;12789.680257993625;13139.474421023053;14101.29493525299;13715;13833.584992450242;13861.23763193034;14173.503927362493;14891.478798242442;12469.376531173224;12578.559750409058;12622.87377126217;12638.810417843555;14059.22674252926;13092.541761038317;13298.534551290659;13896.305184740924;14159.64600884986;14550.636234094232;11555.2489088209;11564.306141631529;11717.88282117168;11926.284422934305;11977.700557486132;11583.6524904253;11670.70823229426;11694.70763230926;12094.637160885188;12137.332446715516 21:05:17 INFO - PROCESS | 31709 | __end_tp_report 21:05:17 INFO - PROCESS | 31709 | __start_cc_report 21:05:17 INFO - PROCESS | 31709 | _x_x_mozilla_cycle_collect,1076 21:05:17 INFO - PROCESS | 31709 | __end_cc_report 21:05:17 INFO - PROCESS | 31709 | __startTimestamp1482383117222__endTimestamp 21:05:17 INFO - PROCESS | 31709 | 21:05:17 INFO - PROCESS | 31709 | ------- Summary: start ------- 21:05:17 INFO - PROCESS | 31709 | Number of tests: 6 21:05:17 INFO - PROCESS | 31709 | 21:05:17 INFO - PROCESS | 31709 | [#0] dojo.html Cycles:165 Average:5413.13 Median:5588.52 stddev:593.73 (10.6%) stddev-sans-first:569.00 21:05:17 INFO - PROCESS | 31709 | Values: 3174.8 3202.0 3210.3 3230.8 3252.2 5429.3 5431.5 5472.2 5474.4 5490.4 5422.6 5504.5 5513.4 5521.2 5522.8 4893.7 4930.7 4959.4 4999.7 5036.7 4870.6 5025.1 5066.9 5085.4 5103.9 4859.1 4919.6 4929.3 4965.5 4974.7 4942.8 4980.6 4982.4 5050.1 5079.2 4806.2 4934.2 4954.3 4982.0 5009.5 5291.5 5321.6 5355.5 5357.3 5430.8 5801.5 5815.3 5856.3 5860.3 5860.6 5691.1 5873.4 5900.6 5903.4 5905.6 5299.8 5337.3 5364.2 5413.7 5431.0 5833.6 5858.2 5864.1 5869.6 5871.0 5546.6 5654.5 5656.3 5656.6 5664.0 5632.6 5768.1 5774.9 5782.6 5878.5 5809.4 5824.9 5830.7 5842.5 5851.0 5783.1 5827.2 5828.8 5831.3 5855.1 4433.6 4464.4 4469.7 4503.7 4512.5 4015.1 4061.2 4064.5 4089.6 4090.6 5527.8 5528.2 5541.4 5575.2 5578.5 5696.5 5744.2 5805.4 5815.9 5822.9 5556.4 5560.8 5561.9 5578.5 5597.2 5059.7 5080.7 5082.9 5086.4 5111.8 5864.5 5887.0 6008.4 6162.6 6165.0 5853.1 5895.1 5897.3 5929.5 5937.9 6014.6 6043.7 6051.8 6054.3 6089.6 5588.5 5640.1 5740.5 5793.5 5795.2 5753.9 5769.9 5831.2 5884.3 5922.6 5674.0 5711.1 5726.0 5731.6 5732.3 5586.3 5717.6 5733.0 5733.1 5740.7 5529.9 5598.4 5616.2 5616.7 5679.7 5651.5 5674.1 5705.3 5708.6 5721.0 5422.8 5477.6 5482.0 5571.2 5574.8 21:05:17 INFO - PROCESS | 31709 | 21:05:17 INFO - PROCESS | 31709 | [#1] ext.html Cycles:180 Average:60656.01 Median:21347.98 stddev:117938.20 (552.5%) stddev-sans-first:118182.80 21:05:17 INFO - PROCESS | 31709 | Values: 585.0 605.9 621.2 654.1 667.9 34202.1 43533.0 44773.3 44902.0 44904.0 45945.1 46320.3 46405.0 46412.8 46481.0 8044.4 8742.9 8868.7 8876.6 8894.5 7988.0 10276.7 10480.8 10485.8 10703.3 10565.4 10630.4 10631.1 10646.9 10650.2 10442.3 10481.2 10483.1 10485.1 10496.8 10372.8 10432.3 10434.0 10444.3 10446.6 43524.8 43648.0 43750.6 43753.0 43879.6 3665.7 3801.8 3843.9 3923.2 4269.3 32589.5 32799.0 32910.0 33160.2 33757.5 4486.9 4494.9 4581.4 4592.4 4710.9 351756.0 351854.0 353164.0 353956.0 354278.2 61690.0 61715.4 62042.0 62060.7 62126.0 39444.2 40187.0 40420.8 42575.8 42648.4 16175.6 16305.4 16319.5 16322.9 16326.6 10635.0 10841.6 11732.5 12098.1 12182.9 19783.5 20506.8 20606.6 20637.5 20650.7 6833.6 7032.5 7118.3 7127.5 7324.6 999.5 1060.5 1083.9 1105.7 1127.9 33790.0 33872.3 33933.0 34164.0 34496.7 1119.5 1136.9 1148.7 1175.7 1220.6 17170.1 18092.0 19212.9 19665.7 19723.0 549211.0 551695.0 553424.0 553447.0 553793.0 61084.7 61395.7 61626.4 61666.4 61709.0 1281.2 1326.9 1347.5 1380.1 1415.5 32663.8 34242.3 34650.3 34969.0 35162.8 53688.0 54285.0 54376.0 54383.2 54422.2 404789.0 407183.0 407669.0 407829.0 408150.0 30292.0 32568.5 32588.8 32983.7 33010.8 50385.5 50506.2 50516.0 51020.0 51931.2 42331.4 42519.8 42614.6 43244.0 43659.8 42859.6 43726.6 43922.6 44429.6 45029.8 43362.0 44232.8 44406.8 44425.3 44440.3 35695.6 38485.6 38755.6 38772.8 39262.8 28696.7 29167.7 29181.7 29368.7 29482.3 21:05:17 INFO - PROCESS | 31709 | 21:05:17 INFO - PROCESS | 31709 | [#2] jquery.html Cycles:180 Average:29298.33 Median:2528.99 stddev:81133.93 (3208.2%) stddev-sans-first:81332.50 21:05:17 INFO - PROCESS | 31709 | Values: 395.6 427.1 431.0 434.4 441.4 16277.7 19427.8 20905.9 20981.0 21107.3 19571.9 19713.1 19912.9 20040.6 20465.9 5580.8 5830.8 5837.2 5837.5 5895.5 5727.1 5997.8 6016.7 6097.5 6101.3 6085.2 6097.3 6109.3 6117.0 6479.3 6468.8 6587.9 6615.6 6621.0 6624.7 5654.3 5673.5 5720.5 5726.6 5958.3 12974.2 13132.3 13193.9 13538.7 13799.7 2345.5 2377.5 2415.1 2502.6 2555.3 10224.4 10412.5 10801.5 10985.6 11295.5 1959.9 1999.2 2012.9 2026.6 2070.1 91578.1 91861.5 92237.0 92466.0 96238.0 9958.2 10444.3 11135.0 11898.5 12188.1 13808.9 14974.9 15847.4 15969.8 15981.1 7571.1 7744.9 7874.5 7874.5 8194.9 7365.7 7384.6 7415.1 7533.9 7588.2 5080.7 5128.2 5140.7 5211.4 5256.9 2069.3 2091.5 2112.1 2125.3 2171.3 916.8 948.7 1029.9 1051.2 1060.6 20213.0 20354.5 20606.8 20634.3 20699.4 993.8 995.2 996.6 1019.4 1035.4 10609.7 11502.5 11509.8 11746.4 11825.5 483870.0 485461.0 489432.0 496035.0 498080.0 59140.7 89251.6 92933.0 99744.5 100899.5 1007.2 1016.7 1018.4 1029.1 1032.9 17535.7 17633.8 17976.8 18178.6 18273.4 43880.8 44479.8 44984.1 45090.3 45129.5 59589.4 59712.4 60345.7 60852.0 61813.7 7828.7 8879.2 8903.7 8931.7 9517.4 12488.3 13559.4 13707.9 14003.8 14126.3 6390.1 9233.6 10897.9 12142.9 12432.2 12032.6 12078.9 12081.5 12164.1 12291.5 12267.8 12313.8 12340.6 12372.6 12623.5 7944.9 8204.5 8364.5 8463.2 8613.7 8864.6 11615.2 12217.3 12221.0 12262.8 21:05:17 INFO - PROCESS | 31709 | 21:05:17 INFO - PROCESS | 31709 | [#3] mootools.html Cycles:180 Average:5334.84 Median:5529.56 stddev:2833.69 (51.2%) stddev-sans-first:2825.98 21:05:17 INFO - PROCESS | 31709 | Values: 1371.4 1469.3 1481.3 1614.6 1793.0 7028.6 7519.9 7556.4 7795.4 7805.3 7837.0 7898.7 7901.8 7902.4 7904.4 2396.8 2413.3 2424.0 2426.2 2427.4 2394.5 2409.4 2463.1 2477.4 2477.5 2397.7 2439.2 2468.7 2474.2 2474.4 2304.0 2334.8 2352.8 2359.5 2374.7 2357.3 2371.9 2394.6 2395.6 2396.5 7616.4 7791.8 7854.9 7884.6 7973.8 5024.5 5146.5 5151.8 5156.3 5167.0 3298.4 3311.9 3321.1 3380.6 3418.8 1080.7 1126.3 1131.8 1135.8 1139.4 10704.7 10748.9 10814.2 10830.3 10832.4 4037.8 4316.0 4348.7 4422.2 4424.3 8708.6 8717.0 8722.4 8722.7 8729.7 4997.0 5002.7 5003.1 5003.9 5011.3 4290.5 4409.9 4507.9 4567.6 4680.1 3780.6 3870.2 3886.7 3910.6 3977.4 1281.8 1286.9 1287.2 1293.2 1313.0 622.7 832.5 889.3 909.5 928.0 5533.9 5567.9 5603.8 5620.5 5647.4 933.8 962.6 990.8 994.9 998.2 3575.1 3686.4 3803.0 3877.3 3884.8 9174.7 9785.1 9785.6 9787.2 9812.2 9469.9 9512.7 9675.4 9715.4 9734.3 7507.9 7527.2 7605.7 7629.4 7632.4 5525.3 5549.9 5637.8 5675.3 5725.3 8978.2 9042.8 9080.9 9084.6 9098.6 9025.8 9268.5 9373.7 9382.9 9385.5 6872.3 6907.6 6909.7 6919.3 6938.1 7693.0 7694.8 7704.5 7771.7 7786.2 6892.5 6978.2 6983.8 6984.2 7037.6 6911.7 7078.5 7099.9 7104.6 7114.0 6418.2 6554.6 6555.8 6557.1 6558.9 4881.3 4956.3 4991.4 5012.7 5134.1 4845.9 4879.9 4907.0 4907.3 5037.4 21:05:17 INFO - PROCESS | 31709 | 21:05:17 INFO - PROCESS | 31709 | [#4] prototype.html Cycles:180 Average:4741.59 Median:5346.16 stddev:1364.90 (25.5%) stddev-sans-first:1328.30 21:05:17 INFO - PROCESS | 31709 | Values: 348.0 349.5 352.8 356.9 358.1 5479.0 5533.2 5545.8 5587.0 5605.3 5185.1 5200.7 5326.5 5328.2 5510.9 4229.8 4235.3 4249.7 4250.5 4283.4 4232.5 4233.6 4248.9 4276.2 4321.2 4001.3 4053.0 4179.0 4246.5 4265.8 4232.5 4233.3 4234.4 4242.1 4243.2 3816.0 3825.8 3832.7 3835.0 3837.1 5132.6 5233.3 5247.0 5249.5 5354.2 4804.4 4825.8 4861.2 4867.4 4881.1 5562.6 5562.8 5567.6 5571.2 5625.8 4083.9 4130.6 4187.8 4193.1 4247.7 5830.2 5830.4 5840.9 5846.8 5853.3 4300.8 4312.4 4312.8 4333.8 4334.9 4258.3 4310.5 4327.7 4345.4 4363.8 4850.1 4864.0 4864.3 4864.8 4893.6 5653.5 5653.6 5661.7 5672.4 5688.1 1360.8 1382.7 1400.5 1445.3 1453.2 985.4 994.5 1017.8 1021.4 1023.9 5246.2 5290.7 5297.9 5312.8 5342.7 5569.0 5594.6 5597.5 5597.6 5620.9 5098.9 5252.3 5298.9 5309.8 5337.8 2922.7 2929.0 2934.8 2946.7 2959.9 5751.6 5761.9 5763.8 5770.8 5785.4 5415.8 5634.4 5643.2 5681.9 5724.1 5756.7 5769.0 5782.8 5825.4 5902.9 5424.2 5465.6 5611.9 5700.0 5707.6 5519.9 5527.0 5528.9 5557.0 5578.5 5769.0 5789.9 5797.7 5800.6 5834.5 3992.9 4184.8 4199.6 4244.4 4271.9 5816.8 5822.4 5831.7 5834.7 5845.0 5476.3 5627.5 5635.5 5639.4 5657.3 5349.6 5647.6 5684.2 5685.8 5699.0 5460.8 5662.4 5665.0 5686.9 5703.6 5700.5 5755.7 5774.5 5774.9 5775.3 5625.4 5641.3 5644.3 5655.9 5722.1 21:05:17 INFO - PROCESS | 31709 | 21:05:17 INFO - PROCESS | 31709 | [#5] yui.html Cycles:180 Average:16607.71 Median:4690.77 stddev:21036.87 (448.5%) stddev-sans-first:21062.15 21:05:17 INFO - PROCESS | 31709 | Values: 741.6 758.2 810.9 833.9 848.3 14040.8 14631.9 14744.6 14918.9 15041.2 12920.9 14275.4 14412.0 14417.1 14452.3 841.2 852.8 859.6 860.0 861.1 835.9 842.1 843.4 844.2 844.4 878.8 879.3 879.8 880.0 883.4 873.8 876.0 876.3 876.4 877.0 643.8 648.5 648.9 649.7 649.8 11863.5 12250.8 12265.9 12295.0 12446.1 12716.9 12784.2 13067.8 13246.5 13353.5 10930.6 11067.5 11150.6 11158.3 11261.8 3828.6 3837.7 3898.8 3928.8 3955.7 56743.4 57134.4 59027.0 63606.4 63977.4 10694.1 10876.3 10977.3 10990.9 11050.1 18138.8 18280.9 18435.7 18436.9 18467.0 8554.7 8578.7 8591.7 8692.6 8775.7 4596.1 4642.1 4662.3 4719.2 4772.2 3351.7 3426.2 3454.8 3459.2 3465.4 602.2 606.6 619.4 620.8 621.7 714.5 754.1 760.4 769.2 771.4 9375.9 9602.5 9638.4 9780.9 9822.2 587.8 666.4 687.7 773.4 801.9 4490.7 4805.2 4906.4 4965.6 4972.0 50932.5 51861.7 69636.0 80880.2 84919.0 72344.6 73195.0 73311.3 74342.6 75777.6 65217.0 67203.0 67343.0 67527.3 67601.0 8448.3 8553.2 8702.2 8715.3 8753.5 44731.0 45548.3 45896.8 46199.8 47560.3 39216.4 39356.0 45872.5 61509.4 61811.4 10825.0 10892.4 11104.1 11691.5 11875.9 12544.0 12734.2 12789.7 13139.5 14101.3 13715.0 13833.6 13861.2 14173.5 14891.5 12469.4 12578.6 12622.9 12638.8 14059.2 13092.5 13298.5 13896.3 14159.6 14550.6 11555.2 11564.3 11717.9 11926.3 11977.7 11583.7 11670.7 11694.7 12094.6 12137.3 21:05:17 INFO - PROCESS | 31709 | -------- Summary: end -------- 21:05:17 INFO - PROCESS | 31709 | 21:05:17 INFO - TEST-INFO | 31709: exit 0 21:05:17 INFO - TEST-OK | dromaeo_css | took 1115011ms 21:05:17 INFO - TEST-START | kraken 21:05:17 INFO - operating with platform_type : linux_ 21:05:17 INFO - Initialising browser for kraken test... 21:05:17 INFO - TEST-INFO | started process 32023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2mOezB/profile http://localhost:60400/getInfo.html) 21:05:22 INFO - PROCESS | 32023 | __metrics Screen width/height:1600/1200 21:05:22 INFO - PROCESS | 32023 | colorDepth:24 21:05:22 INFO - PROCESS | 32023 | Browser inner width/height: 1024/697 21:05:22 INFO - PROCESS | 32023 | __metrics 21:05:22 INFO - PROCESS | 32023 | 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" 21:05:22 INFO - PROCESS | 32023 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:05:23 INFO - PROCESS | 32023 | console.error: PushService: 21:05:23 INFO - PROCESS | 32023 | stateChangeProcessEnqueue: Error transitioning state 21:05:23 INFO - PROCESS | 32023 | UnknownError 21:05:23 INFO - TEST-INFO | 32023: exit 0 21:05:23 INFO - Browser initialized. 21:05:23 INFO - Running cycle 1/1 for kraken test... 21:05:23 INFO - TEST-INFO | started process 32117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2mOezB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:05:35 INFO - PROCESS | 32117 | RSS: Main: 144420864 21:05:35 INFO - PROCESS | 32117 | 21:05:37 INFO - PROCESS | 32117 | Cycle 1(1): loaded http://localhost:60400/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60400/tests/kraken/driver.html?testName=audio-beat-detection) 21:05:38 INFO - PROCESS | 32117 | RSS: Main: 185786368 21:05:38 INFO - PROCESS | 32117 | 21:05:41 INFO - PROCESS | 32117 | Cycle 1(1): loaded http://localhost:60400/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60400/tests/kraken/driver.html?testName=audio-dft) 21:05:41 INFO - PROCESS | 32117 | RSS: Main: 175022080 21:05:41 INFO - PROCESS | 32117 | 21:05:44 INFO - PROCESS | 32117 | Cycle 1(1): loaded http://localhost:60400/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60400/tests/kraken/driver.html?testName=audio-fft) 21:05:45 INFO - PROCESS | 32117 | RSS: Main: 266932224 21:05:45 INFO - PROCESS | 32117 | 21:05:47 INFO - PROCESS | 32117 | Cycle 1(1): loaded http://localhost:60400/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60400/tests/kraken/driver.html?testName=audio-oscillator) 21:05:47 INFO - PROCESS | 32117 | RSS: Main: 173154304 21:05:47 INFO - PROCESS | 32117 | 21:05:50 INFO - PROCESS | 32117 | Cycle 1(1): loaded http://localhost:60400/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60400/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:05:50 INFO - PROCESS | 32117 | RSS: Main: 175534080 21:05:50 INFO - PROCESS | 32117 | 21:05:53 INFO - PROCESS | 32117 | Cycle 1(1): loaded http://localhost:60400/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60400/tests/kraken/driver.html?testName=imaging-darkroom) 21:05:54 INFO - PROCESS | 32117 | RSS: Main: 213368832 21:05:54 INFO - PROCESS | 32117 | 21:05:57 INFO - PROCESS | 32117 | Cycle 1(1): loaded http://localhost:60400/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60400/tests/kraken/driver.html?testName=imaging-desaturate) 21:05:58 INFO - PROCESS | 32117 | RSS: Main: 212975616 21:05:58 INFO - PROCESS | 32117 | 21:06:00 INFO - PROCESS | 32117 | Cycle 1(1): loaded http://localhost:60400/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60400/tests/kraken/driver.html?testName=json-parse-financial) 21:06:01 INFO - PROCESS | 32117 | RSS: Main: 211152896 21:06:01 INFO - PROCESS | 32117 | 21:06:02 INFO - PROCESS | 32117 | Cycle 1(1): loaded http://localhost:60400/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60400/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:06:03 INFO - PROCESS | 32117 | RSS: Main: 173858816 21:06:03 INFO - PROCESS | 32117 | 21:06:05 INFO - PROCESS | 32117 | Cycle 1(1): loaded http://localhost:60400/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60400/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:06:05 INFO - PROCESS | 32117 | RSS: Main: 180649984 21:06:05 INFO - PROCESS | 32117 | 21:06:07 INFO - PROCESS | 32117 | Cycle 1(1): loaded http://localhost:60400/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60400/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:06:08 INFO - PROCESS | 32117 | RSS: Main: 189558784 21:06:08 INFO - PROCESS | 32117 | 21:06:10 INFO - PROCESS | 32117 | Cycle 1(1): loaded http://localhost:60400/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:06:11 INFO - PROCESS | 32117 | RSS: Main: 198348800 21:06:11 INFO - PROCESS | 32117 | 21:06:14 INFO - PROCESS | 32117 | Cycle 1(1): loaded http://localhost:60400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:06:14 INFO - PROCESS | 32117 | RSS: Main: 195096576 21:06:14 INFO - PROCESS | 32117 | 21:06:16 INFO - PROCESS | 32117 | Cycle 1(1): loaded http://localhost:60400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60400/tests/kraken/driver.html?testName=ai-astar) 21:06:16 INFO - PROCESS | 32117 | RSS: Main: 246755328 21:06:16 INFO - PROCESS | 32117 | 21:06:16 INFO - PROCESS | 32117 | __start_tp_report 21:06:16 INFO - PROCESS | 32117 | _x_x_mozilla_page_load 21:06:16 INFO - PROCESS | 32117 | _x_x_mozilla_page_load_details 21:06:16 INFO - PROCESS | 32117 | |i|pagename|runs| 21:06:16 INFO - PROCESS | 32117 | |0;ai-astar;104;111;113;111;112;113;112;113;112;112 21:06:16 INFO - PROCESS | 32117 | |1;audio-beat-detection;146;117;118;171;118;120;116;117;148;119 21:06:16 INFO - PROCESS | 32117 | |2;audio-dft;161;160;162;161;162;162;161;162;161;161 21:06:16 INFO - PROCESS | 32117 | |3;audio-fft;74;74;74;117;75;76;75;75;101;74 21:06:16 INFO - PROCESS | 32117 | |4;audio-oscillator;81;81;121;82;81;81;98;81;81;117 21:06:16 INFO - PROCESS | 32117 | |5;imaging-gaussian-blur;117;118;117;118;119;118;117;117;117;117 21:06:16 INFO - PROCESS | 32117 | |6;imaging-darkroom;147;147;146;145;146;146;146;146;145;148 21:06:16 INFO - PROCESS | 32117 | |7;imaging-desaturate;85;86;84;85;84;84;85;85;85;84 21:06:16 INFO - PROCESS | 32117 | |8;json-parse-financial;52;51;52;57;52;53;53;52;51;52 21:06:16 INFO - PROCESS | 32117 | |9;json-stringify-tinderbox;60;58;58;58;59;59;58;58;59;62 21:06:16 INFO - PROCESS | 32117 | |10;stanford-crypto-aes;75;75;75;74;75;76;74;74;73;74 21:06:16 INFO - PROCESS | 32117 | |11;stanford-crypto-ccm;137;127;123;131;125;128;122;120;165;125 21:06:16 INFO - PROCESS | 32117 | |12;stanford-crypto-pbkdf2;152;149;151;153;152;151;153;155;156;154 21:06:16 INFO - PROCESS | 32117 | |13;stanford-crypto-sha256-iterative;63;61;63;63;62;61;62;61;61;61 21:06:16 INFO - PROCESS | 32117 | __end_tp_report 21:06:16 INFO - PROCESS | 32117 | __start_cc_report 21:06:16 INFO - PROCESS | 32117 | _x_x_mozilla_cycle_collect,1584 21:06:16 INFO - PROCESS | 32117 | __end_cc_report 21:06:16 INFO - PROCESS | 32117 | __startTimestamp1482383176604__endTimestamp 21:06:16 INFO - PROCESS | 32117 | 21:06:16 INFO - PROCESS | 32117 | ------- Summary: start ------- 21:06:16 INFO - PROCESS | 32117 | Number of tests: 14 21:06:16 INFO - PROCESS | 32117 | 21:06:16 INFO - PROCESS | 32117 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.67 (2.4%) stddev-sans-first:0.78 21:06:16 INFO - PROCESS | 32117 | Values: 104.0 111.0 113.0 111.0 112.0 113.0 112.0 113.0 112.0 112.0 21:06:16 INFO - PROCESS | 32117 | 21:06:16 INFO - PROCESS | 32117 | [#1] audio-beat-detection Cycles:10 Average:129.00 Median:119.50 stddev:19.13 (16.0%) stddev-sans-first:19.28 21:06:16 INFO - PROCESS | 32117 | Values: 146.0 117.0 118.0 171.0 118.0 120.0 116.0 117.0 148.0 119.0 21:06:16 INFO - PROCESS | 32117 | 21:06:16 INFO - PROCESS | 32117 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 21:06:16 INFO - PROCESS | 32117 | Values: 161.0 160.0 162.0 161.0 162.0 162.0 161.0 162.0 161.0 161.0 21:06:16 INFO - PROCESS | 32117 | 21:06:16 INFO - PROCESS | 32117 | [#3] audio-fft Cycles:10 Average:81.50 Median:74.50 stddev:14.99 (20.1%) stddev-sans-first:15.65 21:06:16 INFO - PROCESS | 32117 | Values: 74.0 74.0 74.0 117.0 75.0 76.0 75.0 75.0 101.0 74.0 21:06:16 INFO - PROCESS | 32117 | 21:06:16 INFO - PROCESS | 32117 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:81.00 stddev:15.99 (19.7%) stddev-sans-first:16.60 21:06:16 INFO - PROCESS | 32117 | Values: 81.0 81.0 121.0 82.0 81.0 81.0 98.0 81.0 81.0 117.0 21:06:16 INFO - PROCESS | 32117 | 21:06:16 INFO - PROCESS | 32117 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 21:06:16 INFO - PROCESS | 32117 | Values: 117.0 118.0 117.0 118.0 119.0 118.0 117.0 117.0 117.0 117.0 21:06:16 INFO - PROCESS | 32117 | 21:06:16 INFO - PROCESS | 32117 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 21:06:16 INFO - PROCESS | 32117 | Values: 147.0 147.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 148.0 21:06:16 INFO - PROCESS | 32117 | 21:06:16 INFO - PROCESS | 32117 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 21:06:16 INFO - PROCESS | 32117 | Values: 85.0 86.0 84.0 85.0 84.0 84.0 85.0 85.0 85.0 84.0 21:06:16 INFO - PROCESS | 32117 | 21:06:16 INFO - PROCESS | 32117 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.00 stddev:1.72 (3.3%) stddev-sans-first:1.81 21:06:16 INFO - PROCESS | 32117 | Values: 52.0 51.0 52.0 57.0 52.0 53.0 53.0 52.0 51.0 52.0 21:06:16 INFO - PROCESS | 32117 | 21:06:16 INFO - PROCESS | 32117 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:1.29 (2.2%) stddev-sans-first:1.30 21:06:16 INFO - PROCESS | 32117 | Values: 60.0 58.0 58.0 58.0 59.0 59.0 58.0 58.0 59.0 62.0 21:06:16 INFO - PROCESS | 32117 | 21:06:16 INFO - PROCESS | 32117 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:75.00 stddev:0.85 (1.1%) stddev-sans-first:0.88 21:06:16 INFO - PROCESS | 32117 | Values: 75.0 75.0 75.0 74.0 75.0 76.0 74.0 74.0 73.0 74.0 21:06:16 INFO - PROCESS | 32117 | 21:06:16 INFO - PROCESS | 32117 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:127.50 stddev:13.12 (10.3%) stddev-sans-first:13.69 21:06:16 INFO - PROCESS | 32117 | Values: 137.0 127.0 123.0 131.0 125.0 128.0 122.0 120.0 165.0 125.0 21:06:16 INFO - PROCESS | 32117 | 21:06:16 INFO - PROCESS | 32117 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.60 Median:153.00 stddev:2.07 (1.4%) stddev-sans-first:2.18 21:06:16 INFO - PROCESS | 32117 | Values: 152.0 149.0 151.0 153.0 152.0 151.0 153.0 155.0 156.0 154.0 21:06:16 INFO - PROCESS | 32117 | 21:06:16 INFO - PROCESS | 32117 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:0.92 (1.5%) stddev-sans-first:0.87 21:06:16 INFO - PROCESS | 32117 | Values: 63.0 61.0 63.0 63.0 62.0 61.0 62.0 61.0 61.0 61.0 21:06:16 INFO - PROCESS | 32117 | -------- Summary: end -------- 21:06:16 INFO - PROCESS | 32117 | 21:06:17 INFO - TEST-INFO | 32117: exit 0 21:06:17 INFO - TEST-OK | kraken | took 59832ms 21:06:17 INFO - SUITE-END | took 1174s 21:06:18 INFO - Completed test suite (00:19:35) 21:06:18 INFO - javascript benchmark 21:06:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3174.7618928580355, 3201.9679803201975, 3210.293735378216, 3230.77384583079, 3252.170696472399, 5429.267048948391, 5431.4568543145615, 5472.206530053145, 5474.42518535554, 5490.423505531921, 5422.566194704424, 5504.4770746779095, 5513.393526712059, 5521.171824226368, 5522.751476183571, 4893.730844803535, 4930.728809915453, 4959.380077490314, 4999.675021123633, 5036.722980236085, 4870.610351171916, 5025.0954828130925, 5066.923996140061, 5085.440601533828, 5103.897922041557, 4859.1010663027455, 4919.60643148549, 4929.309896614477, 4965.453800081988, 4974.651774375795, 4942.827001054964, 4980.626453016002, 4982.352294201767, 5050.065737838475, 5079.187330027178, 4806.1829488986605, 4934.210526315772, 4954.3063971044085, 4981.950180498185, 5009.524095210949, 5291.497307755757, 5321.600879934021, 5355.544778693816, 5357.330333708286, 5430.809921652763, 5801.53587712982, 5815.273090863642, 5856.32652244993, 5860.267466566679, 5860.648361098348, 5691.06097493913, 5873.383294754032, 5900.616459930091, 5903.380145084747, 5905.616134951258, 5299.761510732026, 5337.332833395825, 5364.195370694388, 5413.675179489164, 5431.049566325877, 5833.591648584643, 5858.238429004287, 5864.149698293723, 5869.618474799125, 5870.970645146747, 5546.55627549795, 5654.519365853948, 5656.2929633795775, 5656.60403771732, 5663.9716801415725, 5632.60571759981, 5768.105943578752, 5774.855628609318, 5782.566307526952, 5878.470937615635, 5809.3609702932645, 5824.912626310609, 5830.679312637845, 5842.532597392198, 5850.970745146332, 5783.132530120515, 5827.184194212814, 5828.766849326064, 5831.329397119301, 5855.092460668518, 4433.6009759121835, 4464.374987501752, 4469.687121901436, 4503.68474206809, 4512.481064677539, 4015.13674559971, 4061.248668996245, 4064.532578753422, 4089.5501494835544, 4090.590940905945, 5527.834164975057, 5528.19841123043, 5541.418151094077, 5575.163725441216, 5578.497935185853, 5696.544276457957, 5744.167095771173, 5805.419458054161, 5815.912761308584, 5822.883542329215, 5556.388797232301, 5560.777568897199, 5561.860953476195, 5578.497935185853, 5597.188407680864, 5059.671121377099, 5080.74596270185, 5082.949170508322, 5086.364204474441, 5111.821086261963, 5864.530837532901, 5886.970565147147, 6008.399160083956, 6162.568620196544, 6165.0444181152, 5853.0635098384055, 5895.056790913605, 5897.262842144732, 5929.466348028525, 5937.910931335947, 6014.578979471395, 6043.667598282137, 6051.75792968294, 6054.27348718139, 6089.634621922699, 5588.524975377139, 5640.069388551007, 5740.540756739534, 5793.536517078539, 5795.159701843125, 5753.884922301614, 5769.94230057694, 5831.183634291117, 5884.323302820059, 5922.615030023035, 5673.950319190963, 5711.057675483498, 5726.0, 5731.570132240182, 5732.283464566929, 5586.329640443173, 5717.599768016199, 5732.971335143465, 5733.0540460823495, 5740.741666624928, 5529.944700553104, 5598.440155984369, 5616.21373007771, 5616.69108199053, 5679.744411501575, 5651.491365777099, 5674.092145256739, 5705.343885453226, 5708.628939118944, 5721.0, 5422.810201643081, 5477.589180811535, 5481.972590137024, 5571.247881535941, 5574.804881829116], "value": 5374.691872077487, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.9766009359626, 605.8788242351529, 621.2327775197632, 654.1300070905696, 667.9499037572183, 34202.14494637636, 43533.0, 44773.328400074024, 44902.0, 44903.999999999956, 45945.08109837801, 46320.305195422094, 46405.0, 46412.76793616027, 46481.0, 8044.436889417743, 8742.912570874289, 8868.733937981839, 8876.600552975131, 8894.466332020067, 7987.960060199691, 10276.691699249035, 10480.79038419231, 10485.842712359283, 10703.250772445932, 10565.415187721826, 10630.415327157003, 10631.096356809681, 10646.893531064707, 10650.201234907374, 10442.269041167121, 10481.161507079492, 10483.056524912718, 10485.056344928917, 10496.842547361719, 10372.792544149075, 10432.269741118125, 10434.008769166918, 10444.321119127233, 10446.582136714522, 43524.78237608792, 43648.0, 43750.562494375285, 43753.0, 43879.561204387865, 3665.706743460517, 3801.7909015004166, 3843.942340864889, 3923.156521347924, 4269.316909294498, 32589.511157332658, 32799.0, 32910.0, 33160.17099572506, 33757.49363759546, 4486.932696009562, 4494.910101797946, 4581.42399114433, 4592.3800286961505, 4710.905781884378, 351756.0, 351854.0, 353164.0, 353956.0, 354278.2286088579, 61690.0, 61715.38284617096, 62042.0, 62060.68969655213, 62126.0, 39444.21111577752, 40187.0, 40420.79789601033, 42575.787121064815, 42648.36027459591, 16175.595610109842, 16305.429309974332, 16319.510414687578, 16322.918385407997, 16326.591835203977, 10635.0, 10841.566337346418, 11732.472038758277, 12098.092643051807, 12182.939085304517, 19783.505412364517, 20506.79493205049, 20606.58786824255, 20637.484062898548, 20650.690239646417, 6833.589984600841, 7032.507724459341, 7118.327193109615, 7127.46544009191, 7324.560526368435, 999.5152351109706, 1060.4591658254346, 1083.8916108389099, 1105.723569107723, 1127.9210455268053, 33790.0, 33872.322553548795, 33933.0, 34164.0, 34496.655033449846, 1119.5297974850582, 1136.9147313951487, 1148.7070796946725, 1175.6884425627215, 1220.5544976083843, 17170.141492925304, 18092.0, 19212.903935480514, 19665.705014424795, 19723.0, 549211.0, 551695.0, 553424.0, 553447.0, 553793.0, 61084.69457652772, 61395.69302153461, 61626.38373616296, 61666.383336166065, 61709.0, 1281.1736430002782, 1326.907116501855, 1347.5351003903638, 1380.130517773796, 1415.504573399302, 32663.836680816443, 34242.31515369629, 34650.30699385948, 34969.0, 35162.824185878904, 53688.0, 54285.0, 54376.0, 54383.18425223546, 54422.183667245816, 404789.0, 407183.0, 407669.0, 407829.0, 408150.0, 30292.0, 32568.51147232746, 32588.83705581457, 32983.67016329902, 33010.83494582512, 50385.49614503808, 50506.24240636467, 50516.0, 51020.0, 51931.22103168531, 42331.365029523964, 42519.78740106404, 42614.5738542623, 43244.0, 43659.78170109129, 42859.57140428556, 43726.56273437225, 43922.560774391844, 44429.55570444383, 45029.774851125534, 43362.0, 44232.778836105615, 44406.77796610996, 44425.33361999508, 44440.33339499975, 35695.64304357027, 38485.615143848205, 38755.6124438752, 38772.80613596914, 39262.80368598139, 28696.713032869404, 29167.708322917348, 29181.7081829179, 29368.706312936596, 29482.262943426587], "value": 20892.305439025535, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.57673289580123, 427.06046697266015, 431.01370180022946, 434.3875136058157, 441.4481897627963, 16277.674446511077, 19427.805721942776, 20905.895470522628, 20980.999999999964, 21107.2612458564, 19571.902140489314, 19713.11290991905, 19912.90043549784, 20040.59918801627, 20465.897670511626, 5580.804671836477, 5830.82507524775, 5837.182794408786, 5837.474627283544, 5895.528357731371, 5727.083666613343, 5997.820065398045, 6016.729247183887, 6097.5426842986735, 6101.2983506896835, 6085.204864564942, 6097.298810636767, 6109.327973922865, 6117.0, 6479.287278399396, 6468.773592924249, 6587.868242635144, 6615.603063816162, 6621.039949207386, 6624.701888414985, 5654.293213348332, 5673.461021202979, 5720.542356611461, 5726.599138060337, 5958.314793798725, 12974.156679815782, 13132.277724725136, 13193.868061319456, 13538.661533461644, 13799.724005519833, 2345.4839935214227, 2377.5244951009695, 2415.0943396226417, 2502.637117617935, 2555.3483861615355, 10224.437655928921, 10412.531436085394, 10801.513931873005, 10985.560577576887, 11295.548178072868, 1959.8530110241647, 1999.2003198720483, 2012.87922724637, 2026.6149431607948, 2070.12019891547, 91578.08421915829, 91861.54069229611, 92237.0, 92466.0, 96238.0, 9958.153556947596, 10444.321119127233, 11135.0, 11898.46456909441, 12188.146829721834, 13808.861911380958, 14974.850251497563, 15847.366105355888, 15969.840301596836, 15981.121038343003, 7571.091469023752, 7744.92255077442, 7874.527528348203, 7874.527528348317, 8194.877076843852, 7365.705371785069, 7384.630768461556, 7415.073115860518, 7533.924660753432, 7588.203238659971, 5080.669756465892, 5128.230765385148, 5140.691558506502, 5211.42674305826, 5256.9211461827335, 2069.3378119001777, 2091.4771307173205, 2112.102356498482, 2125.330520885916, 2171.250918433138, 916.8349697054595, 948.743839163422, 1029.917606591471, 1051.206339213904, 1060.6446840308583, 20212.989350532414, 20354.491137721674, 20606.793932060787, 20634.27780027692, 20699.379018629163, 993.8310487217191, 995.2485873165714, 996.5764550066338, 1019.3934608907688, 1035.3735989726258, 10609.681709548726, 11502.482388292547, 11509.827352589718, 11746.412679365998, 11825.526978920747, 483870.0, 485461.0, 489432.0, 496035.0, 498080.0, 59140.7042964791, 89251.55374223087, 92933.0, 99744.5012774946, 100899.49550252348, 1007.1640538353149, 1016.6594190945968, 1018.4195008844887, 1029.0943969306961, 1032.932859364139, 17535.736963945295, 17633.823661763217, 17976.820231797516, 18178.636427271646, 18273.3604323848, 43880.78059609682, 44479.77760111179, 44984.1003179928, 45090.323645146, 45129.548704512534, 59589.40410595838, 59712.402875970685, 60345.698271508365, 60852.0, 61813.690931545054, 7828.686852526063, 8879.200871921557, 8903.688370906988, 8931.668140951504, 9517.381370210915, 12488.25070495773, 13559.389827457591, 13707.862921371057, 14003.789943151065, 14126.293685315899, 6390.073439351361, 9233.58448869789, 10897.891021089688, 12142.85004915941, 12432.191907525981, 12032.639020829389, 12078.879211207775, 12081.456334464794, 12164.148509604243, 12291.50833966667, 12267.75464490723, 12313.753724925631, 12340.629781106582, 12372.62882113538, 12623.495060197489, 7944.920550794418, 8204.54874981858, 8364.539950302791, 8463.195996380335, 8613.69852055175, 8864.64541418336, 11615.245009074382, 12217.266963982189, 12221.0, 12262.816057759319], "value": 9342.102483430059, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.4445649511938, 1469.2947385255081, 1481.2889812889814, 1614.5882799886028, 1792.9820701792978, 7028.61342626156, 7519.924800751991, 7556.3577095946775, 7795.3763698904095, 7805.297523222909, 7836.96081519593, 7898.723544675938, 7901.762947111596, 7902.40731945105, 7904.446688731791, 2396.820238482112, 2413.3363325085566, 2423.987880060597, 2426.2357357432443, 2427.3810178404483, 2394.461246219604, 2409.373562873648, 2463.051725085846, 2477.3896966971524, 2477.5044991001782, 2397.736249012607, 2439.1828737373003, 2468.7160976487667, 2474.1711526638596, 2474.3690358958443, 2304.0, 2334.789868911806, 2352.764723527659, 2359.49270906755, 2374.6912901322717, 2357.328161473989, 2371.91698290559, 2394.6288325309606, 2395.5807733646543, 2396.5446565152565, 7616.352610028154, 7791.766247012599, 7854.8821767673535, 7884.64519096642, 7973.800654983614, 5024.547790698818, 5146.536811686929, 5151.819686310999, 5156.303898973628, 5167.0, 3298.356820420019, 3311.933761324784, 3321.086701157177, 3380.6112297085906, 3418.8461519231696, 1080.6811990462832, 1126.2791813239533, 1131.7906187355366, 1135.7955567997758, 1139.4302848575712, 10704.732381690443, 10748.892511074868, 10814.243002989715, 10830.296030757976, 10832.40421776802, 4037.7577345359373, 4316.0, 4348.652107831366, 4422.20400327944, 4424.269995450779, 8708.608112634947, 8717.0, 8722.433041852386, 8722.651093956298, 8729.650813967497, 4996.950030499721, 5002.724850133205, 5003.099442100384, 5003.949960500348, 5011.323471331323, 4290.549492303326, 4409.889752756207, 4507.909841803145, 4567.566081222279, 4680.110778951988, 3780.584135745066, 3870.2259548089933, 3886.7279290449396, 3910.56983731795, 3977.423273625308, 1281.8397700287464, 1286.9292188929699, 1287.2019348004296, 1293.1982171054008, 1312.967175820612, 622.6948795090373, 832.496339714464, 889.3418870036256, 909.486140330711, 928.0, 5533.861653458615, 5567.860803479945, 5603.803866864721, 5620.4660557247, 5647.407022262685, 933.7945651956559, 962.6486332488591, 990.7968866382374, 994.8955359687274, 998.2164001258977, 3575.1419659282105, 3686.4101743721412, 3802.9809850951124, 3877.2827027000094, 3884.76691398517, 9174.724758257264, 9785.07041831025, 9785.608575657036, 9787.16809071237, 9812.215022798158, 9469.857952130724, 9512.667056652985, 9675.371100878421, 9715.36850104741, 9734.269929755297, 7507.924920750832, 7527.209642987407, 7605.6957721691615, 7629.351505122127, 7632.3512501438, 5525.254090697705, 5549.889002220014, 5637.774489020393, 5675.31896172462, 5725.255716756795, 8978.236849867835, 9042.819143617222, 9080.909190908007, 9084.591193396182, 9098.590563424794, 9025.819483610423, 9268.53657317145, 9373.671921482715, 9382.859257111013, 9385.483798391155, 6872.312768723088, 6907.620080895398, 6909.689063992032, 6919.342662447059, 6938.098047253825, 7692.9615351922885, 7694.769156925301, 7704.499207551491, 7771.689132434639, 7786.221377862168, 6892.517523773287, 6978.232394436506, 6983.790486285419, 6984.196817365864, 7037.612931288828, 6911.688973996082, 7078.53989490702, 7099.858002840017, 7104.644767761488, 7114.0396046535125, 6418.165638467156, 6554.63949482783, 6555.836104097436, 6557.1147895035465, 6558.868822623616, 4881.29221262922, 4956.306117143675, 4991.376077990251, 5012.724300163381, 5134.075866344094, 4845.878853028703, 4879.853604391874, 4906.95093049065, 4907.288443175791, 5037.445880953165], "value": 4380.623958039324, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.0, 349.5124301599269, 352.8447483107434, 356.90363601827505, 358.1011660731563, 5478.9726051369735, 5533.170024496318, 5545.77816887324, 5586.972065139674, 5605.299337582802, 5185.107435785939, 5200.661956972804, 5326.547243484309, 5328.17413300939, 5510.862228444281, 4229.830806767725, 4235.343521754117, 4249.725082475261, 4250.511191213003, 4283.400323954649, 4232.470941132358, 4233.597808208231, 4248.936265956013, 4276.246738837078, 4321.157374312011, 4001.339778936472, 4052.959470405288, 4179.026957920066, 4246.532881383046, 4265.848220980349, 4232.46052368578, 4233.301505251629, 4234.449521562193, 4242.109157077018, 4243.215005224043, 3815.9809200954096, 3825.8087095645383, 3832.6550610444915, 3834.9808250958845, 3837.1174629835295, 5132.613334799336, 5233.267342572043, 5246.973765131188, 5249.527542521153, 5354.223637572569, 4804.4234691836855, 4825.793551612097, 4861.173600487926, 4867.415910090812, 4881.145799485076, 5562.582806289544, 5562.7774889004395, 5567.610267281292, 5571.192177134333, 5625.774969001235, 4083.9387409188885, 4130.607592278729, 4187.8324867005285, 4193.098483825962, 4247.660187185018, 5830.242068531106, 5830.4169583041785, 5840.912386314209, 5846.7953621623465, 5853.32686741026, 4300.763458009839, 4312.374705667723, 4312.805923733376, 4333.7833108345085, 4334.869953901388, 4258.297380932174, 4310.4611923509565, 4327.675424343187, 4345.391645169679, 4363.825446982149, 4850.102730994778, 4863.975680121577, 4864.318995340655, 4864.810835124137, 4893.608511319086, 5653.462921022497, 5653.575981801381, 5661.716914154275, 5672.376038635747, 5688.146777983253, 1360.8366995960548, 1382.67507135825, 1400.4888215801363, 1445.262915912892, 1453.1644304524941, 985.3841349156777, 994.472929347447, 1017.8066167428314, 1021.4382089850552, 1023.8771347438355, 5246.193286591655, 5290.735463226823, 5297.894042119136, 5312.787488500417, 5342.679439233659, 5568.972155139199, 5594.636348637326, 5597.496225339739, 5597.580181486404, 5620.932022915715, 5098.872528186825, 5252.343457067866, 5298.8940221196135, 5309.840704778863, 5337.839864804062, 2922.6931172227037, 2929.0, 2934.8385838779072, 2946.67399670145, 2959.896403625906, 5751.597388182787, 5761.9135712964335, 5763.7982670606325, 5770.826875193751, 5785.363610002896, 5415.783368665288, 5634.4365563443325, 5643.153526970905, 5681.886362272731, 5724.112762521816, 5756.683382414008, 5769.009691656372, 5782.768689252467, 5825.446582574734, 5902.881942361215, 5424.2134890439875, 5465.584024901411, 5611.943880561305, 5699.971500142473, 5707.600467967369, 5519.917201242065, 5526.972365138148, 5528.91706624409, 5556.972215138899, 5578.525825304894, 5768.990426675231, 5789.899919015374, 5797.652140871562, 5800.564957628279, 5834.533237340917, 3992.9001774954695, 4184.769837658958, 4199.614127338033, 4244.389700334334, 4271.893202669834, 5816.7605471892775, 5822.417758224144, 5831.7375718091935, 5834.716362400265, 5845.0, 5476.315460567429, 5627.480580243393, 5635.492805647511, 5639.379668236409, 5657.264555607745, 5349.631706787265, 5647.576431767716, 5684.152650388558, 5685.829425117253, 5698.971505142447, 5460.754266058117, 5662.433756624469, 5665.0, 5686.914696279477, 5703.5722320826935, 5700.543956483554, 5755.7409916553015, 5774.509166720875, 5774.942250577608, 5775.33583637887, 5625.437456254342, 5641.323041235078, 5644.294463192101, 5655.9253741788925, 5722.141678748221], "value": 4310.958898186748, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.6291854072964, 758.2455456820461, 810.8580998325295, 833.9374546908982, 848.3128665780716, 14040.789388159186, 14631.926840365782, 14744.6313842154, 14918.850811491882, 15041.172735499544, 12920.935395323033, 14275.4289828407, 14412.0, 14417.134971901667, 14452.349644266007, 841.1882533355326, 852.7910661887846, 859.5573279760928, 860.0324634785866, 861.130258438978, 835.9289460395873, 842.061101871412, 843.3969711656165, 844.1811442900377, 844.4089137603671, 878.7846977490492, 879.2833840420069, 879.8284334554764, 879.9956000219989, 883.3860466975455, 873.8383399071192, 875.9956200218958, 876.2902049340055, 876.4478378621492, 877.0177401310541, 643.8326035230826, 648.5168549430657, 648.8507643242081, 649.7433513762085, 649.7953144759385, 11863.46614402354, 12250.816237756351, 12265.938670306592, 12295.016398688083, 12446.128770986035, 12716.872831271754, 12784.232946023269, 13067.803982940264, 13246.536371227057, 13353.465861365534, 10930.605595726509, 11067.50196241171, 11150.553977840877, 11158.330500169935, 11261.774764504664, 3828.5979972102805, 3837.6929845612563, 3898.8245528951265, 3928.8428462861452, 3955.7230993830444, 56743.432565674644, 57134.428655713324, 59027.0, 63606.3639363605, 63977.360226397606, 10694.144468442506, 10876.347419154876, 10977.341359518296, 10990.890091099147, 11050.06074483678, 18138.818611813713, 18280.90859545694, 18435.72346414805, 18436.907815460836, 18467.0, 8554.700585479479, 8578.742637720878, 8591.656333746705, 8692.608832602547, 8775.736727898173, 4596.080783843245, 4642.141203877293, 4662.347271382009, 4719.197736384823, 4772.188727916263, 3351.6648335166287, 3426.194844211608, 3454.809985450774, 3459.1870910336556, 3465.358908601917, 602.2321540036401, 606.6390497653889, 619.3899009475663, 620.8416853702277, 621.7481919822479, 714.5426926766874, 754.1176823116966, 760.3954855889581, 769.2499812682702, 771.3713323641215, 9375.90624093764, 9602.471864047404, 9638.373505722106, 9780.853287200698, 9822.214222862154, 587.8030859661976, 666.4368608525788, 687.7214728035153, 773.3697036914897, 801.8837268596137, 4490.685652004394, 4805.203161891002, 4906.435759887588, 4965.577925876341, 4971.975140124277, 50932.49067509278, 51861.740691296305, 69636.0, 80880.19119808727, 84919.0, 72344.63827680828, 73195.0, 73311.26688733151, 74342.6282868593, 75777.62111189519, 65217.0, 67203.0, 67343.0, 67527.32472675308, 67601.0, 8448.281896038905, 8553.230209281195, 8702.216800487986, 8715.30277577805, 8753.518556479456, 44731.0, 45548.31677524774, 45896.770516147204, 46199.76900115612, 47560.286595701786, 39216.411753823144, 39356.0, 45872.54127458816, 61509.384906152154, 61811.38188618236, 10825.0, 10892.40091794959, 11104.111671066134, 11691.473883675086, 11875.881241187477, 12544.0, 12734.235945843278, 12789.680257993625, 13139.474421023053, 14101.29493525299, 13715.0, 13833.584992450242, 13861.23763193034, 14173.503927362493, 14891.478798242442, 12469.376531173224, 12578.559750409058, 12622.87377126217, 12638.810417843555, 14059.22674252926, 13092.541761038317, 13298.534551290659, 13896.305184740924, 14159.64600884986, 14550.636234094232, 11555.2489088209, 11564.306141631529, 11717.88282117168, 11926.284422934305, 11977.700557486132, 11583.6524904253, 11670.70823229426, 11694.70763230926, 12094.637160885188, 12137.332446715516], "value": 7055.87758503213, "unit": "score"}], "name": "dromaeo_css", "value": 7204.141076621916, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 113.0, 111.0, 112.0, 113.0, 112.0, 113.0, 112.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 118.0, 171.0, 118.0, 120.0, 116.0, 117.0, 148.0, 119.0], "value": 129.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 161.0, 162.0, 162.0, 161.0, 162.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 117.0, 75.0, 76.0, 75.0, 75.0, 101.0, 74.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 121.0, 82.0, 81.0, 81.0, 98.0, 81.0, 81.0, 117.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 119.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 148.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 84.0, 85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 57.0, 52.0, 53.0, 53.0, 52.0, 51.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 58.0, 58.0, 59.0, 59.0, 58.0, 58.0, 59.0, 62.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 74.0, 75.0, 76.0, 74.0, 74.0, 73.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 127.0, 123.0, 131.0, 125.0, 128.0, 122.0, 120.0, 165.0, 125.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 149.0, 151.0, 153.0, 152.0, 151.0, 153.0, 155.0, 156.0, 154.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 63.0, 63.0, 62.0, 61.0, 62.0, 61.0, 61.0, 61.0], "value": 61.8, "unit": "score"}], "name": "kraken", "value": 1452.5, "alertThreshold": 2.0}]} 21:06:18 INFO - Return code: 0 21:06:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:06:18 INFO - # TBPL SUCCESS # 21:06:18 INFO - Running post-action listener: _resource_record_post_action 21:06:18 INFO - [mozharness: 2016-12-22 05:06:18.396601Z] Finished run-tests step (success) 21:06:18 INFO - Running post-run listener: _resource_record_post_run 21:06:18 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 355643392; Read time: 12; Write time: 264528 21:06:18 INFO - TinderboxPrint: CPU usage
13.0% 21:06:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:06:18 INFO - TinderboxPrint: I/O write bytes / time
355,643,392 / 264,528 21:06:18 INFO - TinderboxPrint: CPU idle
8,270.2 (87.0%) 21:06:18 INFO - TinderboxPrint: CPU user
1,192.7 (12.5%) 21:06:18 INFO - TinderboxPrint: Swap in / out
0 / 0 21:06:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108027904; Read time: 0; Write time: 101920 21:06:18 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 247156736; Read time: 0; Write time: 162604 21:06:19 INFO - Running post-run listener: _upload_blobber_files 21:06:19 INFO - Blob upload gear active. 21:06:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:06:19 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 21:06:19 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:06:19 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:06:19 INFO - (blobuploader) - INFO - Open directory for files ... 21:06:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:06:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:06:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:24 INFO - (blobuploader) - INFO - Done attempting. 21:06:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:06:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:06:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:24 INFO - (blobuploader) - INFO - Done attempting. 21:06:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:06:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:06:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:25 INFO - (blobuploader) - INFO - Done attempting. 21:06:25 INFO - (blobuploader) - INFO - Iteration through files over. 21:06:25 INFO - Return code: 0 21:06:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:06:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:06:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c19ec718fee075ad2accb78a341cd7d41fbbab5c6c7d4018117cfab04f01a51d1beb71013cabde994af11493d83dc397eafc263869e3bf5d5f935bf37d3d355", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c492a6f7331a680fb53bf87a81f356f2d2f75e9f388a6024f7538e446e64e2d4a24c012445cde80c32ce88d3a414a683125077c551c414b3c85400c6d6f06036", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43ebe8a592c6273e4a665eff53728301e772027edcf0cedf0448d27515d13f5116cb95c3023f744a54916b26bc488031d29adf06e98ddedf2db403fa06a416e7"} 21:06:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:06:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:06:25 INFO - Contents: 21:06:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c19ec718fee075ad2accb78a341cd7d41fbbab5c6c7d4018117cfab04f01a51d1beb71013cabde994af11493d83dc397eafc263869e3bf5d5f935bf37d3d355", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c492a6f7331a680fb53bf87a81f356f2d2f75e9f388a6024f7538e446e64e2d4a24c012445cde80c32ce88d3a414a683125077c551c414b3c85400c6d6f06036", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43ebe8a592c6273e4a665eff53728301e772027edcf0cedf0448d27515d13f5116cb95c3023f744a54916b26bc488031d29adf06e98ddedf2db403fa06a416e7"} 21:06:25 INFO - Running post-run listener: copy_logs_to_upload_dir 21:06:25 INFO - Copying logs to upload dir... 21:06:25 INFO - mkdir: /builds/slave/test/build/upload/logs 21:06:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.436841 ========= master_lag: 0.53 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-21 21:06:25.921572) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 21:06:25.925820) ========= 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=03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391 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-Aurora/sha512/5c19ec718fee075ad2accb78a341cd7d41fbbab5c6c7d4018117cfab04f01a51d1beb71013cabde994af11493d83dc397eafc263869e3bf5d5f935bf37d3d355", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c492a6f7331a680fb53bf87a81f356f2d2f75e9f388a6024f7538e446e64e2d4a24c012445cde80c32ce88d3a414a683125077c551c414b3c85400c6d6f06036", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43ebe8a592c6273e4a665eff53728301e772027edcf0cedf0448d27515d13f5116cb95c3023f744a54916b26bc488031d29adf06e98ddedf2db403fa06a416e7"} build_url:https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011793 build_url: 'https://queue.taskcluster.net/v1/task/QvPHv77gTiCLQmcGUPl1iA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c19ec718fee075ad2accb78a341cd7d41fbbab5c6c7d4018117cfab04f01a51d1beb71013cabde994af11493d83dc397eafc263869e3bf5d5f935bf37d3d355", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c492a6f7331a680fb53bf87a81f356f2d2f75e9f388a6024f7538e446e64e2d4a24c012445cde80c32ce88d3a414a683125077c551c414b3c85400c6d6f06036", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43ebe8a592c6273e4a665eff53728301e772027edcf0cedf0448d27515d13f5116cb95c3023f744a54916b26bc488031d29adf06e98ddedf2db403fa06a416e7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 21:06:25.960604) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 21:06:25.961020) ========= 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=03627c79f6bb3d1578c4a402000001ba-1482381285.221416-1195282391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 21:06:26.017503) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 21:06:26.017882) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 21:06:26.018216) ========= ========= Total master_lag: 0.67 =========