builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1475813858.58 results: success (0) buildid: 20161006195807 builduid: abc95a81680c40669bcbe2b183b958ee revision: d8e1f5cf0a70a53e8a5532809096a0a5bf729196 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 21:17:38.577481) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 21:17:38.577900) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 21:17:38.578170) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 21:17:38.596430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:17:38.596778) ========= 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=db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 21:17:39-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.1M=0s 2016-10-06 21:17:39 (39.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075808 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:17:38.898093) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:17:38.898398) ========= 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=db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015430 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:17:38.938051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:17:38.938369) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d8e1f5cf0a70a53e8a5532809096a0a5bf729196 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d8e1f5cf0a70a53e8a5532809096a0a5bf729196 --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=db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 21:17:39,626 truncating revision to first 12 chars 2016-10-06 21:17:39,626 Setting DEBUG logging. 2016-10-06 21:17:39,627 attempt 1/10 2016-10-06 21:17:39,627 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d8e1f5cf0a70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 21:17:39,967 unpacking tar archive at: mozilla-central-d8e1f5cf0a70/testing/mozharness/ program finished with exit code 0 elapsedTime=0.712703 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:17:39.670029) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 21:17:39.670320) ========= script_repo_revision: d8e1f5cf0a70a53e8a5532809096a0a5bf729196 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 21:17:39.670696) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 21:17:39.670961) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 21:17:39.681126) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-10-06 21:17:39.681388) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:17:40 INFO - MultiFileLogger online at 20161006 21:17:40 in /builds/slave/test 21:17:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 21:17:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:17:40 INFO - {'append_to_log': False, 21:17:40 INFO - 'base_work_dir': '/builds/slave/test', 21:17:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 21:17:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:17:40 INFO - 'branch': 'Firefox-Non-PGO', 21:17:40 INFO - 'buildbot_json_path': 'buildprops.json', 21:17:40 INFO - 'config_files': ('talos/linux_config.py',), 21:17:40 INFO - 'default_actions': ('clobber', 21:17:40 INFO - 'read-buildbot-config', 21:17:40 INFO - 'download-and-extract', 21:17:40 INFO - 'populate-webroot', 21:17:40 INFO - 'create-virtualenv', 21:17:40 INFO - 'install', 21:17:40 INFO - 'run-tests'), 21:17:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:17:40 INFO - 'download_minidump_stackwalk': True, 21:17:40 INFO - 'download_symbols': 'ondemand', 21:17:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:17:40 INFO - 'tooltool.py': '/tools/tooltool.py', 21:17:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:17:40 INFO - '/tools/misc-python/virtualenv.py')}, 21:17:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:17:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:17:40 INFO - 'installer_path': 'installer.exe', 21:17:40 INFO - 'log_level': 'info', 21:17:40 INFO - 'log_name': 'talos', 21:17:40 INFO - 'log_to_console': True, 21:17:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:17:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:17:40 INFO - 'opt_config_files': (), 21:17:40 INFO - 'pip_index': False, 21:17:40 INFO - 'sps_profile': False, 21:17:40 INFO - 'sps_profile_interval': 0, 21:17:40 INFO - 'suite': 'dromaeojs', 21:17:40 INFO - 'system_bits': '32', 21:17:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:17:40 INFO - 'title': 'talos-linux64-ix-049', 21:17:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:17:40 INFO - 'use_talos_json': True, 21:17:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:17:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:17:40 INFO - 'work_dir': 'build'} 21:17:40 INFO - [mozharness: 2016-10-07 04:17:40.459989Z] Running clobber step. 21:17:40 INFO - Running pre-action listener: _resource_record_pre_action 21:17:40 INFO - Running main action method: clobber 21:17:40 INFO - rmtree: /builds/slave/test/build 21:17:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:17:40 INFO - Running post-action listener: _resource_record_post_action 21:17:40 INFO - [mozharness: 2016-10-07 04:17:40.927469Z] Finished clobber step (success) 21:17:40 INFO - [mozharness: 2016-10-07 04:17:40.927569Z] Running read-buildbot-config step. 21:17:40 INFO - Running pre-action listener: _resource_record_pre_action 21:17:40 INFO - Running main action method: read_buildbot_config 21:17:40 INFO - Using buildbot properties: 21:17:40 INFO - { 21:17:40 INFO - "project": "", 21:17:40 INFO - "product": "firefox", 21:17:40 INFO - "script_repo_revision": "production", 21:17:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 21:17:40 INFO - "repository": "", 21:17:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 21:17:40 INFO - "buildid": "20161006195807", 21:17:40 INFO - "pgo_build": "False", 21:17:40 INFO - "basedir": "/builds/slave/test", 21:17:40 INFO - "buildnumber": 771, 21:17:40 INFO - "slavename": "talos-linux64-ix-049", 21:17:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:17:40 INFO - "platform": "ubuntu64_hw", 21:17:40 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 21:17:40 INFO - "branch": "mozilla-central", 21:17:40 INFO - "repo_path": "mozilla-central", 21:17:40 INFO - "revision": "d8e1f5cf0a70a53e8a5532809096a0a5bf729196", 21:17:40 INFO - "stage_platform": "linux64", 21:17:40 INFO - "builduid": "abc95a81680c40669bcbe2b183b958ee", 21:17:40 INFO - "slavebuilddir": "test" 21:17:40 INFO - } 21:17:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:17:40 INFO - Running post-action listener: _resource_record_post_action 21:17:40 INFO - [mozharness: 2016-10-07 04:17:40.930242Z] Finished read-buildbot-config step (success) 21:17:40 INFO - [mozharness: 2016-10-07 04:17:40.930331Z] Running download-and-extract step. 21:17:40 INFO - Running pre-action listener: _resource_record_pre_action 21:17:40 INFO - Running main action method: download_and_extract 21:17:40 INFO - mkdir: /builds/slave/test/build/tests 21:17:40 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')]} 21:17:40 INFO - trying https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:17:40 INFO - Downloading https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:17:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:17:41 INFO - Downloaded 1361 bytes. 21:17:41 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:17:41 INFO - Using the following test package requirements: 21:17:41 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:17:41 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:17:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:17:41 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:17:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:17:41 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:17:41 INFO - u'jsshell-linux-x86_64.zip'], 21:17:41 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:17:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:17:41 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:17:41 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:17:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:17:41 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:17:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:17:41 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:17:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:17:41 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:17:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:17:41 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:17:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:17:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:17:41 INFO - Fetch https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:17:42 INFO - Http code: 200 21:17:42 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 21:17:42 INFO - x-amz-cf-id: tMmgHWudNVU5k6U7kx7DMDVotcPzOwhZcqkJNUz6qQWgH8e8eSuN8A== 21:17:42 INFO - x-amz-version-id: ueI9VcZTmK.tAY3ygVMedB0szaPZ8KOG 21:17:42 INFO - Expected file size: 20445658 21:17:42 INFO - Obtained file size: 20445658 21:17:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:17:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:17:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:17:46 INFO - Fetch https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:17:46 INFO - Http code: 200 21:17:46 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 21:17:46 INFO - x-amz-cf-id: MtayOZySR3q41baQziTk88T52-saPhUVl2CLtA5lBVQRkyNZ1jApZQ== 21:17:46 INFO - x-amz-version-id: ueI9VcZTmK.tAY3ygVMedB0szaPZ8KOG 21:17:47 INFO - Expected file size: 20445658 21:17:47 INFO - Obtained file size: 20445658 21:17:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:17:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:17:51 INFO - Fetch https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:17:52 INFO - Http code: 200 21:17:52 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 21:17:52 INFO - x-amz-cf-id: 96ZzyOZmlLPFf_ld9TNIRT7uE6waPktYtSlMcQikxKGDhsJRSsD2tA== 21:17:52 INFO - x-amz-version-id: HtWGOTmyoaYy8_f6AIERPYuVbWYte0KH 21:17:53 INFO - Expected file size: 14409006 21:17:53 INFO - Obtained file size: 14409006 21:17:53 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')]} 21:17:53 INFO - trying https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:17:53 INFO - Downloading https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:17:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:18:00 INFO - Downloaded 55831807 bytes. 21:18:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:18:00 INFO - mkdir: /builds/slave/test/properties 21:18:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:18:00 INFO - Writing to file /builds/slave/test/properties/build_url 21:18:00 INFO - Contents: 21:18:00 INFO - build_url:https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:18:01 INFO - Running post-action listener: _resource_record_post_action 21:18:01 INFO - Running post-action listener: set_extra_try_arguments 21:18:01 INFO - [mozharness: 2016-10-07 04:18:01.423538Z] Finished download-and-extract step (success) 21:18:01 INFO - [mozharness: 2016-10-07 04:18:01.423765Z] Running populate-webroot step. 21:18:01 INFO - Running pre-action listener: _resource_record_pre_action 21:18:01 INFO - Running main action method: populate_webroot 21:18:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:18:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:18:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:18:01 INFO - '--tppagecycles', 21:18:01 INFO - '7'], 21:18:01 INFO - 'tests': ['tsvgm']}}, 21:18:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:18:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:18:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:18:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:18:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:18:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:18:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:18:01 INFO - 'talos_options': ['--disable-e10s'], 21:18:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:18:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:18:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:18:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:18:01 INFO - 'talos_options': ['--disable-e10s'], 21:18:01 INFO - 'tests': ['damp', 'tps']}, 21:18:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:18:01 INFO - 'tests': ['damp', 'tps']}, 21:18:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:18:01 INFO - 'tests': ['dromaeo_dom']}, 21:18:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:18:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:18:01 INFO - 'tests': ['basic_compositor_video']}, 21:18:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:18:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:18:01 INFO - 'tests': ['a11yr', 21:18:01 INFO - 'ts_paint', 21:18:01 INFO - 'tpaint', 21:18:01 INFO - 'sessionrestore', 21:18:01 INFO - 'sessionrestore_no_auto_restore', 21:18:01 INFO - 'tabpaint']}, 21:18:01 INFO - 'other-e10s': {'tests': ['a11yr', 21:18:01 INFO - 'ts_paint', 21:18:01 INFO - 'tpaint', 21:18:01 INFO - 'sessionrestore', 21:18:01 INFO - 'sessionrestore_no_auto_restore', 21:18:01 INFO - 'tabpaint']}, 21:18:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:18:01 INFO - 'ts_paint', 21:18:01 INFO - 'tpaint', 21:18:01 INFO - 'sessionrestore', 21:18:01 INFO - 'sessionrestore_no_auto_restore', 21:18:01 INFO - 'tabpaint']}, 21:18:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:18:01 INFO - 'ts_paint', 21:18:01 INFO - 'tpaint', 21:18:01 INFO - 'sessionrestore', 21:18:01 INFO - 'sessionrestore_no_auto_restore', 21:18:01 INFO - 'tabpaint']}, 21:18:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:18:01 INFO - 'tests': ['a11yr', 21:18:01 INFO - 'ts_paint', 21:18:01 INFO - 'tpaint', 21:18:01 INFO - 'sessionrestore', 21:18:01 INFO - 'sessionrestore_no_auto_restore', 21:18:01 INFO - 'tabpaint']}, 21:18:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:18:01 INFO - 'tests': ['a11yr', 21:18:01 INFO - 'ts_paint', 21:18:01 INFO - 'tpaint', 21:18:01 INFO - 'sessionrestore', 21:18:01 INFO - 'sessionrestore_no_auto_restore', 21:18:01 INFO - 'tabpaint']}, 21:18:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:18:01 INFO - 'tests': ['tsvgx', 21:18:01 INFO - 'tsvgr_opacity', 21:18:01 INFO - 'tart', 21:18:01 INFO - 'tscrollx', 21:18:01 INFO - 'cart']}, 21:18:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:18:01 INFO - 'tsvgr_opacity', 21:18:01 INFO - 'tart', 21:18:01 INFO - 'tscrollx', 21:18:01 INFO - 'cart']}, 21:18:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:18:01 INFO - 'talos_options': ['--disable-e10s'], 21:18:01 INFO - 'tests': ['tp5o']}, 21:18:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:18:01 INFO - 'tests': ['tp5o']}, 21:18:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:18:01 INFO - 'talos_options': ['--disable-e10s', 21:18:01 INFO - '--xperf_path', 21:18:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:18:01 INFO - 'tests': ['tp5n']}, 21:18:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:18:01 INFO - 'talos_options': ['--xperf_path', 21:18:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:18:01 INFO - 'tests': ['tp5n']}}, 21:18:01 INFO - 'talos.zip': {'path': '', 21:18:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:18:01 INFO - Running post-action listener: _resource_record_post_action 21:18:01 INFO - [mozharness: 2016-10-07 04:18:01.442618Z] Finished populate-webroot step (success) 21:18:01 INFO - [mozharness: 2016-10-07 04:18:01.442706Z] Running create-virtualenv step. 21:18:01 INFO - Running pre-action listener: _resource_record_pre_action 21:18:01 INFO - Running main action method: create_virtualenv 21:18:01 INFO - Creating virtualenv /builds/slave/test/build/venv 21:18:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:18:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:18:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:18:01 INFO - Using real prefix '/usr' 21:18:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:18:02 INFO - Installing distribute.............................................................................................................................................................................................done. 21:18:04 INFO - Installing pip.................done. 21:18:04 INFO - Return code: 0 21:18:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:18:04 INFO - Reading from file tmpfile_stdout 21:18:04 INFO - Output received: 21:18:04 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:18:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc31b2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2622ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ff60>, '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 0x2620d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26211d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', '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 21:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:18:04 INFO - Using env: {'DISPLAY': ':0', 21:18:04 INFO - 'HOME': '/home/cltbld', 21:18:04 INFO - 'LANG': 'en_US.UTF-8', 21:18:04 INFO - 'LANGUAGE': 'en_US:en', 21:18:04 INFO - 'LOGNAME': 'cltbld', 21:18:04 INFO - 'MAIL': '/var/mail/cltbld', 21:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:04 INFO - 'MOZ_NO_REMOTE': '1', 21:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:04 INFO - 'NO_EM_RESTART': '1', 21:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:04 INFO - 'PWD': '/builds/slave/test', 21:18:04 INFO - 'SHELL': '/bin/bash', 21:18:04 INFO - 'SHLVL': '1', 21:18:04 INFO - 'TERM': 'linux', 21:18:04 INFO - 'TMOUT': '86400', 21:18:04 INFO - 'USER': 'cltbld', 21:18:04 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', 21:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:04 INFO - '_': '/tools/buildbot/bin/python'} 21:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:18:04 INFO - Cleaning up... 21:18:04 INFO - Return code: 0 21:18:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc31b2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2622ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ff60>, '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 0x2620d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26211d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', '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 21:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:18:04 INFO - Using env: {'DISPLAY': ':0', 21:18:04 INFO - 'HOME': '/home/cltbld', 21:18:04 INFO - 'LANG': 'en_US.UTF-8', 21:18:04 INFO - 'LANGUAGE': 'en_US:en', 21:18:04 INFO - 'LOGNAME': 'cltbld', 21:18:04 INFO - 'MAIL': '/var/mail/cltbld', 21:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:04 INFO - 'MOZ_NO_REMOTE': '1', 21:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:04 INFO - 'NO_EM_RESTART': '1', 21:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:04 INFO - 'PWD': '/builds/slave/test', 21:18:04 INFO - 'SHELL': '/bin/bash', 21:18:04 INFO - 'SHLVL': '1', 21:18:04 INFO - 'TERM': 'linux', 21:18:04 INFO - 'TMOUT': '86400', 21:18:04 INFO - 'USER': 'cltbld', 21:18:04 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', 21:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:04 INFO - '_': '/tools/buildbot/bin/python'} 21:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:04 INFO - Downloading/unpacking psutil>=3.1.1 21:18:04 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 21:18:04 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 21:18:04 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 21:18:04 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 21:18:04 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 21:18:04 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 21:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:18:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:18:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:18:06 INFO - Installing collected packages: psutil 21:18:06 INFO - Running setup.py install for psutil 21:18:06 INFO - building 'psutil._psutil_linux' extension 21:18:06 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 21:18:06 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 21:18:06 INFO - building 'psutil._psutil_posix' extension 21:18:06 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 21:18:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:18:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:18:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:18:07 INFO - Successfully installed psutil 21:18:07 INFO - Cleaning up... 21:18:07 INFO - Return code: 0 21:18:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc31b2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2622ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ff60>, '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 0x2620d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26211d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', '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 21:18:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:18:07 INFO - Using env: {'DISPLAY': ':0', 21:18:07 INFO - 'HOME': '/home/cltbld', 21:18:07 INFO - 'LANG': 'en_US.UTF-8', 21:18:07 INFO - 'LANGUAGE': 'en_US:en', 21:18:07 INFO - 'LOGNAME': 'cltbld', 21:18:07 INFO - 'MAIL': '/var/mail/cltbld', 21:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:07 INFO - 'MOZ_NO_REMOTE': '1', 21:18:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:07 INFO - 'NO_EM_RESTART': '1', 21:18:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:07 INFO - 'PWD': '/builds/slave/test', 21:18:07 INFO - 'SHELL': '/bin/bash', 21:18:07 INFO - 'SHLVL': '1', 21:18:07 INFO - 'TERM': 'linux', 21:18:07 INFO - 'TMOUT': '86400', 21:18:07 INFO - 'USER': 'cltbld', 21:18:07 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', 21:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:07 INFO - '_': '/tools/buildbot/bin/python'} 21:18:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:18: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 21:18: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 21:18: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 21:18: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 21:18: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 21:18: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 21:18:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:18:09 INFO - Installing collected packages: mozsystemmonitor 21:18:09 INFO - Running setup.py install for mozsystemmonitor 21:18:09 INFO - Successfully installed mozsystemmonitor 21:18:09 INFO - Cleaning up... 21:18:09 INFO - Return code: 0 21:18:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:18: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')]} 21:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18: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')]} 21:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18: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', '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 0x7fc31b2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2622ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ff60>, '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 0x2620d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26211d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', '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 21:18: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:18: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 jsonschema==2.5.1 21:18:09 INFO - Using env: {'DISPLAY': ':0', 21:18:09 INFO - 'HOME': '/home/cltbld', 21:18:09 INFO - 'LANG': 'en_US.UTF-8', 21:18:09 INFO - 'LANGUAGE': 'en_US:en', 21:18:09 INFO - 'LOGNAME': 'cltbld', 21:18:09 INFO - 'MAIL': '/var/mail/cltbld', 21:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:09 INFO - 'MOZ_NO_REMOTE': '1', 21:18:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:09 INFO - 'NO_EM_RESTART': '1', 21:18:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:09 INFO - 'PWD': '/builds/slave/test', 21:18:09 INFO - 'SHELL': '/bin/bash', 21:18:09 INFO - 'SHLVL': '1', 21:18:09 INFO - 'TERM': 'linux', 21:18:09 INFO - 'TMOUT': '86400', 21:18:09 INFO - 'USER': 'cltbld', 21:18:09 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', 21:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:09 INFO - '_': '/tools/buildbot/bin/python'} 21:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:09 INFO - Downloading/unpacking jsonschema==2.5.1 21:18: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 21:18: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 21:18: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 21:18: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 21:18: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 21:18: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 21:18:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:18:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:11 INFO - Downloading functools32-3.2.3-2.tar.gz 21:18:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:18:11 INFO - warning: no files found matching '*.txt' 21:18:11 INFO - no previously-included directories found matching 'build' 21:18:11 INFO - no previously-included directories found matching 'dist' 21:18:11 INFO - no previously-included directories found matching '.git*' 21:18:11 INFO - Installing collected packages: jsonschema, functools32 21:18:11 INFO - Running setup.py install for functools32 21:18:12 INFO - warning: no files found matching '*.txt' 21:18:12 INFO - no previously-included directories found matching 'build' 21:18:12 INFO - no previously-included directories found matching 'dist' 21:18:12 INFO - no previously-included directories found matching '.git*' 21:18:12 INFO - Successfully installed jsonschema functools32 21:18:12 INFO - Cleaning up... 21:18:12 INFO - Return code: 0 21:18:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:18: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')]} 21:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18: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')]} 21:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc31b2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2622ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ff60>, '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 0x2620d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26211d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', '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 21:18:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:18:12 INFO - Using env: {'DISPLAY': ':0', 21:18:12 INFO - 'HOME': '/home/cltbld', 21:18:12 INFO - 'LANG': 'en_US.UTF-8', 21:18:12 INFO - 'LANGUAGE': 'en_US:en', 21:18:12 INFO - 'LOGNAME': 'cltbld', 21:18:12 INFO - 'MAIL': '/var/mail/cltbld', 21:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:12 INFO - 'MOZ_NO_REMOTE': '1', 21:18:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:12 INFO - 'NO_EM_RESTART': '1', 21:18:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:12 INFO - 'PWD': '/builds/slave/test', 21:18:12 INFO - 'SHELL': '/bin/bash', 21:18:12 INFO - 'SHLVL': '1', 21:18:12 INFO - 'TERM': 'linux', 21:18:12 INFO - 'TMOUT': '86400', 21:18:12 INFO - 'USER': 'cltbld', 21:18:12 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', 21:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:12 INFO - '_': '/tools/buildbot/bin/python'} 21:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:18:12 INFO - Cleaning up... 21:18:12 INFO - Return code: 0 21:18:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:18: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')]} 21:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18: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')]} 21:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc31b2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2622ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ff60>, '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 0x2620d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26211d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', '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 21:18:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:18:12 INFO - Using env: {'DISPLAY': ':0', 21:18:12 INFO - 'HOME': '/home/cltbld', 21:18:12 INFO - 'LANG': 'en_US.UTF-8', 21:18:12 INFO - 'LANGUAGE': 'en_US:en', 21:18:12 INFO - 'LOGNAME': 'cltbld', 21:18:12 INFO - 'MAIL': '/var/mail/cltbld', 21:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:12 INFO - 'MOZ_NO_REMOTE': '1', 21:18:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:12 INFO - 'NO_EM_RESTART': '1', 21:18:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:12 INFO - 'PWD': '/builds/slave/test', 21:18:12 INFO - 'SHELL': '/bin/bash', 21:18:12 INFO - 'SHLVL': '1', 21:18:12 INFO - 'TERM': 'linux', 21:18:12 INFO - 'TMOUT': '86400', 21:18:12 INFO - 'USER': 'cltbld', 21:18:12 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', 21:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:12 INFO - '_': '/tools/buildbot/bin/python'} 21:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:12 INFO - Downloading/unpacking blobuploader==1.2.4 21:18: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 21:18: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 21:18: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 21:18: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 21:18: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 21:18: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 21:18:14 INFO - Downloading blobuploader-1.2.4.tar.gz 21:18:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:18:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:18: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 21:18: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 21:18: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 21:18: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 21:18: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 21:18: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 21:18:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:18:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:18: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 21:18: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 21:18: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 21:18: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 21:18: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 21:18: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 21:18:15 INFO - Downloading docopt-0.6.1.tar.gz 21:18:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:18:15 INFO - Installing collected packages: blobuploader, requests, docopt 21:18:15 INFO - Running setup.py install for blobuploader 21:18:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:18:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:18:15 INFO - Running setup.py install for requests 21:18:15 INFO - Running setup.py install for docopt 21:18:15 INFO - Successfully installed blobuploader requests docopt 21:18:15 INFO - Cleaning up... 21:18:15 INFO - Return code: 0 21:18:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:18: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')]} 21:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18: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')]} 21:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:15 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 0x7fc31b2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2622ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ff60>, '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 0x2620d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26211d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', '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 21:18:15 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 21:18:15 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 21:18:15 INFO - Using env: {'DISPLAY': ':0', 21:18:15 INFO - 'HOME': '/home/cltbld', 21:18:15 INFO - 'LANG': 'en_US.UTF-8', 21:18:15 INFO - 'LANGUAGE': 'en_US:en', 21:18:15 INFO - 'LOGNAME': 'cltbld', 21:18:15 INFO - 'MAIL': '/var/mail/cltbld', 21:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:15 INFO - 'MOZ_NO_REMOTE': '1', 21:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:15 INFO - 'NO_EM_RESTART': '1', 21:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:15 INFO - 'PWD': '/builds/slave/test', 21:18:15 INFO - 'SHELL': '/bin/bash', 21:18:15 INFO - 'SHLVL': '1', 21:18:15 INFO - 'TERM': 'linux', 21:18:15 INFO - 'TMOUT': '86400', 21:18:15 INFO - 'USER': 'cltbld', 21:18:15 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', 21:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:15 INFO - '_': '/tools/buildbot/bin/python'} 21:18:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:18:16 INFO - Running setup.py (path:/tmp/pip-jgbgT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:18:16 INFO - Running setup.py (path:/tmp/pip-xkSzCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:18:16 INFO - Running setup.py (path:/tmp/pip-Vkxqzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:18:16 INFO - Running setup.py (path:/tmp/pip-vz1s7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:18:16 INFO - Running setup.py (path:/tmp/pip-AT7VnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:18:16 INFO - Running setup.py (path:/tmp/pip-I_K57O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:18:16 INFO - Running setup.py (path:/tmp/pip-iNkzwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:18:16 INFO - Running setup.py (path:/tmp/pip-Nydoh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:18:16 INFO - Running setup.py (path:/tmp/pip-WekrXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:18:16 INFO - Running setup.py (path:/tmp/pip-E2nlxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:18:16 INFO - Running setup.py (path:/tmp/pip-ahHWg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:18:16 INFO - Running setup.py (path:/tmp/pip-7krSKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:18:16 INFO - Running setup.py (path:/tmp/pip-7crrvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:18:16 INFO - Running setup.py (path:/tmp/pip-z8nRRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:17 INFO - Running setup.py (path:/tmp/pip-1BEvLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:18:17 INFO - Running setup.py (path:/tmp/pip-gnHQYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:18:17 INFO - Running setup.py (path:/tmp/pip-HuC_yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:18:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:18:17 INFO - Running setup.py install for manifestparser 21:18:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:18:17 INFO - Running setup.py install for mozcrash 21:18:17 INFO - Running setup.py install for mozdebug 21:18:17 INFO - Running setup.py install for mozdevice 21:18:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:18:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:18:17 INFO - Running setup.py install for mozfile 21:18:17 INFO - Running setup.py install for mozhttpd 21:18:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:18:17 INFO - Running setup.py install for mozinfo 21:18:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:18:17 INFO - Running setup.py install for mozInstall 21:18:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:18:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:18:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:18:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:18:18 INFO - Running setup.py install for mozleak 21:18:18 INFO - Running setup.py install for mozlog 21:18:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:18:18 INFO - Running setup.py install for moznetwork 21:18:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:18:18 INFO - Running setup.py install for mozprocess 21:18:18 INFO - Running setup.py install for mozprofile 21:18:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:18:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:18:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:18:18 INFO - Running setup.py install for mozrunner 21:18:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:18:18 INFO - Running setup.py install for mozscreenshot 21:18:18 INFO - Running setup.py install for moztest 21:18:18 INFO - Running setup.py install for mozversion 21:18:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:18:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:18:19 INFO - Cleaning up... 21:18:19 INFO - Return code: 0 21:18:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc31b2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2622ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ff60>, '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 0x2620d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26211d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', '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 21:18:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:18:19 INFO - Using env: {'DISPLAY': ':0', 21:18:19 INFO - 'HOME': '/home/cltbld', 21:18:19 INFO - 'LANG': 'en_US.UTF-8', 21:18:19 INFO - 'LANGUAGE': 'en_US:en', 21:18:19 INFO - 'LOGNAME': 'cltbld', 21:18:19 INFO - 'MAIL': '/var/mail/cltbld', 21:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:19 INFO - 'MOZ_NO_REMOTE': '1', 21:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:19 INFO - 'NO_EM_RESTART': '1', 21:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:19 INFO - 'PWD': '/builds/slave/test', 21:18:19 INFO - 'SHELL': '/bin/bash', 21:18:19 INFO - 'SHLVL': '1', 21:18:19 INFO - 'TERM': 'linux', 21:18:19 INFO - 'TMOUT': '86400', 21:18:19 INFO - 'USER': 'cltbld', 21:18:19 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', 21:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:19 INFO - '_': '/tools/buildbot/bin/python'} 21:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:18:19 INFO - Running setup.py (path:/tmp/pip-wprU9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:18:19 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)) 21:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:18:19 INFO - Running setup.py (path:/tmp/pip-XrHjLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:18:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:18:19 INFO - Running setup.py (path:/tmp/pip-dpF9sK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:18:19 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)) 21:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:18:19 INFO - Running setup.py (path:/tmp/pip-UMweTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:18:19 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)) 21:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:18:19 INFO - Running setup.py (path:/tmp/pip-_oT9N5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:18:19 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)) 21:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:18:19 INFO - Running setup.py (path:/tmp/pip-trCekp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:18:19 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)) 21:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:18:19 INFO - Running setup.py (path:/tmp/pip-KtVE_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:18:19 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)) 21:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:18:19 INFO - Running setup.py (path:/tmp/pip-xsJQ1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:18:19 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)) 21:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:18:19 INFO - Running setup.py (path:/tmp/pip-mWHrQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:18:19 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)) 21:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:18:19 INFO - Running setup.py (path:/tmp/pip-Wwi_zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:18:20 INFO - Running setup.py (path:/tmp/pip-fMSMkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:18:20 INFO - Running setup.py (path:/tmp/pip-jIJpUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:18:20 INFO - Running setup.py (path:/tmp/pip-L_fVad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:18:20 INFO - Running setup.py (path:/tmp/pip-Prz9rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:20 INFO - Running setup.py (path:/tmp/pip-jCFdAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:20 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)) 21:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:18:20 INFO - Running setup.py (path:/tmp/pip-N83Uj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:18:20 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)) 21:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:18:20 INFO - Running setup.py (path:/tmp/pip-n3ePI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:18:20 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)) 21:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:18:20 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)) 21:18:20 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)) 21:18:20 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)) 21:18:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:18:20 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 21:18:20 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 21:18:20 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 21:18:20 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 21:18:20 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 21:18:20 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 21:18:22 INFO - Downloading blessings-1.6.tar.gz 21:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:18:22 INFO - Installing collected packages: blessings 21:18:22 INFO - Running setup.py install for blessings 21:18:22 INFO - Successfully installed blessings 21:18:22 INFO - Cleaning up... 21:18:22 INFO - Return code: 0 21:18:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:18:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:18:22 INFO - Reading from file tmpfile_stdout 21:18:22 INFO - Current package versions: 21:18:22 INFO - argparse == 1.2.1 21:18:22 INFO - blessings == 1.6 21:18:22 INFO - blobuploader == 1.2.4 21:18:22 INFO - docopt == 0.6.1 21:18:22 INFO - functools32 == 3.2.3-2 21:18:22 INFO - jsonschema == 2.5.1 21:18:22 INFO - manifestparser == 1.1 21:18:22 INFO - mozInstall == 1.12 21:18:22 INFO - mozcrash == 0.17 21:18:22 INFO - mozdebug == 0.1 21:18:22 INFO - mozdevice == 0.48 21:18:22 INFO - mozfile == 1.2 21:18:22 INFO - mozhttpd == 0.7 21:18:22 INFO - mozinfo == 0.9 21:18:22 INFO - mozleak == 0.1 21:18:22 INFO - mozlog == 3.4 21:18:22 INFO - moznetwork == 0.27 21:18:22 INFO - mozprocess == 0.23 21:18:22 INFO - mozprofile == 0.28 21:18:22 INFO - mozrunner == 6.12 21:18:22 INFO - mozscreenshot == 0.1 21:18:22 INFO - mozsystemmonitor == 0.3 21:18:22 INFO - moztest == 0.7 21:18:22 INFO - mozversion == 1.4 21:18:22 INFO - psutil == 3.1.1 21:18:22 INFO - requests == 1.2.3 21:18:22 INFO - wsgiref == 0.1.2 21:18:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:18: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')]} 21:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18: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')]} 21:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:22 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 0x7fc31b2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2622ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ff60>, '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 0x2620d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26211d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', '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 21:18:22 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 21:18:22 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 21:18:22 INFO - Using env: {'DISPLAY': ':0', 21:18:22 INFO - 'HOME': '/home/cltbld', 21:18:22 INFO - 'LANG': 'en_US.UTF-8', 21:18:22 INFO - 'LANGUAGE': 'en_US:en', 21:18:22 INFO - 'LOGNAME': 'cltbld', 21:18:22 INFO - 'MAIL': '/var/mail/cltbld', 21:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:22 INFO - 'MOZ_NO_REMOTE': '1', 21:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:22 INFO - 'NO_EM_RESTART': '1', 21:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:22 INFO - 'PWD': '/builds/slave/test', 21:18:22 INFO - 'SHELL': '/bin/bash', 21:18:22 INFO - 'SHLVL': '1', 21:18:22 INFO - 'TERM': 'linux', 21:18:22 INFO - 'TMOUT': '86400', 21:18:22 INFO - 'USER': 'cltbld', 21:18:22 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', 21:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:22 INFO - '_': '/tools/buildbot/bin/python'} 21:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:18:23 INFO - Cleaning up... 21:18:23 INFO - Return code: 0 21:18:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc31b2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2622ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ff60>, '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 0x2620d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26211d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', '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 21:18:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:18:23 INFO - Using env: {'DISPLAY': ':0', 21:18:23 INFO - 'HOME': '/home/cltbld', 21:18:23 INFO - 'LANG': 'en_US.UTF-8', 21:18:23 INFO - 'LANGUAGE': 'en_US:en', 21:18:23 INFO - 'LOGNAME': 'cltbld', 21:18:23 INFO - 'MAIL': '/var/mail/cltbld', 21:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:23 INFO - 'MOZ_NO_REMOTE': '1', 21:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:23 INFO - 'NO_EM_RESTART': '1', 21:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:23 INFO - 'PWD': '/builds/slave/test', 21:18:23 INFO - 'SHELL': '/bin/bash', 21:18:23 INFO - 'SHLVL': '1', 21:18:23 INFO - 'TERM': 'linux', 21:18:23 INFO - 'TMOUT': '86400', 21:18:23 INFO - 'USER': 'cltbld', 21:18:23 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', 21:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:23 INFO - '_': '/tools/buildbot/bin/python'} 21:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:18:23 INFO - Cleaning up... 21:18:23 INFO - Return code: 0 21:18:23 INFO - Running post-action listener: _resource_record_post_action 21:18:23 INFO - Running post-action listener: _start_resource_monitoring 21:18:23 INFO - Starting resource monitoring. 21:18:23 INFO - [mozharness: 2016-10-07 04:18:23.409627Z] Finished create-virtualenv step (success) 21:18:23 INFO - [mozharness: 2016-10-07 04:18:23.410092Z] Running install step. 21:18:23 INFO - Running pre-action listener: _resource_record_pre_action 21:18:23 INFO - Running main action method: install 21:18:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:18:23 INFO - Reading from file tmpfile_stdout 21:18:23 INFO - Detecting whether we're running mozinstall >=1.0... 21:18:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:18:23 INFO - Reading from file tmpfile_stdout 21:18:23 INFO - Output received: 21:18:23 INFO - Usage: mozinstall [options] installer 21:18:23 INFO - Options: 21:18:23 INFO - -h, --help show this help message and exit 21:18:23 INFO - -d DEST, --destination=DEST 21:18:23 INFO - Directory to install application into. [default: 21:18:23 INFO - "/builds/slave/test"] 21:18:23 INFO - --app=APP Application being installed. [default: firefox] 21:18:23 INFO - mkdir: /builds/slave/test/build/application 21:18:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:18:39 INFO - Reading from file tmpfile_stdout 21:18:39 INFO - Output received: 21:18:39 INFO - /builds/slave/test/build/application/firefox/firefox 21:18:39 INFO - Running post-action listener: _resource_record_post_action 21:18:39 INFO - [mozharness: 2016-10-07 04:18:39.848655Z] Finished install step (success) 21:18:39 INFO - [mozharness: 2016-10-07 04:18:39.848906Z] Running run-tests step. 21:18:39 INFO - Running pre-action listener: _resource_record_pre_action 21:18:39 INFO - Running main action method: run_tests 21:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:18:39 INFO - Python 2.7.3 21:18:39 INFO - Return code: 0 21:18:39 INFO - grabbing minidump binary from tooltool 21:18:39 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')]} 21:18:39 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 0x261ff60>, '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 0x2620d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26211d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:18:39 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 21:18:39 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 21:18:39 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 21:18:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:18:39 INFO - Return code: 0 21:18:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:18:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:18:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:18:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:18:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 21:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 21:18:39 INFO - Using env: {'DISPLAY': ':0', 21:18:39 INFO - 'HOME': '/home/cltbld', 21:18:39 INFO - 'LANG': 'en_US.UTF-8', 21:18:39 INFO - 'LANGUAGE': 'en_US:en', 21:18:39 INFO - 'LOGNAME': 'cltbld', 21:18:39 INFO - 'MAIL': '/var/mail/cltbld', 21:18:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:18:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:39 INFO - 'MOZ_NO_REMOTE': '1', 21:18:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:39 INFO - 'NO_EM_RESTART': '1', 21:18:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:39 INFO - 'PWD': '/builds/slave/test', 21:18:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:18:39 INFO - 'SHELL': '/bin/bash', 21:18:39 INFO - 'SHLVL': '1', 21:18:39 INFO - 'TERM': 'linux', 21:18:39 INFO - 'TMOUT': '86400', 21:18:39 INFO - 'USER': 'cltbld', 21:18:39 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722', 21:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:39 INFO - '_': '/tools/buildbot/bin/python'} 21:18:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 21:18:40 INFO - mozversion application_buildid: 20161006195807 21:18:40 INFO - mozversion application_changeset: d8e1f5cf0a70a53e8a5532809096a0a5bf729196 21:18:40 INFO - mozversion application_display_name: Nightly 21:18:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:18:40 INFO - mozversion application_name: Firefox 21:18:40 INFO - mozversion application_remotingname: firefox 21:18:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:18:40 INFO - mozversion application_vendor: Mozilla 21:18:40 INFO - mozversion application_version: 52.0a1 21:18:40 INFO - mozversion platform_buildid: 20161006195807 21:18:40 INFO - mozversion platform_changeset: d8e1f5cf0a70a53e8a5532809096a0a5bf729196 21:18:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:18:40 INFO - mozversion platform_version: 52.0a1 21:18:40 INFO - using testdate: 1475813920 21:18:40 INFO - actual date: 1475813920 21:18:40 INFO - starting webserver on 'localhost:39306' 21:18:40 INFO - SUITE-START | Running 2 tests 21:18:40 INFO - TEST-START | dromaeo_css 21:18:40 INFO - operating with platform_type : linux_ 21:18:40 INFO - Initialising browser for dromaeo_css test... 21:18:40 INFO - TEST-INFO | started process 31504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK9F1F4/profile http://localhost:39306/getInfo.html) 21:18:44 INFO - PROCESS | 31504 | __metrics Screen width/height:1600/1200 21:18:44 INFO - PROCESS | 31504 | colorDepth:24 21:18:44 INFO - PROCESS | 31504 | Browser inner width/height: 1024/697 21:18:44 INFO - PROCESS | 31504 | __metrics 21:18:45 INFO - PROCESS | 31504 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:18:45 INFO - PROCESS | 31504 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:18:46 INFO - PROCESS | 31504 | console.error: PushService: 21:18:46 INFO - PROCESS | 31504 | stateChangeProcessEnqueue: Error transitioning state 21:18:46 INFO - PROCESS | 31504 | UnknownError 21:18:46 INFO - TEST-INFO | 31504: exit 0 21:18:46 INFO - Browser initialized. 21:18:46 INFO - Running cycle 1/1 for dromaeo_css test... 21:18:46 INFO - TEST-INFO | started process 31586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK9F1F4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:18:59 INFO - PROCESS | 31586 | RSS: Main: 174899200 21:18:59 INFO - PROCESS | 31586 | 21:19:50 INFO - PROCESS | 31586 | 1475813990644 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] 21:22:04 INFO - PROCESS | 31586 | Cycle 1(1): loaded http://localhost:39306/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39306/tests/dromaeo/cssquery-ext.html) 21:22:05 INFO - PROCESS | 31586 | RSS: Main: 281825280 21:22:05 INFO - PROCESS | 31586 | 21:25:08 INFO - PROCESS | 31586 | Cycle 1(1): loaded http://localhost:39306/tests/dromaeo/cssquery-ext.html (next: http://localhost:39306/tests/dromaeo/cssquery-jquery.html) 21:25:08 INFO - PROCESS | 31586 | RSS: Main: 281620480 21:25:08 INFO - PROCESS | 31586 | 21:28:10 INFO - PROCESS | 31586 | Cycle 1(1): loaded http://localhost:39306/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39306/tests/dromaeo/cssquery-mootools.html) 21:28:11 INFO - PROCESS | 31586 | RSS: Main: 220377088 21:28:11 INFO - PROCESS | 31586 | 21:31:13 INFO - PROCESS | 31586 | Cycle 1(1): loaded http://localhost:39306/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39306/tests/dromaeo/cssquery-prototype.html) 21:31:14 INFO - PROCESS | 31586 | RSS: Main: 231526400 21:31:14 INFO - PROCESS | 31586 | 21:34:17 INFO - PROCESS | 31586 | Cycle 1(1): loaded http://localhost:39306/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39306/tests/dromaeo/cssquery-yui.html) 21:34:18 INFO - PROCESS | 31586 | RSS: Main: 221200384 21:34:18 INFO - PROCESS | 31586 | 21:37:21 INFO - PROCESS | 31586 | Cycle 1(1): loaded http://localhost:39306/tests/dromaeo/cssquery-yui.html (next: http://localhost:39306/tests/dromaeo/cssquery-dojo.html) 21:37:21 INFO - PROCESS | 31586 | RSS: Main: 307720192 21:37:21 INFO - PROCESS | 31586 | 21:37:21 INFO - PROCESS | 31586 | __start_tp_report 21:37:21 INFO - PROCESS | 31586 | _x_x_mozilla_page_load 21:37:21 INFO - PROCESS | 31586 | _x_x_mozilla_page_load_details 21:37:21 INFO - PROCESS | 31586 | |i|pagename|runs| 21:37:21 INFO - PROCESS | 31586 | |0;dojo.html;2551.93620159496;2572.9871350643243;2597.7012643546;2605.570080936645;2617.698964619068;4539.59143677069;4618.4688760792515;4622.768861556926;4628.166929952616;4628.190066738324;4616.469106052805;4626.167289887819;4649;4652.906941861169;4664.230401983668;4276.764777937212;4297.935530967038;4319.136172765444;4331.6534677225745;4343.174796788616;4263.872083837475;4293.957060429387;4315.352697095429;4325.091730736549;4343.9565604344025;4238.046439551092;4242.766647834368;4255.468066491689;4288.571142885718;4401.185780630578;4293.205756934945;4294.592013758688;4295.78521073945;4312.310030395153;4321.351797230409;4103.261412945669;4146.606072423115;4197.18154959783;4216.430781844442;4273.401723758645;4567.817287308537;4575.9771201143785;4579.702319349231;4580.540169306808;4666.9766651166865;4900;4900.26496025599;4923.975380123076;4927.975360123212;4952.727599981999;4804.25534042224;4861.440934292566;4868.269759536098;4921.507849215086;4933.629977751647;4634.119517291704;4639.443266808004;4644.512326205768;4673.649476289292;4692.202325604655;5055.823046193365;5072.087024335581;5072.67027643202;5074.06129865976;5129.820456284012;4684.5549672781035;4737.478877323491;4861.149298872683;4864.708117512961;4929.359183306147;4829.9275510867365;4875.024995001014;4883.169861123618;4886.511348865085;4951.480094590088;4820.758962051884;4826.782794774173;4831.565159135695;4832.830850920201;4889.682170658896;4788.928166077511;4801.18379875422;4802.759862006886;4805.951940480621;4861.0277944411255;3978.781167035841;4013.6387725104883;4013.6989725770686;4013.9598604013586;4065;3589.8743543975834;3602.225521512887;3646.033801042726;3647.6170002149925;3664.780113193217;4147.792610369469;4171.749695018309;4185.497740271126;4235.131797981407;4240.215560121387;4759.690620109682;4802.135615589227;4821.686590371614;4858.8785280367565;4919.581835543947;4161.958380416218;4176.916461670749;4184.497860256789;4229;4230.598093181143;4381.693281470267;4387.166438376762;4388.451443569554;4431.711938724037;4436.866893993185;4525.049739554599;4570.085982803386;4612.469565999953;4618.769061546976;4670.929936050894;4853.80584776605;4904.435989861212;4907.828226012072;4908.680935739166;4943.283223932438;4604.608608268335;4606.769661516978;4615.076984603025;4624.884377890579;4676.719396836201;4693.2021556336185;4831.396075490564;4840.709557426566;4840.951590484191;4896.534829191221;4779.259214821708;4874.049560335842;4913.48408417111;4942.925856112233;4993.226049962262;4793.664443488922;4801.855944321676;4802.591779698625;4802.615790736802;4863.659543832039;4786.976065119652;4805.879853003703;4806.975965120152;4807.95192048089;4868.391451068616;4631.51369106239;4664.253719405015;4679.953200468088;4746.121967436035;4757.5718185363485;4837.903241935212;4842.588379987599;4846.5153484652665;4890.877728056827;4900.460949295503;4550.385697930869;4610.815567377267;4725.8582242532775;4742.264948932921;4762.714237145782 21:37:21 INFO - PROCESS | 31586 | |1;ext.html;551.4375337156101;571.3429556010587;582.1239035251945;587.1955421073128;588.838069530879;26427.339316517096;36570;37573.81213093934;37588.81205593975;42046.57953420465;39397.60602393975;39793.80103099488;39864;39909.800450997776;39929.8003509982;7581.924180758177;7745.457817952745;7753.612319384037;7755.573443460607;7757.418193635472;7452.254774522531;7539.924600753977;7551.093868735759;7551.358134558569;7551.660175292125;7536.924630753704;7564.735234266802;7577.16651168371;7582.620868956557;7583.62081895903;7507.1742108368035;7546.471746977713;7550.056242969629;7560.168381478033;7562.546247225184;7582.090149182079;7630.580318082503;7644.694212231504;7645.3119219269975;7645.617719114078;37375.25249494995;37702.81148594267;37737.622623773685;37755.433668494996;37767;2813.3529288263608;3084.4602194616077;3191.0426871938325;3356.5133055706788;3553.662402071799;27622.585661215096;27877.820720608404;28013.719862801314;28070.157895263175;28930.55347232651;3413.5562376891094;3452.171478845084;3493.196564790087;3493.2664140530264;3550.130218096557;245447;247073;247592;247638.76180619161;248158;49406;49753.751231243616;49759.25361119586;49839.50160498349;49851.50148498541;31762.205944851103;32399.352012959607;32533;52283.21575176375;52505.2124218137;14817.851821481863;15058.32237549313;15148.848511514963;15175.089494630358;15199.088054716753;11574.18980671345;11660.76678466426;11685.591004314809;11686.70783230409;11693.298402095901;17265.741013884803;17328.913355433142;17337.35295146959;17389.217485213198;17532;6667.799286449505;6701;6794.966025169842;6902.413294869993;6944.18760402038;792.3581898662102;886.6054605700531;921.4793641592479;929.6699671616614;978.5400861595039;25893;26883.596746048825;27193.592096118573;27369.589456158174;27585;786.9213078692085;942.58997336159;956.4596003258137;963.2246041936309;1043.2801367056707;13020.934895325652;14383.352749126314;14460.85539144616;14527.709445811024;14634.926825365805;353826;406245;411783;414144;656643;49712.50287497151;50123.498765011886;50200;50229.49770502321;50262.24606630903;1067.0929709746654;1124.6288724720823;1149.270213414488;1150.4305368842477;1199.142613031669;24484;28339.57490637601;28892.85553572219;29271.85364073166;29280.560791587715;39735.60264397319;40378;40394.79802600968;40406.39390409087;40417.59582404138;290694;291303;292657;292704;293840;22097.779022209572;22635.773642263368;22737.658935115654;22765.430864228525;25137.74862251427;39991.80004099961;40208;40490.59509404868;40686;40725;35076.47385289274;35148;35460.64539354573;35598.64401355953;35652;35349.82325088358;35572.82213588915;35633;35650;35875.64124358723;34355.65644343525;34617.134571635914;34649;35160.64839351574;35458.645413545535;29472.410551788416;32094.679053210104;32313.838430807697;32566;32767;24630.753692462848;24837.379065523506;24847.25458236256;24873;25350.366240844127 21:37:21 INFO - PROCESS | 31586 | |2;jquery.html;338.75271052131944;340.62531215662756;369.4790345612686;370.712697659314;383.7122158381214;12237.816432753516;13228.817245154562;13585;14942.25288735563;17206.39777607784;15611.141387223699;15637.452689155882;16116.516504504854;16645.83354166458;16959.91520042398;4849.321095046696;4987.600991920646;4995.875103122433;5031.32077169581;5032.270320803481;3575.3564358415474;3774.433834924756;5035.269885866547;5079.492050794928;5087.5421212090905;5667.518260947824;5945.583809133363;5967.731452084667;6071.3625069367745;6072.666003369813;5800.8259752207505;5958.880822383571;5980.880382392371;6037.0340745480735;6052.485538729214;5309.681419114827;5312.60155488336;5324.600654950894;5324.946750532523;5349.652272602269;19712.90143549273;20030.79969200304;20217.393478195678;20232;20455.386338409873;1892.9716054259197;2015.8084981926693;2064.4735592423986;2219.955600887973;2291.4271432141963;12212.511499540007;13125.868741312655;13316.733665326736;13616.591502254949;13741.793873091912;1639.7048531264368;1715.3738885306898;1728.4555365059966;1753.7018706819872;1805.747195392646;63069;63600;65111.348886511005;67372.32627673709;67816;8750.34372422071;8790.648374065093;8910.108989101038;9644.373115747454;9790.853137202948;13208.471661133448;13209.801852972214;13215.933920330337;13245.867541324656;13254.469821207236;7179.138503379628;7222.422206223489;7360.595167265852;7489.063867016623;7572.507786993828;7363.263673632594;7495.287947644965;7562.810929726691;7620;7667.386609071261;5847.590668653239;5853.756026880563;5874.470391171493;5975.342712301644;6057.697115144225;1693.6289195126922;1733.5839398544258;1740.825917408249;1749.6238308763423;1775.6271183051444;825.9587020648944;826.3513142183357;866.0949307973183;890.550272112579;947.8151760406655;15473.071615703095;16703.248353824107;17139.74290385645;17649.7352539712;17739;841.8021764885247;857.7083791510917;875.0899064972484;881.2553392383426;924.505389616552;9592.760180995392;10105.9494702526;10159.796804063877;10201.693949181536;10233.9488302558;369121;380327;380519;382441;383944;64447;64887.48456381166;67261;67620.32379676239;67632;921.7373048681228;922.1700469577434;923.607466826596;927.4528028463104;942.3121121581147;14908.627284317545;15143.924280378527;15262.465813696468;15718.292676829342;15888.920555397612;32714.672853272114;34446.31107377889;34878;35091.29817403587;35791;44294;44505.10989780251;44653.330200047676;44896.87757806081;45102.54897450984;6409.0838668406695;6686.398224159849;6726.596404215763;6855.828604284933;7209.531380460253;10775;11192.160587955774;11532.423378830857;11588.420578970849;12141.817872732092;10038.899611004088;10178.949105254427;10370.948145259226;10524.684259472227;10894.78210435771;9624.470654114091;9920.702378928356;9925.702228933143;9977.60089596408;10346;10436.16510679159;10458.372497650165;10474.581016759244;10526.736831579272;10746.62386816489;6807.489438292049;6841.657917104224;6973.930260697328;7037.8944315836325;7169.318914703095;9579.712608621752;9656.95171524138;9899.901000990187;10036.799264014824;10290.279680422298 21:37:21 INFO - PROCESS | 31586 | |3;mootools.html;1204.45197435167;1336.6858788184777;1370.4723681382668;1421.3603878254787;1650.6863695897778;6341.239051313843;7179;7422.146453157889;7436.851262974744;7622.085349758023;7445.404367650589;7489.850202995937;7505.174430812606;7505.5121417107985;7510.887336689941;1946.182603306611;1959.0694420150385;1962.3818497173345;1962.7546556680416;1970.3596331192348;1889.3576184097403;1923.2883832981815;1925.913333899971;1930.6717857964109;1937.4671965209538;1924.5573518090848;1934.139308007937;1935.4000259919399;1938.108470103754;1939.8933058681766;1876.0713446843831;1911;1916.9137388817467;1917.6452356314126;1919.29945569866;1840.429466865276;1860.48836569943;1865.0488250991957;1881.8494520438333;1890.3478299986482;7199.9280007200305;7353.411727061823;7428;7489.176190619028;7607.315341619225;4352.086061926999;4535.863924082283;4539.52335004823;4553.590176884063;4581.748003859786;2746.436980419029;2847.9288017799513;2898.971010289891;2917.6061231733656;2924.926876828075;889.3241136736062;899.2940541674753;900.3877363392891;903.6204793986476;912.338554547954;9587.568559414844;9779.46212958287;9805.460699661517;9826.312158148932;9830.4101753895;3790.886273411802;3961.267165574378;4010.3583426651594;4097.098638299629;4111.7944102794745;8456.619452124545;8460.619272132768;8464.957675211585;8471.152884711479;8473.872891906627;4426.092651006536;4426.22541055314;4426.734395936254;4427.335899615084;4434.733915965053;3486.8082255475683;3591.2099338145567;4076.8776936691947;4078.9592104079175;4080.6939479539155;3243.3351163012;3332.1836150142885;3448.9655103448645;3528.5412896323314;3542.8051457169586;1109.6615532262576;1142.3203194099497;1147.0651419093413;1147.908167346627;1148.6108893501496;701.8876979683226;710.3784188834769;722.6856317501904;741.1995045351008;753.4876284126847;4848.296996935424;4897.314375987365;4985;5064.7214403207445;5117.74411279442;813.7111325479488;822.7778499805019;844.7972486603294;847.7287268074281;857.3955361470148;3465.54947856777;3477.078574177845;3515.43752999524;3538.6284440133413;3601.85592576294;8519.105493923173;8974.37179397449;8983.730488085368;9006.59470323837;9013.233875120688;8772.824543509094;8954.776130596787;9005.459672419676;9046.276297896153;9087.36388452802;6879;6958.443324534025;6959;6960;6965.268646792115;4686.671932964796;4790.712557246577;4941.629377796751;4990.134618746693;5131.79472821083;8258.752237432887;8308.70919517814;8358.707445239388;8416.4950102994;8423.368247381348;8332.375071869756;8430.45202061864;8439;8472.872906906525;8569.957150214459;6558.901616475852;6610.10763546915;6615.272320044695;6623.701933413105;6634.303398143318;6677.098591690254;6746.123004009447;6788.76239331621;6797.694103765243;6815.795526134224;6002.33974262822;6036.185115009417;6061.39386061408;6154.230721159855;6182.598131121463;6175.84560385994;6251.937480625135;6272.341404152498;6283.2460104787715;6394.200724909387;5822.796202132905;5831.446012628793;5836.591438599257;5878.412158784087;5898.528117750656;4248.490181178155;4338.240807858675;4395.494518130456;4459.777011149495;4472.39622650951;4147.97926010368;4156.06488540076;4180.268453020648;4277.545634484166;4332.6317263033 21:37:21 INFO - PROCESS | 31586 | |4;prototype.html;256.0896014667855;279.3742017879948;282.7031616802358;287.4237154505217;293.2580571154979;4495.730256184631;4535.501094879564;4638.211504044312;4733.668643194977;4792.305115758213;4723.598494127995;4724.787384567694;4753.382060332161;4772.164871147553;4773.57037866592;3506.5266189064405;3672.173760903802;3684.5762737285154;3694.8915325402404;3706.7759344393417;3470.410030294843;3572.7141828653644;3586.55168103987;3691;3698.093966978094;3631.400818864884;3654.7441679082476;3657.4397921454956;3660.798656073915;3671.3942199537046;3647.544056992876;3669.174435751961;3671.284099600579;3672.7612705174347;3675.3016926783826;3214.3089235814414;3215.1640573451073;3222.8871989480253;3228.5480032795426;3241.578594782663;4374.58441448062;4609.976950115261;4613.492515823256;4613.869601947545;4623.606993405565;4115.670746340285;4119.608637179464;4119.814608342602;4132.876013719593;4157.272477316487;4909.435414927258;4911.68074075184;4927.1870141426625;4934.111859865223;4940.308356830046;3272.5582046423665;3453.3611281912677;3482.7387945903906;3493.7205023598303;3493.737969652286;5120.001599688062;5153.149730294497;5163.690178589259;5168.664036837594;5173.499685091319;3567.554055743032;3567.625399333033;3570.696490798311;3575.249197668467;3578.284343131384;3629.6551827576336;3637.381645120336;3646.5624125104628;3652.593751405675;3657.6159503251774;3943.842246310173;4084.917496863334;4130.359794231899;4142.316517774533;4174.874753757392;4900.436449808247;4903.141950158708;4906.846890980617;4918.926216106761;4922.704637721677;1250.9874901251053;1255.409957320058;1259.2885019963874;1260.5147018397984;1261.9621411357673;733.7395224695263;776.0997243197863;790.4506368074249;792.1247022040562;799.1788984883372;3871.922561548753;3871.9806400968378;3885.3977633466857;3920.0591857954455;3953.466282051944;4460.219461594273;4487.5961163494785;4535.841245556389;4545.886352841139;4549.7042692224895;3878.9030274242805;3918.529776426847;3931.486377744589;3948.545917219499;3969.523657161159;2328.2189125319146;2416.842905211191;2421.7093948726265;2432.8905199266073;2433.9026438942597;4161.542230354658;4323.0705398339505;4323.740575565476;4347.826086956549;4354.040681693187;4509.2559727644575;4528.320751887243;4544.772761361919;4569.611583015414;4572.90250339916;4240.533541310453;4250.808713607895;4261;4473.664475164375;4807.351007613927;5072.239164125411;5094.5160209780015;5094.949050509447;5097.566706829961;5098.770555324945;4763.857084287339;4904.288878112725;4984.900301993867;5001.24981252815;5022.844745708435;4644.767761611838;4783.95216047835;4786.688865223749;4794.736289504111;4805.783739731791;3555.5377800885717;3598.820058997092;3607.4228123500116;3640.872569460056;3647.7811331320204;4858.805647774191;5035.874103147451;5097.566706829961;5131.255967884561;5131.974340128276;4925.852224433273;4944.851654450372;4956.281339205723;4969.155243608523;4972.577330926912;4971.036440606013;4971.925421118758;4977.576905963034;5009.198528235464;5026.472220416804;4759.6668233223345;4853;4913.877153071202;4928.162212423968;4941.555260026615;4999.375078115236;5002.349694539686;5011.799528018839;5019;5023.824166154167;4854.466008738966;4877.756112194447;4907.4111106666;4946.307516947702;4949.925751113664 21:37:21 INFO - PROCESS | 31586 | |5;yui.html;589.7632535932513;660.5805313625849;667.7262322447791;713.7430525010996;724.5326764237067;12884.484620615176;13911.165330080203;13924.791128133085;13927.860721392795;13929.442822287108;11912.940435297833;11956.222845515058;11988.64034078979;11988.880111198885;12063.396830158501;607.501848484243;623.8721062182242;736.2821249281934;751.4138971602159;764.7285213749122;766.877299632059;771.8919351290824;773.2538100732792;773.5474747272852;776.9184235655259;805.4885147931047;805.8307755371379;808.2119933065273;809.2352726673296;809.7287408718057;633.6894921488483;650.2262307853687;652.4095693397483;653.493542504558;796.6295672512281;485.24786580799974;560.6664034899228;578.6759414727766;581.4505292498591;582.4554041970771;12044.156909016372;12079.516819327217;12100;12102.394880255952;12145.210561313486;11648.825267620992;11955.64133076009;12070.939645301805;12389.380530973416;12769.170003949714;10135.341202821794;10301.124404425633;11014.614488492944;11047.779044419147;11284.548618055267;4088.1414902870433;4144.129732756125;4170.6871984600975;4223.809928553223;4339.370791235285;48209.51790482085;50347.74826125846;50484.747576261885;58243.12635310516;58307.12539311914;9817.460039697886;9994.600215991424;10010.099091081838;10057;10232.59069637206;16226.513204603882;16230.269637866324;16237.51287461378;16257.561365795225;16266.430674926321;6447.903281450782;6499.837504062436;6500.382463665944;6544.3782840630065;6711.899321510181;3535.169235229719;3568.072301201706;3581.71346292296;3635.0367152704553;3678.3746763050344;2910.4033673096965;3007.443622929765;3023.259301471154;3027.303720144379;3027.9848600756854;503.4663256947574;504.95202955719145;506.09914352452694;507.92888995540653;517.6428264497484;550.3505863081602;566.7619599768108;569.4959960435045;582.6620560075146;585.9033259512217;7372;7535.962320188364;7585.506942048749;7715.807104822425;8341.791455213546;482.7465580570159;507.8933423981005;515.2065818639328;570.6775671745451;571.9942800572024;3672.687821535146;3848.5766565677754;4274.1451709658195;4393.692441529062;4395.230834603995;94391.0560894396;95596.52201738946;98446;98803.50598246962;101273.49363253136;82652.17347826566;84268.15731842603;85332.57333713291;85914.57042714747;90582;77974.61012695014;78249.60875195701;78605.2139478598;79094.60452697815;80159.59920200362;8053.838923221386;8108.878366824621;8177.877331840146;8446.619902104543;8697;30847;31244.68755312418;41536;43086.78456607697;43908;42141.157176856905;55825.44174558202;59230.40769592249;66236.74305517504;67913.66043169753;9663.226941844776;9714.80570388574;9724.367916085432;9837.901620983985;9895.604175833174;12402.379881006094;12442.6576975508;12985.22606350063;13023.869761302265;13077.738445230852;11076.612318568812;11467.827982580435;11469.523325054863;11515.884841151816;11675.649730508097;10002.8499572505;10255.58977640886;10270.229732770222;10409.635662751767;10724.410157441103;10349.793004139725;10625.628103016667;10695.839562406414;10709.303895246783;10991.06575941054;8108.878366824384;8367.12145224767;8521.147885211429;8635.30917526609;8876.378653494194;8618.310535157298;8846.690365837165;9316.860247096163;9479.478628675213;9497.335186537153 21:37:21 INFO - PROCESS | 31586 | __end_tp_report 21:37:21 INFO - PROCESS | 31586 | __start_cc_report 21:37:21 INFO - PROCESS | 31586 | _x_x_mozilla_cycle_collect,1081 21:37:21 INFO - PROCESS | 31586 | __end_cc_report 21:37:21 INFO - PROCESS | 31586 | __startTimestamp1475815041324__endTimestamp 21:37:21 INFO - PROCESS | 31586 | 21:37:21 INFO - PROCESS | 31586 | ------- Summary: start ------- 21:37:21 INFO - PROCESS | 31586 | Number of tests: 6 21:37:21 INFO - PROCESS | 31586 | 21:37:21 INFO - PROCESS | 31586 | [#0] dojo.html Cycles:165 Average:4536.77 Median:4664.23 stddev:470.09 (10.1%) stddev-sans-first:445.00 21:37:21 INFO - PROCESS | 31586 | Values: 2551.9 2573.0 2597.7 2605.6 2617.7 4539.6 4618.5 4622.8 4628.2 4628.2 4616.5 4626.2 4649.0 4652.9 4664.2 4276.8 4297.9 4319.1 4331.7 4343.2 4263.9 4294.0 4315.4 4325.1 4344.0 4238.0 4242.8 4255.5 4288.6 4401.2 4293.2 4294.6 4295.8 4312.3 4321.4 4103.3 4146.6 4197.2 4216.4 4273.4 4567.8 4576.0 4579.7 4580.5 4667.0 4900.0 4900.3 4924.0 4928.0 4952.7 4804.3 4861.4 4868.3 4921.5 4933.6 4634.1 4639.4 4644.5 4673.6 4692.2 5055.8 5072.1 5072.7 5074.1 5129.8 4684.6 4737.5 4861.1 4864.7 4929.4 4829.9 4875.0 4883.2 4886.5 4951.5 4820.8 4826.8 4831.6 4832.8 4889.7 4788.9 4801.2 4802.8 4806.0 4861.0 3978.8 4013.6 4013.7 4014.0 4065.0 3589.9 3602.2 3646.0 3647.6 3664.8 4147.8 4171.7 4185.5 4235.1 4240.2 4759.7 4802.1 4821.7 4858.9 4919.6 4162.0 4176.9 4184.5 4229.0 4230.6 4381.7 4387.2 4388.5 4431.7 4436.9 4525.0 4570.1 4612.5 4618.8 4670.9 4853.8 4904.4 4907.8 4908.7 4943.3 4604.6 4606.8 4615.1 4624.9 4676.7 4693.2 4831.4 4840.7 4841.0 4896.5 4779.3 4874.0 4913.5 4942.9 4993.2 4793.7 4801.9 4802.6 4802.6 4863.7 4787.0 4805.9 4807.0 4808.0 4868.4 4631.5 4664.3 4680.0 4746.1 4757.6 4837.9 4842.6 4846.5 4890.9 4900.5 4550.4 4610.8 4725.9 4742.3 4762.7 21:37:21 INFO - PROCESS | 31586 | 21:37:21 INFO - PROCESS | 31586 | [#1] ext.html Cycles:180 Average:47344.78 Median:35585.73 stddev:91851.83 (258.1%) stddev-sans-first:92042.30 21:37:21 INFO - PROCESS | 31586 | Values: 551.4 571.3 582.1 587.2 588.8 26427.3 36570.0 37573.8 37588.8 42046.6 39397.6 39793.8 39864.0 39909.8 39929.8 7581.9 7745.5 7753.6 7755.6 7757.4 7452.3 7539.9 7551.1 7551.4 7551.7 7536.9 7564.7 7577.2 7582.6 7583.6 7507.2 7546.5 7550.1 7560.2 7562.5 7582.1 7630.6 7644.7 7645.3 7645.6 37375.3 37702.8 37737.6 37755.4 37767.0 2813.4 3084.5 3191.0 3356.5 3553.7 27622.6 27877.8 28013.7 28070.2 28930.6 3413.6 3452.2 3493.2 3493.3 3550.1 245447.0 247073.0 247592.0 247638.8 248158.0 49406.0 49753.8 49759.3 49839.5 49851.5 31762.2 32399.4 32533.0 52283.2 52505.2 14817.9 15058.3 15148.8 15175.1 15199.1 11574.2 11660.8 11685.6 11686.7 11693.3 17265.7 17328.9 17337.4 17389.2 17532.0 6667.8 6701.0 6795.0 6902.4 6944.2 792.4 886.6 921.5 929.7 978.5 25893.0 26883.6 27193.6 27369.6 27585.0 786.9 942.6 956.5 963.2 1043.3 13020.9 14383.4 14460.9 14527.7 14634.9 353826.0 406245.0 411783.0 414144.0 656643.0 49712.5 50123.5 50200.0 50229.5 50262.2 1067.1 1124.6 1149.3 1150.4 1199.1 24484.0 28339.6 28892.9 29271.9 29280.6 39735.6 40378.0 40394.8 40406.4 40417.6 290694.0 291303.0 292657.0 292704.0 293840.0 22097.8 22635.8 22737.7 22765.4 25137.7 39991.8 40208.0 40490.6 40686.0 40725.0 35076.5 35148.0 35460.6 35598.6 35652.0 35349.8 35572.8 35633.0 35650.0 35875.6 34355.7 34617.1 34649.0 35160.6 35458.6 29472.4 32094.7 32313.8 32566.0 32767.0 24630.8 24837.4 24847.3 24873.0 25350.4 21:37:21 INFO - PROCESS | 31586 | 21:37:21 INFO - PROCESS | 31586 | [#2] jquery.html Cycles:180 Average:23360.77 Median:44579.22 stddev:62308.53 (139.8%) stddev-sans-first:62459.34 21:37:21 INFO - PROCESS | 31586 | Values: 338.8 340.6 369.5 370.7 383.7 12237.8 13228.8 13585.0 14942.3 17206.4 15611.1 15637.5 16116.5 16645.8 16959.9 4849.3 4987.6 4995.9 5031.3 5032.3 3575.4 3774.4 5035.3 5079.5 5087.5 5667.5 5945.6 5967.7 6071.4 6072.7 5800.8 5958.9 5980.9 6037.0 6052.5 5309.7 5312.6 5324.6 5324.9 5349.7 19712.9 20030.8 20217.4 20232.0 20455.4 1893.0 2015.8 2064.5 2220.0 2291.4 12212.5 13125.9 13316.7 13616.6 13741.8 1639.7 1715.4 1728.5 1753.7 1805.7 63069.0 63600.0 65111.3 67372.3 67816.0 8750.3 8790.6 8910.1 9644.4 9790.9 13208.5 13209.8 13215.9 13245.9 13254.5 7179.1 7222.4 7360.6 7489.1 7572.5 7363.3 7495.3 7562.8 7620.0 7667.4 5847.6 5853.8 5874.5 5975.3 6057.7 1693.6 1733.6 1740.8 1749.6 1775.6 826.0 826.4 866.1 890.6 947.8 15473.1 16703.2 17139.7 17649.7 17739.0 841.8 857.7 875.1 881.3 924.5 9592.8 10105.9 10159.8 10201.7 10233.9 369121.0 380327.0 380519.0 382441.0 383944.0 64447.0 64887.5 67261.0 67620.3 67632.0 921.7 922.2 923.6 927.5 942.3 14908.6 15143.9 15262.5 15718.3 15888.9 32714.7 34446.3 34878.0 35091.3 35791.0 44294.0 44505.1 44653.3 44896.9 45102.5 6409.1 6686.4 6726.6 6855.8 7209.5 10775.0 11192.2 11532.4 11588.4 12141.8 10038.9 10178.9 10370.9 10524.7 10894.8 9624.5 9920.7 9925.7 9977.6 10346.0 10436.2 10458.4 10474.6 10526.7 10746.6 6807.5 6841.7 6973.9 7037.9 7169.3 9579.7 9657.0 9899.9 10036.8 10290.3 21:37:21 INFO - PROCESS | 31586 | 21:37:21 INFO - PROCESS | 31586 | [#3] mootools.html Cycles:180 Average:4812.11 Median:5827.12 stddev:2688.98 (46.1%) stddev-sans-first:2682.86 21:37:21 INFO - PROCESS | 31586 | Values: 1204.5 1336.7 1370.5 1421.4 1650.7 6341.2 7179.0 7422.1 7436.9 7622.1 7445.4 7489.9 7505.2 7505.5 7510.9 1946.2 1959.1 1962.4 1962.8 1970.4 1889.4 1923.3 1925.9 1930.7 1937.5 1924.6 1934.1 1935.4 1938.1 1939.9 1876.1 1911.0 1916.9 1917.6 1919.3 1840.4 1860.5 1865.0 1881.8 1890.3 7199.9 7353.4 7428.0 7489.2 7607.3 4352.1 4535.9 4539.5 4553.6 4581.7 2746.4 2847.9 2899.0 2917.6 2924.9 889.3 899.3 900.4 903.6 912.3 9587.6 9779.5 9805.5 9826.3 9830.4 3790.9 3961.3 4010.4 4097.1 4111.8 8456.6 8460.6 8465.0 8471.2 8473.9 4426.1 4426.2 4426.7 4427.3 4434.7 3486.8 3591.2 4076.9 4079.0 4080.7 3243.3 3332.2 3449.0 3528.5 3542.8 1109.7 1142.3 1147.1 1147.9 1148.6 701.9 710.4 722.7 741.2 753.5 4848.3 4897.3 4985.0 5064.7 5117.7 813.7 822.8 844.8 847.7 857.4 3465.5 3477.1 3515.4 3538.6 3601.9 8519.1 8974.4 8983.7 9006.6 9013.2 8772.8 8954.8 9005.5 9046.3 9087.4 6879.0 6958.4 6959.0 6960.0 6965.3 4686.7 4790.7 4941.6 4990.1 5131.8 8258.8 8308.7 8358.7 8416.5 8423.4 8332.4 8430.5 8439.0 8472.9 8570.0 6558.9 6610.1 6615.3 6623.7 6634.3 6677.1 6746.1 6788.8 6797.7 6815.8 6002.3 6036.2 6061.4 6154.2 6182.6 6175.8 6251.9 6272.3 6283.2 6394.2 5822.8 5831.4 5836.6 5878.4 5898.5 4248.5 4338.2 4395.5 4459.8 4472.4 4148.0 4156.1 4180.3 4277.5 4332.6 21:37:21 INFO - PROCESS | 31586 | 21:37:21 INFO - PROCESS | 31586 | [#4] prototype.html Cycles:180 Average:4004.06 Median:4480.63 stddev:1178.71 (26.3%) stddev-sans-first:1147.95 21:37:21 INFO - PROCESS | 31586 | Values: 256.1 279.4 282.7 287.4 293.3 4495.7 4535.5 4638.2 4733.7 4792.3 4723.6 4724.8 4753.4 4772.2 4773.6 3506.5 3672.2 3684.6 3694.9 3706.8 3470.4 3572.7 3586.6 3691.0 3698.1 3631.4 3654.7 3657.4 3660.8 3671.4 3647.5 3669.2 3671.3 3672.8 3675.3 3214.3 3215.2 3222.9 3228.5 3241.6 4374.6 4610.0 4613.5 4613.9 4623.6 4115.7 4119.6 4119.8 4132.9 4157.3 4909.4 4911.7 4927.2 4934.1 4940.3 3272.6 3453.4 3482.7 3493.7 3493.7 5120.0 5153.1 5163.7 5168.7 5173.5 3567.6 3567.6 3570.7 3575.2 3578.3 3629.7 3637.4 3646.6 3652.6 3657.6 3943.8 4084.9 4130.4 4142.3 4174.9 4900.4 4903.1 4906.8 4918.9 4922.7 1251.0 1255.4 1259.3 1260.5 1262.0 733.7 776.1 790.5 792.1 799.2 3871.9 3872.0 3885.4 3920.1 3953.5 4460.2 4487.6 4535.8 4545.9 4549.7 3878.9 3918.5 3931.5 3948.5 3969.5 2328.2 2416.8 2421.7 2432.9 2433.9 4161.5 4323.1 4323.7 4347.8 4354.0 4509.3 4528.3 4544.8 4569.6 4572.9 4240.5 4250.8 4261.0 4473.7 4807.4 5072.2 5094.5 5094.9 5097.6 5098.8 4763.9 4904.3 4984.9 5001.2 5022.8 4644.8 4784.0 4786.7 4794.7 4805.8 3555.5 3598.8 3607.4 3640.9 3647.8 4858.8 5035.9 5097.6 5131.3 5132.0 4925.9 4944.9 4956.3 4969.2 4972.6 4971.0 4971.9 4977.6 5009.2 5026.5 4759.7 4853.0 4913.9 4928.2 4941.6 4999.4 5002.3 5011.8 5019.0 5023.8 4854.5 4877.8 4907.4 4946.3 4949.9 21:37:21 INFO - PROCESS | 31586 | 21:37:21 INFO - PROCESS | 31586 | [#5] yui.html Cycles:180 Average:17074.07 Median:516.42 stddev:25093.25 (4859.0%) stddev-sans-first:25133.12 21:37:21 INFO - PROCESS | 31586 | Values: 589.8 660.6 667.7 713.7 724.5 12884.5 13911.2 13924.8 13927.9 13929.4 11912.9 11956.2 11988.6 11988.9 12063.4 607.5 623.9 736.3 751.4 764.7 766.9 771.9 773.3 773.5 776.9 805.5 805.8 808.2 809.2 809.7 633.7 650.2 652.4 653.5 796.6 485.2 560.7 578.7 581.5 582.5 12044.2 12079.5 12100.0 12102.4 12145.2 11648.8 11955.6 12070.9 12389.4 12769.2 10135.3 10301.1 11014.6 11047.8 11284.5 4088.1 4144.1 4170.7 4223.8 4339.4 48209.5 50347.7 50484.7 58243.1 58307.1 9817.5 9994.6 10010.1 10057.0 10232.6 16226.5 16230.3 16237.5 16257.6 16266.4 6447.9 6499.8 6500.4 6544.4 6711.9 3535.2 3568.1 3581.7 3635.0 3678.4 2910.4 3007.4 3023.3 3027.3 3028.0 503.5 505.0 506.1 507.9 517.6 550.4 566.8 569.5 582.7 585.9 7372.0 7536.0 7585.5 7715.8 8341.8 482.7 507.9 515.2 570.7 572.0 3672.7 3848.6 4274.1 4393.7 4395.2 94391.1 95596.5 98446.0 98803.5 101273.5 82652.2 84268.2 85332.6 85914.6 90582.0 77974.6 78249.6 78605.2 79094.6 80159.6 8053.8 8108.9 8177.9 8446.6 8697.0 30847.0 31244.7 41536.0 43086.8 43908.0 42141.2 55825.4 59230.4 66236.7 67913.7 9663.2 9714.8 9724.4 9837.9 9895.6 12402.4 12442.7 12985.2 13023.9 13077.7 11076.6 11467.8 11469.5 11515.9 11675.6 10002.8 10255.6 10270.2 10409.6 10724.4 10349.8 10625.6 10695.8 10709.3 10991.1 8108.9 8367.1 8521.1 8635.3 8876.4 8618.3 8846.7 9316.9 9479.5 9497.3 21:37:21 INFO - PROCESS | 31586 | -------- Summary: end -------- 21:37:21 INFO - PROCESS | 31586 | 21:37:22 INFO - TEST-INFO | 31586: exit 0 21:37:22 INFO - TEST-OK | dromaeo_css | took 1122246ms 21:37:22 INFO - TEST-START | kraken 21:37:22 INFO - operating with platform_type : linux_ 21:37:22 INFO - Initialising browser for kraken test... 21:37:22 INFO - TEST-INFO | started process 31893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpualph_/profile http://localhost:39306/getInfo.html) 21:37:27 INFO - PROCESS | 31893 | __metrics Screen width/height:1600/1200 21:37:27 INFO - PROCESS | 31893 | colorDepth:24 21:37:27 INFO - PROCESS | 31893 | Browser inner width/height: 1024/697 21:37:27 INFO - PROCESS | 31893 | __metrics 21:37:27 INFO - PROCESS | 31893 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:37:27 INFO - PROCESS | 31893 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:37:28 INFO - PROCESS | 31893 | console.error: PushService: 21:37:28 INFO - PROCESS | 31893 | stateChangeProcessEnqueue: Error transitioning state 21:37:28 INFO - PROCESS | 31893 | UnknownError 21:37:28 INFO - TEST-INFO | 31893: exit 0 21:37:28 INFO - Browser initialized. 21:37:28 INFO - Running cycle 1/1 for kraken test... 21:37:28 INFO - TEST-INFO | started process 31976 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpualph_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:37:41 INFO - PROCESS | 31976 | RSS: Main: 174948352 21:37:41 INFO - PROCESS | 31976 | 21:37:43 INFO - PROCESS | 31976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39306/tests/kraken/driver.html?testName=audio-beat-detection) 21:37:44 INFO - PROCESS | 31976 | RSS: Main: 234250240 21:37:44 INFO - PROCESS | 31976 | 21:37:47 INFO - PROCESS | 31976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39306/tests/kraken/driver.html?testName=audio-dft) 21:37:48 INFO - PROCESS | 31976 | RSS: Main: 218468352 21:37:48 INFO - PROCESS | 31976 | 21:37:51 INFO - PROCESS | 31976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39306/tests/kraken/driver.html?testName=audio-fft) 21:37:52 INFO - PROCESS | 31976 | RSS: Main: 300421120 21:37:52 INFO - PROCESS | 31976 | 21:37:54 INFO - PROCESS | 31976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39306/tests/kraken/driver.html?testName=audio-oscillator) 21:37:54 INFO - PROCESS | 31976 | RSS: Main: 211816448 21:37:54 INFO - PROCESS | 31976 | 21:37:57 INFO - PROCESS | 31976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39306/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:37:57 INFO - PROCESS | 31976 | RSS: Main: 214421504 21:37:57 INFO - PROCESS | 31976 | 21:38:00 INFO - PROCESS | 31976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39306/tests/kraken/driver.html?testName=imaging-darkroom) 21:38:01 INFO - PROCESS | 31976 | RSS: Main: 250769408 21:38:01 INFO - PROCESS | 31976 | 21:38:05 INFO - PROCESS | 31976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39306/tests/kraken/driver.html?testName=imaging-desaturate) 21:38:05 INFO - PROCESS | 31976 | RSS: Main: 249901056 21:38:05 INFO - PROCESS | 31976 | 21:38:08 INFO - PROCESS | 31976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39306/tests/kraken/driver.html?testName=json-parse-financial) 21:38:09 INFO - PROCESS | 31976 | RSS: Main: 249712640 21:38:09 INFO - PROCESS | 31976 | 21:38:10 INFO - PROCESS | 31976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39306/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:38:11 INFO - PROCESS | 31976 | RSS: Main: 212008960 21:38:11 INFO - PROCESS | 31976 | 21:38:13 INFO - PROCESS | 31976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39306/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:38:13 INFO - PROCESS | 31976 | RSS: Main: 219578368 21:38:13 INFO - PROCESS | 31976 | 21:38:16 INFO - PROCESS | 31976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39306/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:38:16 INFO - PROCESS | 31976 | RSS: Main: 228618240 21:38:16 INFO - PROCESS | 31976 | 21:38:19 INFO - PROCESS | 31976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:38:20 INFO - PROCESS | 31976 | RSS: Main: 236937216 21:38:20 INFO - PROCESS | 31976 | 21:38:23 INFO - PROCESS | 31976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:38:24 INFO - PROCESS | 31976 | RSS: Main: 233746432 21:38:24 INFO - PROCESS | 31976 | 21:38:25 INFO - PROCESS | 31976 | Cycle 1(1): loaded http://localhost:39306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39306/tests/kraken/driver.html?testName=ai-astar) 21:38:26 INFO - PROCESS | 31976 | RSS: Main: 283865088 21:38:26 INFO - PROCESS | 31976 | 21:38:26 INFO - PROCESS | 31976 | __start_tp_report 21:38:26 INFO - PROCESS | 31976 | _x_x_mozilla_page_load 21:38:26 INFO - PROCESS | 31976 | _x_x_mozilla_page_load_details 21:38:26 INFO - PROCESS | 31976 | |i|pagename|runs| 21:38:26 INFO - PROCESS | 31976 | |0;ai-astar;109;113;113;114;113;112;114;113;113;113 21:38:26 INFO - PROCESS | 31976 | |1;audio-beat-detection;159;131;126;180;131;128;127;129;160;134 21:38:26 INFO - PROCESS | 31976 | |2;audio-dft;163;162;163;163;164;160;164;163;162;162 21:38:26 INFO - PROCESS | 31976 | |3;audio-fft;76;75;77;114;76;76;77;76;102;76 21:38:26 INFO - PROCESS | 31976 | |4;audio-oscillator;84;83;118;83;83;84;114;84;83;118 21:38:26 INFO - PROCESS | 31976 | |5;imaging-gaussian-blur;117;117;117;118;117;118;117;117;117;117 21:38:26 INFO - PROCESS | 31976 | |6;imaging-darkroom;146;145;146;147;146;146;146;146;146;146 21:38:26 INFO - PROCESS | 31976 | |7;imaging-desaturate;96;95;96;96;95;95;96;96;96;96 21:38:26 INFO - PROCESS | 31976 | |8;json-parse-financial;64;62;62;64;64;64;65;65;63;63 21:38:26 INFO - PROCESS | 31976 | |9;json-stringify-tinderbox;66;67;66;66;68;66;66;67;68;68 21:38:26 INFO - PROCESS | 31976 | |10;stanford-crypto-aes;83;93;86;82;92;83;83;92;83;83 21:38:26 INFO - PROCESS | 31976 | |11;stanford-crypto-ccm;156;141;137;140;138;140;138;142;183;154 21:38:26 INFO - PROCESS | 31976 | |12;stanford-crypto-pbkdf2;177;173;176;175;178;176;179;179;174;176 21:38:26 INFO - PROCESS | 31976 | |13;stanford-crypto-sha256-iterative;80;70;70;70;70;71;72;70;71;69 21:38:26 INFO - PROCESS | 31976 | __end_tp_report 21:38:26 INFO - PROCESS | 31976 | __start_cc_report 21:38:26 INFO - PROCESS | 31976 | _x_x_mozilla_cycle_collect,1933 21:38:26 INFO - PROCESS | 31976 | __end_cc_report 21:38:26 INFO - PROCESS | 31976 | __startTimestamp1475815106082__endTimestamp 21:38:26 INFO - PROCESS | 31976 | 21:38:26 INFO - PROCESS | 31976 | ------- Summary: start ------- 21:38:26 INFO - PROCESS | 31976 | Number of tests: 14 21:38:26 INFO - PROCESS | 31976 | 21:38:26 INFO - PROCESS | 31976 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:1.42 (1.3%) stddev-sans-first:0.60 21:38:26 INFO - PROCESS | 31976 | Values: 109.0 113.0 113.0 114.0 113.0 112.0 114.0 113.0 113.0 113.0 21:38:26 INFO - PROCESS | 31976 | 21:38:26 INFO - PROCESS | 31976 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:132.50 stddev:18.82 (14.2%) stddev-sans-first:18.73 21:38:26 INFO - PROCESS | 31976 | Values: 159.0 131.0 126.0 180.0 131.0 128.0 127.0 129.0 160.0 134.0 21:38:26 INFO - PROCESS | 31976 | 21:38:26 INFO - PROCESS | 31976 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 21:38:26 INFO - PROCESS | 31976 | Values: 163.0 162.0 163.0 163.0 164.0 160.0 164.0 163.0 162.0 162.0 21:38:26 INFO - PROCESS | 31976 | 21:38:26 INFO - PROCESS | 31976 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:13.75 (18.1%) stddev-sans-first:14.38 21:38:26 INFO - PROCESS | 31976 | Values: 76.0 75.0 77.0 114.0 76.0 76.0 77.0 76.0 102.0 76.0 21:38:26 INFO - PROCESS | 31976 | 21:38:26 INFO - PROCESS | 31976 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:83.00 stddev:16.10 (19.4%) stddev-sans-first:16.71 21:38:26 INFO - PROCESS | 31976 | Values: 84.0 83.0 118.0 83.0 83.0 84.0 114.0 84.0 83.0 118.0 21:38:26 INFO - PROCESS | 31976 | 21:38:26 INFO - PROCESS | 31976 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:38:26 INFO - PROCESS | 31976 | Values: 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 21:38:26 INFO - PROCESS | 31976 | 21:38:26 INFO - PROCESS | 31976 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 21:38:26 INFO - PROCESS | 31976 | Values: 146.0 145.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 21:38:26 INFO - PROCESS | 31976 | 21:38:26 INFO - PROCESS | 31976 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 21:38:26 INFO - PROCESS | 31976 | Values: 96.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 21:38:26 INFO - PROCESS | 31976 | 21:38:26 INFO - PROCESS | 31976 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.00 stddev:1.07 (1.7%) stddev-sans-first:1.13 21:38:26 INFO - PROCESS | 31976 | Values: 64.0 62.0 62.0 64.0 64.0 64.0 65.0 65.0 63.0 63.0 21:38:26 INFO - PROCESS | 31976 | 21:38:26 INFO - PROCESS | 31976 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 21:38:26 INFO - PROCESS | 31976 | Values: 66.0 67.0 66.0 66.0 68.0 66.0 66.0 67.0 68.0 68.0 21:38:26 INFO - PROCESS | 31976 | 21:38:26 INFO - PROCESS | 31976 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:84.50 stddev:4.50 (5.3%) stddev-sans-first:4.64 21:38:26 INFO - PROCESS | 31976 | Values: 83.0 93.0 86.0 82.0 92.0 83.0 83.0 92.0 83.0 83.0 21:38:26 INFO - PROCESS | 31976 | 21:38:26 INFO - PROCESS | 31976 | [#11] stanford-crypto-ccm Cycles:10 Average:146.90 Median:141.50 stddev:14.33 (10.1%) stddev-sans-first:14.81 21:38:26 INFO - PROCESS | 31976 | Values: 156.0 141.0 137.0 140.0 138.0 140.0 138.0 142.0 183.0 154.0 21:38:26 INFO - PROCESS | 31976 | 21:38:26 INFO - PROCESS | 31976 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:176.50 stddev:2.00 (1.1%) stddev-sans-first:2.11 21:38:26 INFO - PROCESS | 31976 | Values: 177.0 173.0 176.0 175.0 178.0 176.0 179.0 179.0 174.0 176.0 21:38:26 INFO - PROCESS | 31976 | 21:38:26 INFO - PROCESS | 31976 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:70.50 stddev:3.16 (4.5%) stddev-sans-first:0.87 21:38:26 INFO - PROCESS | 31976 | Values: 80.0 70.0 70.0 70.0 70.0 71.0 72.0 70.0 71.0 69.0 21:38:26 INFO - PROCESS | 31976 | -------- Summary: end -------- 21:38:26 INFO - PROCESS | 31976 | 21:38:27 INFO - TEST-INFO | 31976: exit 0 21:38:27 INFO - TEST-OK | kraken | took 65039ms 21:38:27 INFO - SUITE-END | took 1187s 21:38:27 INFO - Completed test suite (00:19:47) 21:38:27 INFO - javascript benchmark 21:38:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2551.93620159496, 2572.9871350643243, 2597.7012643546, 2605.570080936645, 2617.698964619068, 4539.59143677069, 4618.4688760792515, 4622.768861556926, 4628.166929952616, 4628.190066738324, 4616.469106052805, 4626.167289887819, 4649.0, 4652.906941861169, 4664.230401983668, 4276.764777937212, 4297.935530967038, 4319.136172765444, 4331.6534677225745, 4343.174796788616, 4263.872083837475, 4293.957060429387, 4315.352697095429, 4325.091730736549, 4343.9565604344025, 4238.046439551092, 4242.766647834368, 4255.468066491689, 4288.571142885718, 4401.185780630578, 4293.205756934945, 4294.592013758688, 4295.78521073945, 4312.310030395153, 4321.351797230409, 4103.261412945669, 4146.606072423115, 4197.18154959783, 4216.430781844442, 4273.401723758645, 4567.817287308537, 4575.9771201143785, 4579.702319349231, 4580.540169306808, 4666.9766651166865, 4900.0, 4900.26496025599, 4923.975380123076, 4927.975360123212, 4952.727599981999, 4804.25534042224, 4861.440934292566, 4868.269759536098, 4921.507849215086, 4933.629977751647, 4634.119517291704, 4639.443266808004, 4644.512326205768, 4673.649476289292, 4692.202325604655, 5055.823046193365, 5072.087024335581, 5072.67027643202, 5074.06129865976, 5129.820456284012, 4684.5549672781035, 4737.478877323491, 4861.149298872683, 4864.708117512961, 4929.359183306147, 4829.9275510867365, 4875.024995001014, 4883.169861123618, 4886.511348865085, 4951.480094590088, 4820.758962051884, 4826.782794774173, 4831.565159135695, 4832.830850920201, 4889.682170658896, 4788.928166077511, 4801.18379875422, 4802.759862006886, 4805.951940480621, 4861.0277944411255, 3978.781167035841, 4013.6387725104883, 4013.6989725770686, 4013.9598604013586, 4065.0, 3589.8743543975834, 3602.225521512887, 3646.033801042726, 3647.6170002149925, 3664.780113193217, 4147.792610369469, 4171.749695018309, 4185.497740271126, 4235.131797981407, 4240.215560121387, 4759.690620109682, 4802.135615589227, 4821.686590371614, 4858.8785280367565, 4919.581835543947, 4161.958380416218, 4176.916461670749, 4184.497860256789, 4229.0, 4230.598093181143, 4381.693281470267, 4387.166438376762, 4388.451443569554, 4431.711938724037, 4436.866893993185, 4525.049739554599, 4570.085982803386, 4612.469565999953, 4618.769061546976, 4670.929936050894, 4853.80584776605, 4904.435989861212, 4907.828226012072, 4908.680935739166, 4943.283223932438, 4604.608608268335, 4606.769661516978, 4615.076984603025, 4624.884377890579, 4676.719396836201, 4693.2021556336185, 4831.396075490564, 4840.709557426566, 4840.951590484191, 4896.534829191221, 4779.259214821708, 4874.049560335842, 4913.48408417111, 4942.925856112233, 4993.226049962262, 4793.664443488922, 4801.855944321676, 4802.591779698625, 4802.615790736802, 4863.659543832039, 4786.976065119652, 4805.879853003703, 4806.975965120152, 4807.95192048089, 4868.391451068616, 4631.51369106239, 4664.253719405015, 4679.953200468088, 4746.121967436035, 4757.5718185363485, 4837.903241935212, 4842.588379987599, 4846.5153484652665, 4890.877728056827, 4900.460949295503, 4550.385697930869, 4610.815567377267, 4725.8582242532775, 4742.264948932921, 4762.714237145782], "value": 4507.1279239967835, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.4375337156101, 571.3429556010587, 582.1239035251945, 587.1955421073128, 588.838069530879, 26427.339316517096, 36570.0, 37573.81213093934, 37588.81205593975, 42046.57953420465, 39397.60602393975, 39793.80103099488, 39864.0, 39909.800450997776, 39929.8003509982, 7581.924180758177, 7745.457817952745, 7753.612319384037, 7755.573443460607, 7757.418193635472, 7452.254774522531, 7539.924600753977, 7551.093868735759, 7551.358134558569, 7551.660175292125, 7536.924630753704, 7564.735234266802, 7577.16651168371, 7582.620868956557, 7583.62081895903, 7507.1742108368035, 7546.471746977713, 7550.056242969629, 7560.168381478033, 7562.546247225184, 7582.090149182079, 7630.580318082503, 7644.694212231504, 7645.3119219269975, 7645.617719114078, 37375.25249494995, 37702.81148594267, 37737.622623773685, 37755.433668494996, 37767.0, 2813.3529288263608, 3084.4602194616077, 3191.0426871938325, 3356.5133055706788, 3553.662402071799, 27622.585661215096, 27877.820720608404, 28013.719862801314, 28070.157895263175, 28930.55347232651, 3413.5562376891094, 3452.171478845084, 3493.196564790087, 3493.2664140530264, 3550.130218096557, 245447.0, 247073.0, 247592.0, 247638.76180619161, 248158.0, 49406.0, 49753.751231243616, 49759.25361119586, 49839.50160498349, 49851.50148498541, 31762.205944851103, 32399.352012959607, 32533.0, 52283.21575176375, 52505.2124218137, 14817.851821481863, 15058.32237549313, 15148.848511514963, 15175.089494630358, 15199.088054716753, 11574.18980671345, 11660.76678466426, 11685.591004314809, 11686.70783230409, 11693.298402095901, 17265.741013884803, 17328.913355433142, 17337.35295146959, 17389.217485213198, 17532.0, 6667.799286449505, 6701.0, 6794.966025169842, 6902.413294869993, 6944.18760402038, 792.3581898662102, 886.6054605700531, 921.4793641592479, 929.6699671616614, 978.5400861595039, 25893.0, 26883.596746048825, 27193.592096118573, 27369.589456158174, 27585.0, 786.9213078692085, 942.58997336159, 956.4596003258137, 963.2246041936309, 1043.2801367056707, 13020.934895325652, 14383.352749126314, 14460.85539144616, 14527.709445811024, 14634.926825365805, 353826.0, 406245.0, 411783.0, 414144.0, 656643.0, 49712.50287497151, 50123.498765011886, 50200.0, 50229.49770502321, 50262.24606630903, 1067.0929709746654, 1124.6288724720823, 1149.270213414488, 1150.4305368842477, 1199.142613031669, 24484.0, 28339.57490637601, 28892.85553572219, 29271.85364073166, 29280.560791587715, 39735.60264397319, 40378.0, 40394.79802600968, 40406.39390409087, 40417.59582404138, 290694.0, 291303.0, 292657.0, 292704.0, 293840.0, 22097.779022209572, 22635.773642263368, 22737.658935115654, 22765.430864228525, 25137.74862251427, 39991.80004099961, 40208.0, 40490.59509404868, 40686.0, 40725.0, 35076.47385289274, 35148.0, 35460.64539354573, 35598.64401355953, 35652.0, 35349.82325088358, 35572.82213588915, 35633.0, 35650.0, 35875.64124358723, 34355.65644343525, 34617.134571635914, 34649.0, 35160.64839351574, 35458.645413545535, 29472.410551788416, 32094.679053210104, 32313.838430807697, 32566.0, 32767.0, 24630.753692462848, 24837.379065523506, 24847.25458236256, 24873.0, 25350.366240844127], "value": 17065.09118284606, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.75271052131944, 340.62531215662756, 369.4790345612686, 370.712697659314, 383.7122158381214, 12237.816432753516, 13228.817245154562, 13585.0, 14942.25288735563, 17206.39777607784, 15611.141387223699, 15637.452689155882, 16116.516504504854, 16645.83354166458, 16959.91520042398, 4849.321095046696, 4987.600991920646, 4995.875103122433, 5031.32077169581, 5032.270320803481, 3575.3564358415474, 3774.433834924756, 5035.269885866547, 5079.492050794928, 5087.5421212090905, 5667.518260947824, 5945.583809133363, 5967.731452084667, 6071.3625069367745, 6072.666003369813, 5800.8259752207505, 5958.880822383571, 5980.880382392371, 6037.0340745480735, 6052.485538729214, 5309.681419114827, 5312.60155488336, 5324.600654950894, 5324.946750532523, 5349.652272602269, 19712.90143549273, 20030.79969200304, 20217.393478195678, 20232.0, 20455.386338409873, 1892.9716054259197, 2015.8084981926693, 2064.4735592423986, 2219.955600887973, 2291.4271432141963, 12212.511499540007, 13125.868741312655, 13316.733665326736, 13616.591502254949, 13741.793873091912, 1639.7048531264368, 1715.3738885306898, 1728.4555365059966, 1753.7018706819872, 1805.747195392646, 63069.0, 63600.0, 65111.348886511005, 67372.32627673709, 67816.0, 8750.34372422071, 8790.648374065093, 8910.108989101038, 9644.373115747454, 9790.853137202948, 13208.471661133448, 13209.801852972214, 13215.933920330337, 13245.867541324656, 13254.469821207236, 7179.138503379628, 7222.422206223489, 7360.595167265852, 7489.063867016623, 7572.507786993828, 7363.263673632594, 7495.287947644965, 7562.810929726691, 7620.0, 7667.386609071261, 5847.590668653239, 5853.756026880563, 5874.470391171493, 5975.342712301644, 6057.697115144225, 1693.6289195126922, 1733.5839398544258, 1740.825917408249, 1749.6238308763423, 1775.6271183051444, 825.9587020648944, 826.3513142183357, 866.0949307973183, 890.550272112579, 947.8151760406655, 15473.071615703095, 16703.248353824107, 17139.74290385645, 17649.7352539712, 17739.0, 841.8021764885247, 857.7083791510917, 875.0899064972484, 881.2553392383426, 924.505389616552, 9592.760180995392, 10105.9494702526, 10159.796804063877, 10201.693949181536, 10233.9488302558, 369121.0, 380327.0, 380519.0, 382441.0, 383944.0, 64447.0, 64887.48456381166, 67261.0, 67620.32379676239, 67632.0, 921.7373048681228, 922.1700469577434, 923.607466826596, 927.4528028463104, 942.3121121581147, 14908.627284317545, 15143.924280378527, 15262.465813696468, 15718.292676829342, 15888.920555397612, 32714.672853272114, 34446.31107377889, 34878.0, 35091.29817403587, 35791.0, 44294.0, 44505.10989780251, 44653.330200047676, 44896.87757806081, 45102.54897450984, 6409.0838668406695, 6686.398224159849, 6726.596404215763, 6855.828604284933, 7209.531380460253, 10775.0, 11192.160587955774, 11532.423378830857, 11588.420578970849, 12141.817872732092, 10038.899611004088, 10178.949105254427, 10370.948145259226, 10524.684259472227, 10894.78210435771, 9624.470654114091, 9920.702378928356, 9925.702228933143, 9977.60089596408, 10346.0, 10436.16510679159, 10458.372497650165, 10474.581016759244, 10526.736831579272, 10746.62386816489, 6807.489438292049, 6841.657917104224, 6973.930260697328, 7037.8944315836325, 7169.318914703095, 9579.712608621752, 9656.95171524138, 9899.901000990187, 10036.799264014824, 10290.279680422298], "value": 8157.08055940858, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1204.45197435167, 1336.6858788184777, 1370.4723681382668, 1421.3603878254787, 1650.6863695897778, 6341.239051313843, 7179.0, 7422.146453157889, 7436.851262974744, 7622.085349758023, 7445.404367650589, 7489.850202995937, 7505.174430812606, 7505.5121417107985, 7510.887336689941, 1946.182603306611, 1959.0694420150385, 1962.3818497173345, 1962.7546556680416, 1970.3596331192348, 1889.3576184097403, 1923.2883832981815, 1925.913333899971, 1930.6717857964109, 1937.4671965209538, 1924.5573518090848, 1934.139308007937, 1935.4000259919399, 1938.108470103754, 1939.8933058681766, 1876.0713446843831, 1911.0, 1916.9137388817467, 1917.6452356314126, 1919.29945569866, 1840.429466865276, 1860.48836569943, 1865.0488250991957, 1881.8494520438333, 1890.3478299986482, 7199.9280007200305, 7353.411727061823, 7428.0, 7489.176190619028, 7607.315341619225, 4352.086061926999, 4535.863924082283, 4539.52335004823, 4553.590176884063, 4581.748003859786, 2746.436980419029, 2847.9288017799513, 2898.971010289891, 2917.6061231733656, 2924.926876828075, 889.3241136736062, 899.2940541674753, 900.3877363392891, 903.6204793986476, 912.338554547954, 9587.568559414844, 9779.46212958287, 9805.460699661517, 9826.312158148932, 9830.4101753895, 3790.886273411802, 3961.267165574378, 4010.3583426651594, 4097.098638299629, 4111.7944102794745, 8456.619452124545, 8460.619272132768, 8464.957675211585, 8471.152884711479, 8473.872891906627, 4426.092651006536, 4426.22541055314, 4426.734395936254, 4427.335899615084, 4434.733915965053, 3486.8082255475683, 3591.2099338145567, 4076.8776936691947, 4078.9592104079175, 4080.6939479539155, 3243.3351163012, 3332.1836150142885, 3448.9655103448645, 3528.5412896323314, 3542.8051457169586, 1109.6615532262576, 1142.3203194099497, 1147.0651419093413, 1147.908167346627, 1148.6108893501496, 701.8876979683226, 710.3784188834769, 722.6856317501904, 741.1995045351008, 753.4876284126847, 4848.296996935424, 4897.314375987365, 4985.0, 5064.7214403207445, 5117.74411279442, 813.7111325479488, 822.7778499805019, 844.7972486603294, 847.7287268074281, 857.3955361470148, 3465.54947856777, 3477.078574177845, 3515.43752999524, 3538.6284440133413, 3601.85592576294, 8519.105493923173, 8974.37179397449, 8983.730488085368, 9006.59470323837, 9013.233875120688, 8772.824543509094, 8954.776130596787, 9005.459672419676, 9046.276297896153, 9087.36388452802, 6879.0, 6958.443324534025, 6959.0, 6960.0, 6965.268646792115, 4686.671932964796, 4790.712557246577, 4941.629377796751, 4990.134618746693, 5131.79472821083, 8258.752237432887, 8308.70919517814, 8358.707445239388, 8416.4950102994, 8423.368247381348, 8332.375071869756, 8430.45202061864, 8439.0, 8472.872906906525, 8569.957150214459, 6558.901616475852, 6610.10763546915, 6615.272320044695, 6623.701933413105, 6634.303398143318, 6677.098591690254, 6746.123004009447, 6788.76239331621, 6797.694103765243, 6815.795526134224, 6002.33974262822, 6036.185115009417, 6061.39386061408, 6154.230721159855, 6182.598131121463, 6175.84560385994, 6251.937480625135, 6272.341404152498, 6283.2460104787715, 6394.200724909387, 5822.796202132905, 5831.446012628793, 5836.591438599257, 5878.412158784087, 5898.528117750656, 4248.490181178155, 4338.240807858675, 4395.494518130456, 4459.777011149495, 4472.39622650951, 4147.97926010368, 4156.06488540076, 4180.268453020648, 4277.545634484166, 4332.6317263033], "value": 3868.142449177267, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [256.0896014667855, 279.3742017879948, 282.7031616802358, 287.4237154505217, 293.2580571154979, 4495.730256184631, 4535.501094879564, 4638.211504044312, 4733.668643194977, 4792.305115758213, 4723.598494127995, 4724.787384567694, 4753.382060332161, 4772.164871147553, 4773.57037866592, 3506.5266189064405, 3672.173760903802, 3684.5762737285154, 3694.8915325402404, 3706.7759344393417, 3470.410030294843, 3572.7141828653644, 3586.55168103987, 3691.0, 3698.093966978094, 3631.400818864884, 3654.7441679082476, 3657.4397921454956, 3660.798656073915, 3671.3942199537046, 3647.544056992876, 3669.174435751961, 3671.284099600579, 3672.7612705174347, 3675.3016926783826, 3214.3089235814414, 3215.1640573451073, 3222.8871989480253, 3228.5480032795426, 3241.578594782663, 4374.58441448062, 4609.976950115261, 4613.492515823256, 4613.869601947545, 4623.606993405565, 4115.670746340285, 4119.608637179464, 4119.814608342602, 4132.876013719593, 4157.272477316487, 4909.435414927258, 4911.68074075184, 4927.1870141426625, 4934.111859865223, 4940.308356830046, 3272.5582046423665, 3453.3611281912677, 3482.7387945903906, 3493.7205023598303, 3493.737969652286, 5120.001599688062, 5153.149730294497, 5163.690178589259, 5168.664036837594, 5173.499685091319, 3567.554055743032, 3567.625399333033, 3570.696490798311, 3575.249197668467, 3578.284343131384, 3629.6551827576336, 3637.381645120336, 3646.5624125104628, 3652.593751405675, 3657.6159503251774, 3943.842246310173, 4084.917496863334, 4130.359794231899, 4142.316517774533, 4174.874753757392, 4900.436449808247, 4903.141950158708, 4906.846890980617, 4918.926216106761, 4922.704637721677, 1250.9874901251053, 1255.409957320058, 1259.2885019963874, 1260.5147018397984, 1261.9621411357673, 733.7395224695263, 776.0997243197863, 790.4506368074249, 792.1247022040562, 799.1788984883372, 3871.922561548753, 3871.9806400968378, 3885.3977633466857, 3920.0591857954455, 3953.466282051944, 4460.219461594273, 4487.5961163494785, 4535.841245556389, 4545.886352841139, 4549.7042692224895, 3878.9030274242805, 3918.529776426847, 3931.486377744589, 3948.545917219499, 3969.523657161159, 2328.2189125319146, 2416.842905211191, 2421.7093948726265, 2432.8905199266073, 2433.9026438942597, 4161.542230354658, 4323.0705398339505, 4323.740575565476, 4347.826086956549, 4354.040681693187, 4509.2559727644575, 4528.320751887243, 4544.772761361919, 4569.611583015414, 4572.90250339916, 4240.533541310453, 4250.808713607895, 4261.0, 4473.664475164375, 4807.351007613927, 5072.239164125411, 5094.5160209780015, 5094.949050509447, 5097.566706829961, 5098.770555324945, 4763.857084287339, 4904.288878112725, 4984.900301993867, 5001.24981252815, 5022.844745708435, 4644.767761611838, 4783.95216047835, 4786.688865223749, 4794.736289504111, 4805.783739731791, 3555.5377800885717, 3598.820058997092, 3607.4228123500116, 3640.872569460056, 3647.7811331320204, 4858.805647774191, 5035.874103147451, 5097.566706829961, 5131.255967884561, 5131.974340128276, 4925.852224433273, 4944.851654450372, 4956.281339205723, 4969.155243608523, 4972.577330926912, 4971.036440606013, 4971.925421118758, 4977.576905963034, 5009.198528235464, 5026.472220416804, 4759.6668233223345, 4853.0, 4913.877153071202, 4928.162212423968, 4941.555260026615, 4999.375078115236, 5002.349694539686, 5011.799528018839, 5019.0, 5023.824166154167, 4854.466008738966, 4877.756112194447, 4907.4111106666, 4946.307516947702, 4949.925751113664], "value": 3626.148953918877, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.7632535932513, 660.5805313625849, 667.7262322447791, 713.7430525010996, 724.5326764237067, 12884.484620615176, 13911.165330080203, 13924.791128133085, 13927.860721392795, 13929.442822287108, 11912.940435297833, 11956.222845515058, 11988.64034078979, 11988.880111198885, 12063.396830158501, 607.501848484243, 623.8721062182242, 736.2821249281934, 751.4138971602159, 764.7285213749122, 766.877299632059, 771.8919351290824, 773.2538100732792, 773.5474747272852, 776.9184235655259, 805.4885147931047, 805.8307755371379, 808.2119933065273, 809.2352726673296, 809.7287408718057, 633.6894921488483, 650.2262307853687, 652.4095693397483, 653.493542504558, 796.6295672512281, 485.24786580799974, 560.6664034899228, 578.6759414727766, 581.4505292498591, 582.4554041970771, 12044.156909016372, 12079.516819327217, 12100.0, 12102.394880255952, 12145.210561313486, 11648.825267620992, 11955.64133076009, 12070.939645301805, 12389.380530973416, 12769.170003949714, 10135.341202821794, 10301.124404425633, 11014.614488492944, 11047.779044419147, 11284.548618055267, 4088.1414902870433, 4144.129732756125, 4170.6871984600975, 4223.809928553223, 4339.370791235285, 48209.51790482085, 50347.74826125846, 50484.747576261885, 58243.12635310516, 58307.12539311914, 9817.460039697886, 9994.600215991424, 10010.099091081838, 10057.0, 10232.59069637206, 16226.513204603882, 16230.269637866324, 16237.51287461378, 16257.561365795225, 16266.430674926321, 6447.903281450782, 6499.837504062436, 6500.382463665944, 6544.3782840630065, 6711.899321510181, 3535.169235229719, 3568.072301201706, 3581.71346292296, 3635.0367152704553, 3678.3746763050344, 2910.4033673096965, 3007.443622929765, 3023.259301471154, 3027.303720144379, 3027.9848600756854, 503.4663256947574, 504.95202955719145, 506.09914352452694, 507.92888995540653, 517.6428264497484, 550.3505863081602, 566.7619599768108, 569.4959960435045, 582.6620560075146, 585.9033259512217, 7372.0, 7535.962320188364, 7585.506942048749, 7715.807104822425, 8341.791455213546, 482.7465580570159, 507.8933423981005, 515.2065818639328, 570.6775671745451, 571.9942800572024, 3672.687821535146, 3848.5766565677754, 4274.1451709658195, 4393.692441529062, 4395.230834603995, 94391.0560894396, 95596.52201738946, 98446.0, 98803.50598246962, 101273.49363253136, 82652.17347826566, 84268.15731842603, 85332.57333713291, 85914.57042714747, 90582.0, 77974.61012695014, 78249.60875195701, 78605.2139478598, 79094.60452697815, 80159.59920200362, 8053.838923221386, 8108.878366824621, 8177.877331840146, 8446.619902104543, 8697.0, 30847.0, 31244.68755312418, 41536.0, 43086.78456607697, 43908.0, 42141.157176856905, 55825.44174558202, 59230.40769592249, 66236.74305517504, 67913.66043169753, 9663.226941844776, 9714.80570388574, 9724.367916085432, 9837.901620983985, 9895.604175833174, 12402.379881006094, 12442.6576975508, 12985.22606350063, 13023.869761302265, 13077.738445230852, 11076.612318568812, 11467.827982580435, 11469.523325054863, 11515.884841151816, 11675.649730508097, 10002.8499572505, 10255.58977640886, 10270.229732770222, 10409.635662751767, 10724.410157441103, 10349.793004139725, 10625.628103016667, 10695.839562406414, 10709.303895246783, 10991.06575941054, 8108.878366824384, 8367.12145224767, 8521.147885211429, 8635.30917526609, 8876.378653494194, 8618.310535157298, 8846.690365837165, 9316.860247096163, 9479.478628675213, 9497.335186537153], "value": 6282.543717274392, "unit": "score"}], "name": "dromaeo_css", "value": 6172.297010125781, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 113.0, 114.0, 113.0, 112.0, 114.0, 113.0, 113.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 131.0, 126.0, 180.0, 131.0, 128.0, 127.0, 129.0, 160.0, 134.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 164.0, 160.0, 164.0, 163.0, 162.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 114.0, 76.0, 76.0, 77.0, 76.0, 102.0, 76.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 118.0, 83.0, 83.0, 84.0, 114.0, 84.0, 83.0, 118.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 64.0, 64.0, 64.0, 65.0, 65.0, 63.0, 63.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 68.0, 66.0, 66.0, 67.0, 68.0, 68.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 93.0, 86.0, 82.0, 92.0, 83.0, 83.0, 92.0, 83.0, 83.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 141.0, 137.0, 140.0, 138.0, 140.0, 138.0, 142.0, 183.0, 154.0], "value": 146.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 173.0, 176.0, 175.0, 178.0, 176.0, 179.0, 179.0, 174.0, 176.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 70.0, 70.0, 70.0, 70.0, 71.0, 72.0, 70.0, 71.0, 69.0], "value": 71.3, "unit": "score"}], "name": "kraken", "value": 1561.5, "alertThreshold": 2.0}]} 21:38:27 INFO - Return code: 0 21:38:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:38:27 INFO - # TBPL SUCCESS # 21:38:27 INFO - Running post-action listener: _resource_record_post_action 21:38:27 INFO - [mozharness: 2016-10-07 04:38:27.898168Z] Finished run-tests step (success) 21:38:27 INFO - Running post-run listener: _resource_record_post_run 21:38:27 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 391217152; Read time: 0; Write time: 235176 21:38:27 INFO - TinderboxPrint: CPU usage
13.1% 21:38:27 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 21:38:27 INFO - TinderboxPrint: I/O write bytes / time
391,217,152 / 235,176 21:38:27 INFO - TinderboxPrint: CPU idle
8,351.8 (86.9%) 21:38:27 INFO - TinderboxPrint: CPU user
1,205.4 (12.5%) 21:38:27 INFO - TinderboxPrint: Swap in / out
0 / 0 21:38:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99426304; Read time: 0; Write time: 60420 21:38:27 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291790848; Read time: 0; Write time: 174756 21:38:28 INFO - Running post-run listener: _upload_blobber_files 21:38:28 INFO - Blob upload gear active. 21:38:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:38:28 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:38:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:38:28 INFO - (blobuploader) - INFO - Open directory for files ... 21:38:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:38:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:38:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:38:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:38:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:38:29 INFO - (blobuploader) - INFO - Done attempting. 21:38:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:38:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:38:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:38:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:38:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:38:30 INFO - (blobuploader) - INFO - Done attempting. 21:38:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:38:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:38:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:38:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:38:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:38:36 INFO - (blobuploader) - INFO - Done attempting. 21:38:36 INFO - (blobuploader) - INFO - Iteration through files over. 21:38:36 INFO - Return code: 0 21:38:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:38:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:38:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8701c48ff790d1f3087668e295e851d9a0a687b1ad78d0ee25392eab70aa5c53f0b9c60de9b85f811790d5edb8faee37e3a226c73ef58303fb06d37f59de9d75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1da6788edbbe6cd47e0b520718eb2dbff4924f36df8d0acded862ff962751691863fe71725852b1ad28a6aa622084794bace32c88820858c69446895d4027c00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4e2304d8351415d853191aa6873cbd79112a9959fb30db8e52999753177ebf231a6e78a1288f54f31ef6b1de76e83a248b3154f5d191868a90b04845e7442a3"} 21:38:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:38:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:38:36 INFO - Contents: 21:38:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8701c48ff790d1f3087668e295e851d9a0a687b1ad78d0ee25392eab70aa5c53f0b9c60de9b85f811790d5edb8faee37e3a226c73ef58303fb06d37f59de9d75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1da6788edbbe6cd47e0b520718eb2dbff4924f36df8d0acded862ff962751691863fe71725852b1ad28a6aa622084794bace32c88820858c69446895d4027c00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4e2304d8351415d853191aa6873cbd79112a9959fb30db8e52999753177ebf231a6e78a1288f54f31ef6b1de76e83a248b3154f5d191868a90b04845e7442a3"} 21:38:36 INFO - Running post-run listener: copy_logs_to_upload_dir 21:38:36 INFO - Copying logs to upload dir... 21:38:36 INFO - mkdir: /builds/slave/test/build/upload/logs 21:38:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.876883 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-10-06 21:38:35.571188) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 21:38:35.578082) ========= 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=db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8701c48ff790d1f3087668e295e851d9a0a687b1ad78d0ee25392eab70aa5c53f0b9c60de9b85f811790d5edb8faee37e3a226c73ef58303fb06d37f59de9d75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1da6788edbbe6cd47e0b520718eb2dbff4924f36df8d0acded862ff962751691863fe71725852b1ad28a6aa622084794bace32c88820858c69446895d4027c00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4e2304d8351415d853191aa6873cbd79112a9959fb30db8e52999753177ebf231a6e78a1288f54f31ef6b1de76e83a248b3154f5d191868a90b04845e7442a3"} build_url:https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011515 build_url: 'https://queue.taskcluster.net/v1/task/NSVcx7FrTZueoDib6nYBHA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8701c48ff790d1f3087668e295e851d9a0a687b1ad78d0ee25392eab70aa5c53f0b9c60de9b85f811790d5edb8faee37e3a226c73ef58303fb06d37f59de9d75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1da6788edbbe6cd47e0b520718eb2dbff4924f36df8d0acded862ff962751691863fe71725852b1ad28a6aa622084794bace32c88820858c69446895d4027c00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4e2304d8351415d853191aa6873cbd79112a9959fb30db8e52999753177ebf231a6e78a1288f54f31ef6b1de76e83a248b3154f5d191868a90b04845e7442a3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 21:38:35.603558) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:38:35.603941) ========= 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=db7e7c15f3ca076d53731445000001ba-1475812811.140795-404815722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004614 ========= master_lag: 0.12 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:38:35.727715) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 21:38:35.728419) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 21:38:35.729108) ========= ========= Total master_lag: 0.41 =========