builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-031 starttime: 1476444625.95 results: success (0) buildid: 20161014030037 builduid: 3f13d4f7004144d7815e6b50ce727e92 revision: 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 04:30:25.947321) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 04:30:25.948367) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 04:30:25.949094) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 04:30:25.965513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:30:25.966289) ========= 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=db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 04:30:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-10-14 04:30:26 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099645 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:30:26.084992) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:30:26.085745) ========= 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=db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014761 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:30:26.140278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 04:30:26.141064) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 --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 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 --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=db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 04:30:26,304 truncating revision to first 12 chars 2016-10-14 04:30:26,304 Setting DEBUG logging. 2016-10-14 04:30:26,304 attempt 1/10 2016-10-14 04:30:26,304 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1391a2889aeb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 04:30:27,100 unpacking tar archive at: mozilla-central-1391a2889aeb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.139022 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 04:30:27.295843) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 04:30:27.296232) ========= script_repo_revision: 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 04:30:27.296688) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 04:30:27.296994) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 04:30:27.307764) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-14 04:30:27.308069) ========= /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=db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:30:27 INFO - MultiFileLogger online at 20161014 04:30:27 in /builds/slave/test 04:30:27 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 04:30:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:27 INFO - {'append_to_log': False, 04:30:27 INFO - 'base_work_dir': '/builds/slave/test', 04:30:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:30:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:27 INFO - 'branch': 'Firefox-Non-PGO', 04:30:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:27 INFO - 'config_files': ('talos/linux_config.py',), 04:30:27 INFO - 'default_actions': ('clobber', 04:30:27 INFO - 'read-buildbot-config', 04:30:27 INFO - 'download-and-extract', 04:30:27 INFO - 'populate-webroot', 04:30:27 INFO - 'create-virtualenv', 04:30:27 INFO - 'install', 04:30:27 INFO - 'run-tests'), 04:30:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:27 INFO - 'download_minidump_stackwalk': True, 04:30:27 INFO - 'download_symbols': 'ondemand', 04:30:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:27 INFO - 'installer_path': 'installer.exe', 04:30:27 INFO - 'log_level': 'info', 04:30:27 INFO - 'log_name': 'talos', 04:30:27 INFO - 'log_to_console': True, 04:30:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:30:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:30:27 INFO - 'opt_config_files': (), 04:30:27 INFO - 'pip_index': False, 04:30:27 INFO - 'sps_profile': False, 04:30:27 INFO - 'sps_profile_interval': 0, 04:30:27 INFO - 'suite': 'dromaeojs', 04:30:27 INFO - 'system_bits': '32', 04:30:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:27 INFO - 'title': 'talos-linux64-ix-031', 04:30:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:27 INFO - 'use_talos_json': True, 04:30:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:27 INFO - 'work_dir': 'build'} 04:30:27 INFO - [mozharness: 2016-10-14 11:30:27.568717Z] Running clobber step. 04:30:27 INFO - Running pre-action listener: _resource_record_pre_action 04:30:27 INFO - Running main action method: clobber 04:30:27 INFO - rmtree: /builds/slave/test/build 04:30:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:30:28 INFO - Running post-action listener: _resource_record_post_action 04:30:28 INFO - [mozharness: 2016-10-14 11:30:28.029816Z] Finished clobber step (success) 04:30:28 INFO - [mozharness: 2016-10-14 11:30:28.029916Z] Running read-buildbot-config step. 04:30:28 INFO - Running pre-action listener: _resource_record_pre_action 04:30:28 INFO - Running main action method: read_buildbot_config 04:30:28 INFO - Using buildbot properties: 04:30:28 INFO - { 04:30:28 INFO - "project": "", 04:30:28 INFO - "product": "firefox", 04:30:28 INFO - "script_repo_revision": "production", 04:30:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:30:28 INFO - "repository": "", 04:30:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:30:28 INFO - "buildid": "20161014030037", 04:30:28 INFO - "pgo_build": "False", 04:30:28 INFO - "basedir": "/builds/slave/test", 04:30:28 INFO - "buildnumber": 674, 04:30:28 INFO - "slavename": "talos-linux64-ix-031", 04:30:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:30:28 INFO - "platform": "ubuntu64_hw", 04:30:28 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:30:28 INFO - "branch": "mozilla-central", 04:30:28 INFO - "repo_path": "mozilla-central", 04:30:28 INFO - "revision": "1391a2889aeb2bdd61ad6ef838e65826e35aabc2", 04:30:28 INFO - "stage_platform": "linux64", 04:30:28 INFO - "builduid": "3f13d4f7004144d7815e6b50ce727e92", 04:30:28 INFO - "slavebuilddir": "test" 04:30:28 INFO - } 04:30:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:30:28 INFO - Running post-action listener: _resource_record_post_action 04:30:28 INFO - [mozharness: 2016-10-14 11:30:28.032331Z] Finished read-buildbot-config step (success) 04:30:28 INFO - [mozharness: 2016-10-14 11:30:28.032438Z] Running download-and-extract step. 04:30:28 INFO - Running pre-action listener: _resource_record_pre_action 04:30:28 INFO - Running main action method: download_and_extract 04:30:28 INFO - mkdir: /builds/slave/test/build/tests 04:30:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:28 INFO - trying https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:30:28 INFO - Downloading https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/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 04:30:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/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 04:30:28 INFO - Downloaded 1361 bytes. 04:30:28 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:30:28 INFO - Using the following test package requirements: 04:30:28 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:28 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:30:28 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:30:28 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:28 INFO - u'jsshell-linux-x86_64.zip'], 04:30:28 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:30:28 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:28 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:30:28 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:30:28 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:30:28 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:30:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:30:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:30:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:30:28 INFO - Fetch https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:30:29 INFO - Http code: 200 04:30:29 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 04:30:29 INFO - x-amz-cf-id: vc4b9V65B6mQWQvFFNDBcnZ95AqpHnfJuo9v9Hkx3ZfWtA4sc1b0yw== 04:30:29 INFO - x-amz-version-id: pXc2TaNOZaIuv6OX1I2kKYsEAPpUIgPr 04:30:29 INFO - Expected file size: 20553754 04:30:29 INFO - Obtained file size: 20553754 04:30:33 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 04:30:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:30:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:30:33 INFO - Fetch https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:30:34 INFO - Http code: 200 04:30:34 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 04:30:34 INFO - x-amz-cf-id: crU3X0vOOn46VCVl4PLmdkdLqOASWKSN65fGJkbvZbIekI6CDq38WQ== 04:30:34 INFO - x-amz-version-id: pXc2TaNOZaIuv6OX1I2kKYsEAPpUIgPr 04:30:34 INFO - Expected file size: 20553754 04:30:34 INFO - Obtained file size: 20553754 04:30:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:30:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:30:38 INFO - Fetch https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:30:39 INFO - Http code: 200 04:30:39 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 04:30:39 INFO - x-amz-cf-id: 2cmrBlboA2EKqeZsOEtPu7OlxACi7b1fx5fNSFuUQwP-4WYDVUgOQQ== 04:30:39 INFO - x-amz-version-id: Vvdc5wEyKOp4uEOxRrcjwtARrT_EceVl 04:30:39 INFO - Expected file size: 14409006 04:30:39 INFO - Obtained file size: 14409006 04:30: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')]} 04:30:39 INFO - trying https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:30:39 INFO - Downloading https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/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 04:30:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/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 04:30:40 INFO - Downloaded 55634849 bytes. 04:30:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:30:40 INFO - mkdir: /builds/slave/test/properties 04:30:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:30:40 INFO - Writing to file /builds/slave/test/properties/build_url 04:30:40 INFO - Contents: 04:30:40 INFO - build_url:https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:30:41 INFO - Running post-action listener: _resource_record_post_action 04:30:41 INFO - Running post-action listener: set_extra_try_arguments 04:30:41 INFO - [mozharness: 2016-10-14 11:30:41.568482Z] Finished download-and-extract step (success) 04:30:41 INFO - [mozharness: 2016-10-14 11:30:41.568709Z] Running populate-webroot step. 04:30:41 INFO - Running pre-action listener: _resource_record_pre_action 04:30:41 INFO - Running main action method: populate_webroot 04:30:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:30:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:30:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:30:41 INFO - '--tppagecycles', 04:30:41 INFO - '7'], 04:30:41 INFO - 'tests': ['tsvgm']}}, 04:30:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:30:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:30:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:30:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:30:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:30:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:30:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:41 INFO - 'talos_options': ['--disable-e10s'], 04:30:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:41 INFO - 'talos_options': ['--disable-e10s'], 04:30:41 INFO - 'tests': ['damp', 'tps']}, 04:30:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:41 INFO - 'tests': ['damp', 'tps']}, 04:30:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:30:41 INFO - 'tests': ['dromaeo_dom']}, 04:30:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:30:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:30:41 INFO - 'tests': ['basic_compositor_video']}, 04:30:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:30:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:30:41 INFO - 'tests': ['a11yr', 04:30:41 INFO - 'ts_paint', 04:30:41 INFO - 'tpaint', 04:30:41 INFO - 'sessionrestore', 04:30:41 INFO - 'sessionrestore_no_auto_restore', 04:30:41 INFO - 'tabpaint']}, 04:30:41 INFO - 'other-e10s': {'tests': ['a11yr', 04:30:41 INFO - 'ts_paint', 04:30:41 INFO - 'tpaint', 04:30:41 INFO - 'sessionrestore', 04:30:41 INFO - 'sessionrestore_no_auto_restore', 04:30:41 INFO - 'tabpaint']}, 04:30:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:30:41 INFO - 'ts_paint', 04:30:41 INFO - 'tpaint', 04:30:41 INFO - 'sessionrestore', 04:30:41 INFO - 'sessionrestore_no_auto_restore', 04:30:41 INFO - 'tabpaint']}, 04:30:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:30:41 INFO - 'ts_paint', 04:30:41 INFO - 'tpaint', 04:30:41 INFO - 'sessionrestore', 04:30:41 INFO - 'sessionrestore_no_auto_restore', 04:30:41 INFO - 'tabpaint']}, 04:30:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:30:41 INFO - 'tests': ['a11yr', 04:30:41 INFO - 'ts_paint', 04:30:41 INFO - 'tpaint', 04:30:41 INFO - 'sessionrestore', 04:30:41 INFO - 'sessionrestore_no_auto_restore', 04:30:41 INFO - 'tabpaint']}, 04:30:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:30:41 INFO - 'tests': ['a11yr', 04:30:41 INFO - 'ts_paint', 04:30:41 INFO - 'tpaint', 04:30:41 INFO - 'sessionrestore', 04:30:41 INFO - 'sessionrestore_no_auto_restore', 04:30:41 INFO - 'tabpaint']}, 04:30:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:30:41 INFO - 'tests': ['tsvgx', 04:30:41 INFO - 'tsvgr_opacity', 04:30:41 INFO - 'tart', 04:30:41 INFO - 'tscrollx', 04:30:41 INFO - 'cart']}, 04:30:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:30:41 INFO - 'tsvgr_opacity', 04:30:41 INFO - 'tart', 04:30:41 INFO - 'tscrollx', 04:30:41 INFO - 'cart']}, 04:30:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:41 INFO - 'talos_options': ['--disable-e10s'], 04:30:41 INFO - 'tests': ['tp5o']}, 04:30:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:41 INFO - 'tests': ['tp5o']}, 04:30:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:41 INFO - 'talos_options': ['--disable-e10s', 04:30:41 INFO - '--xperf_path', 04:30:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:41 INFO - 'tests': ['tp5n']}, 04:30:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:41 INFO - 'talos_options': ['--xperf_path', 04:30:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:41 INFO - 'tests': ['tp5n']}}, 04:30:41 INFO - 'talos.zip': {'path': '', 04:30:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:30:41 INFO - Running post-action listener: _resource_record_post_action 04:30:41 INFO - [mozharness: 2016-10-14 11:30:41.589466Z] Finished populate-webroot step (success) 04:30:41 INFO - [mozharness: 2016-10-14 11:30:41.589554Z] Running create-virtualenv step. 04:30:41 INFO - Running pre-action listener: _resource_record_pre_action 04:30:41 INFO - Running main action method: create_virtualenv 04:30:41 INFO - Creating virtualenv /builds/slave/test/build/venv 04:30:41 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 04:30:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:30:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:30:41 INFO - Using real prefix '/usr' 04:30:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:30:42 INFO - Installing distribute.............................................................................................................................................................................................done. 04:30:44 INFO - Installing pip.................done. 04:30:44 INFO - Return code: 0 04:30:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:30:44 INFO - Reading from file tmpfile_stdout 04:30:44 INFO - Output received: 04:30:44 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) 04:30:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:30:44 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')]} 04:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:44 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')]} 04:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:44 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 0x7f17d2df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2f60>, '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 0x21a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a41d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', '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 04:30:44 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 04:30:44 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 04:30:44 INFO - Using env: {'DISPLAY': ':0', 04:30:44 INFO - 'HOME': '/home/cltbld', 04:30:44 INFO - 'LANG': 'en_US.UTF-8', 04:30:44 INFO - 'LANGUAGE': 'en_US:en', 04:30:44 INFO - 'LOGNAME': 'cltbld', 04:30:44 INFO - 'MAIL': '/var/mail/cltbld', 04:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:44 INFO - 'MOZ_NO_REMOTE': '1', 04:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:44 INFO - 'NO_EM_RESTART': '1', 04:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:44 INFO - 'PWD': '/builds/slave/test', 04:30:44 INFO - 'SHELL': '/bin/bash', 04:30:44 INFO - 'SHLVL': '1', 04:30:44 INFO - 'TERM': 'linux', 04:30:44 INFO - 'TMOUT': '86400', 04:30:44 INFO - 'USER': 'cltbld', 04:30:44 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', 04:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:44 INFO - '_': '/tools/buildbot/bin/python'} 04:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:44 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 04:30:44 INFO - Cleaning up... 04:30:44 INFO - Return code: 0 04:30:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:30:44 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')]} 04:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:44 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')]} 04:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:44 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 0x7f17d2df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2f60>, '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 0x21a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a41d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', '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 04:30:44 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 04:30:44 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 04:30:44 INFO - Using env: {'DISPLAY': ':0', 04:30:44 INFO - 'HOME': '/home/cltbld', 04:30:44 INFO - 'LANG': 'en_US.UTF-8', 04:30:44 INFO - 'LANGUAGE': 'en_US:en', 04:30:44 INFO - 'LOGNAME': 'cltbld', 04:30:44 INFO - 'MAIL': '/var/mail/cltbld', 04:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:44 INFO - 'MOZ_NO_REMOTE': '1', 04:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:44 INFO - 'NO_EM_RESTART': '1', 04:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:44 INFO - 'PWD': '/builds/slave/test', 04:30:44 INFO - 'SHELL': '/bin/bash', 04:30:44 INFO - 'SHLVL': '1', 04:30:44 INFO - 'TERM': 'linux', 04:30:44 INFO - 'TMOUT': '86400', 04:30:44 INFO - 'USER': 'cltbld', 04:30:44 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', 04:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:44 INFO - '_': '/tools/buildbot/bin/python'} 04:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:44 INFO - Downloading/unpacking psutil>=3.1.1 04:30:44 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 04:30:44 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 04:30:44 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 04:30:44 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 04:30:44 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 04:30:44 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 04:30:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:30:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:46 INFO - Installing collected packages: psutil 04:30:46 INFO - Running setup.py install for psutil 04:30:46 INFO - building 'psutil._psutil_linux' extension 04:30:46 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 04:30:47 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 04:30:47 INFO - building 'psutil._psutil_posix' extension 04:30:47 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 04:30:47 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 04:30:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:47 INFO - Successfully installed psutil 04:30:47 INFO - Cleaning up... 04:30:47 INFO - Return code: 0 04:30:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:47 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 0x7f17d2df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2f60>, '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 0x21a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a41d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', '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 04:30:47 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 04:30:47 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 04:30:47 INFO - Using env: {'DISPLAY': ':0', 04:30:47 INFO - 'HOME': '/home/cltbld', 04:30:47 INFO - 'LANG': 'en_US.UTF-8', 04:30:47 INFO - 'LANGUAGE': 'en_US:en', 04:30:47 INFO - 'LOGNAME': 'cltbld', 04:30:47 INFO - 'MAIL': '/var/mail/cltbld', 04:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:47 INFO - 'MOZ_NO_REMOTE': '1', 04:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:47 INFO - 'NO_EM_RESTART': '1', 04:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:47 INFO - 'PWD': '/builds/slave/test', 04:30:47 INFO - 'SHELL': '/bin/bash', 04:30:47 INFO - 'SHLVL': '1', 04:30:47 INFO - 'TERM': 'linux', 04:30:47 INFO - 'TMOUT': '86400', 04:30:47 INFO - 'USER': 'cltbld', 04:30:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', 04:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:47 INFO - '_': '/tools/buildbot/bin/python'} 04:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:30:47 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 04:30:47 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 04:30:47 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 04:30:47 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 04:30:47 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 04:30:47 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 04:30:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:30:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:30:49 INFO - Installing collected packages: mozsystemmonitor 04:30:49 INFO - Running setup.py install for mozsystemmonitor 04:30:49 INFO - Successfully installed mozsystemmonitor 04:30:49 INFO - Cleaning up... 04:30:49 INFO - Return code: 0 04:30:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:30:49 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')]} 04:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:49 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')]} 04:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:49 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 0x7f17d2df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2f60>, '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 0x21a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a41d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', '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 04:30:49 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 04:30:49 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 04:30:49 INFO - Using env: {'DISPLAY': ':0', 04:30:49 INFO - 'HOME': '/home/cltbld', 04:30:49 INFO - 'LANG': 'en_US.UTF-8', 04:30:49 INFO - 'LANGUAGE': 'en_US:en', 04:30:49 INFO - 'LOGNAME': 'cltbld', 04:30:49 INFO - 'MAIL': '/var/mail/cltbld', 04:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:49 INFO - 'MOZ_NO_REMOTE': '1', 04:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:49 INFO - 'NO_EM_RESTART': '1', 04:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:49 INFO - 'PWD': '/builds/slave/test', 04:30:49 INFO - 'SHELL': '/bin/bash', 04:30:49 INFO - 'SHLVL': '1', 04:30:49 INFO - 'TERM': 'linux', 04:30:49 INFO - 'TMOUT': '86400', 04:30:49 INFO - 'USER': 'cltbld', 04:30:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', 04:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:49 INFO - '_': '/tools/buildbot/bin/python'} 04:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:50 INFO - Downloading/unpacking jsonschema==2.5.1 04:30:50 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 04:30:50 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 04:30:50 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 04:30:50 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 04:30:50 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 04:30:50 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 04:30:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:30:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:30:51 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 04:30:51 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 04:30:51 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 04:30:51 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 04:30:51 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 04:30:51 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 04:30:52 INFO - Downloading functools32-3.2.3-2.tar.gz 04:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:30:52 INFO - warning: no files found matching '*.txt' 04:30:52 INFO - no previously-included directories found matching 'build' 04:30:52 INFO - no previously-included directories found matching 'dist' 04:30:52 INFO - no previously-included directories found matching '.git*' 04:30:52 INFO - Installing collected packages: jsonschema, functools32 04:30:52 INFO - Running setup.py install for functools32 04:30:52 INFO - warning: no files found matching '*.txt' 04:30:52 INFO - no previously-included directories found matching 'build' 04:30:52 INFO - no previously-included directories found matching 'dist' 04:30:52 INFO - no previously-included directories found matching '.git*' 04:30:52 INFO - Successfully installed jsonschema functools32 04:30:52 INFO - Cleaning up... 04:30:52 INFO - Return code: 0 04:30:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:52 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 0x7f17d2df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2f60>, '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 0x21a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a41d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', '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 04:30:52 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 04:30:52 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 04:30:52 INFO - Using env: {'DISPLAY': ':0', 04:30:52 INFO - 'HOME': '/home/cltbld', 04:30:52 INFO - 'LANG': 'en_US.UTF-8', 04:30:52 INFO - 'LANGUAGE': 'en_US:en', 04:30:52 INFO - 'LOGNAME': 'cltbld', 04:30:52 INFO - 'MAIL': '/var/mail/cltbld', 04:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:52 INFO - 'MOZ_NO_REMOTE': '1', 04:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:52 INFO - 'NO_EM_RESTART': '1', 04:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:52 INFO - 'PWD': '/builds/slave/test', 04:30:52 INFO - 'SHELL': '/bin/bash', 04:30:52 INFO - 'SHLVL': '1', 04:30:52 INFO - 'TERM': 'linux', 04:30:52 INFO - 'TMOUT': '86400', 04:30:52 INFO - 'USER': 'cltbld', 04:30:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', 04:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:52 INFO - '_': '/tools/buildbot/bin/python'} 04:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:30:52 INFO - Cleaning up... 04:30:52 INFO - Return code: 0 04:30:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:52 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 0x7f17d2df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2f60>, '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 0x21a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a41d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', '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 04:30:52 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 04:30:52 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 04:30:52 INFO - Using env: {'DISPLAY': ':0', 04:30:52 INFO - 'HOME': '/home/cltbld', 04:30:52 INFO - 'LANG': 'en_US.UTF-8', 04:30:52 INFO - 'LANGUAGE': 'en_US:en', 04:30:52 INFO - 'LOGNAME': 'cltbld', 04:30:52 INFO - 'MAIL': '/var/mail/cltbld', 04:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:52 INFO - 'MOZ_NO_REMOTE': '1', 04:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:52 INFO - 'NO_EM_RESTART': '1', 04:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:52 INFO - 'PWD': '/builds/slave/test', 04:30:52 INFO - 'SHELL': '/bin/bash', 04:30:52 INFO - 'SHLVL': '1', 04:30:52 INFO - 'TERM': 'linux', 04:30:52 INFO - 'TMOUT': '86400', 04:30:52 INFO - 'USER': 'cltbld', 04:30:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', 04:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:52 INFO - '_': '/tools/buildbot/bin/python'} 04:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:52 INFO - Downloading/unpacking blobuploader==1.2.4 04:30:52 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 04:30:52 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 04:30:52 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 04:30:52 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 04:30:52 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 04:30:52 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 04:30:54 INFO - Downloading blobuploader-1.2.4.tar.gz 04:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:30:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:30:54 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 04:30:54 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 04:30:54 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 04:30:54 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 04:30:54 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 04:30:54 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 04:30:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:30:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:30:55 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 04:30:55 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 04:30:55 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 04:30:55 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 04:30:55 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 04:30:55 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 04:30:55 INFO - Downloading docopt-0.6.1.tar.gz 04:30:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:30:55 INFO - Installing collected packages: blobuploader, requests, docopt 04:30:55 INFO - Running setup.py install for blobuploader 04:30:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:30:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:30:55 INFO - Running setup.py install for requests 04:30:55 INFO - Running setup.py install for docopt 04:30:56 INFO - Successfully installed blobuploader requests docopt 04:30:56 INFO - Cleaning up... 04:30:56 INFO - Return code: 0 04:30:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:56 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 0x7f17d2df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2f60>, '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 0x21a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a41d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', '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 04:30:56 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 04:30:56 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 04:30:56 INFO - Using env: {'DISPLAY': ':0', 04:30:56 INFO - 'HOME': '/home/cltbld', 04:30:56 INFO - 'LANG': 'en_US.UTF-8', 04:30:56 INFO - 'LANGUAGE': 'en_US:en', 04:30:56 INFO - 'LOGNAME': 'cltbld', 04:30:56 INFO - 'MAIL': '/var/mail/cltbld', 04:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:56 INFO - 'MOZ_NO_REMOTE': '1', 04:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:56 INFO - 'NO_EM_RESTART': '1', 04:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:56 INFO - 'PWD': '/builds/slave/test', 04:30:56 INFO - 'SHELL': '/bin/bash', 04:30:56 INFO - 'SHLVL': '1', 04:30:56 INFO - 'TERM': 'linux', 04:30:56 INFO - 'TMOUT': '86400', 04:30:56 INFO - 'USER': 'cltbld', 04:30:56 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', 04:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:56 INFO - '_': '/tools/buildbot/bin/python'} 04:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:56 INFO - Running setup.py (path:/tmp/pip-SYHvG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:56 INFO - Running setup.py (path:/tmp/pip-1V7xh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:56 INFO - Running setup.py (path:/tmp/pip-sX4TJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:56 INFO - Running setup.py (path:/tmp/pip-UXm7At-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:56 INFO - Running setup.py (path:/tmp/pip-7jI9Yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:56 INFO - Running setup.py (path:/tmp/pip-EyCmBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:56 INFO - Running setup.py (path:/tmp/pip-GA_TZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:56 INFO - Running setup.py (path:/tmp/pip-SgeVJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:56 INFO - Running setup.py (path:/tmp/pip-ijndJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:57 INFO - Running setup.py (path:/tmp/pip-mz1xrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:57 INFO - Running setup.py (path:/tmp/pip-x3DUKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:57 INFO - Running setup.py (path:/tmp/pip-7rQ6U8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:57 INFO - Running setup.py (path:/tmp/pip-7dYzLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:57 INFO - Running setup.py (path:/tmp/pip-P_RhWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:57 INFO - Running setup.py (path:/tmp/pip-3d2UvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:57 INFO - Running setup.py (path:/tmp/pip-Aiisyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:57 INFO - Running setup.py (path:/tmp/pip-NKMNWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:30:57 INFO - Running setup.py install for manifestparser 04:30:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Running setup.py install for mozcrash 04:30:57 INFO - Running setup.py install for mozdebug 04:30:57 INFO - Running setup.py install for mozdevice 04:30:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Running setup.py install for mozfile 04:30:58 INFO - Running setup.py install for mozhttpd 04:30:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Running setup.py install for mozinfo 04:30:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Running setup.py install for mozInstall 04:30:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Running setup.py install for mozleak 04:30:58 INFO - Running setup.py install for mozlog 04:30:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Running setup.py install for moznetwork 04:30:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Running setup.py install for mozprocess 04:30:58 INFO - Running setup.py install for mozprofile 04:30:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Running setup.py install for mozrunner 04:30:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Running setup.py install for mozscreenshot 04:30:59 INFO - Running setup.py install for moztest 04:30:59 INFO - Running setup.py install for mozversion 04:30:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:30:59 INFO - Cleaning up... 04:30:59 INFO - Return code: 0 04:30:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:59 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 0x7f17d2df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2f60>, '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 0x21a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a41d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', '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 04:30:59 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 04:30:59 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 04:30:59 INFO - Using env: {'DISPLAY': ':0', 04:30:59 INFO - 'HOME': '/home/cltbld', 04:30:59 INFO - 'LANG': 'en_US.UTF-8', 04:30:59 INFO - 'LANGUAGE': 'en_US:en', 04:30:59 INFO - 'LOGNAME': 'cltbld', 04:30:59 INFO - 'MAIL': '/var/mail/cltbld', 04:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:59 INFO - 'MOZ_NO_REMOTE': '1', 04:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:59 INFO - 'NO_EM_RESTART': '1', 04:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:59 INFO - 'PWD': '/builds/slave/test', 04:30:59 INFO - 'SHELL': '/bin/bash', 04:30:59 INFO - 'SHLVL': '1', 04:30:59 INFO - 'TERM': 'linux', 04:30:59 INFO - 'TMOUT': '86400', 04:30:59 INFO - 'USER': 'cltbld', 04:30:59 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', 04:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:59 INFO - '_': '/tools/buildbot/bin/python'} 04:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:59 INFO - Running setup.py (path:/tmp/pip-Hl_DUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:59 INFO - Running setup.py (path:/tmp/pip-2KC7Jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:59 INFO - Running setup.py (path:/tmp/pip-KTZb1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:59 INFO - Running setup.py (path:/tmp/pip-uxoUpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:59 INFO - Running setup.py (path:/tmp/pip-rtipl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:00 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)) 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:00 INFO - Running setup.py (path:/tmp/pip-Fz8tbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:00 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)) 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:00 INFO - Running setup.py (path:/tmp/pip-mTxHKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:00 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)) 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:00 INFO - Running setup.py (path:/tmp/pip-tYHeNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:00 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)) 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:00 INFO - Running setup.py (path:/tmp/pip-vPFrvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:00 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)) 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:00 INFO - Running setup.py (path:/tmp/pip-YUKeuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:00 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)) 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:00 INFO - Running setup.py (path:/tmp/pip-VpFqVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:00 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)) 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:00 INFO - Running setup.py (path:/tmp/pip-bcS40q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:00 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)) 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:00 INFO - Running setup.py (path:/tmp/pip-bWM42y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:00 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)) 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:00 INFO - Running setup.py (path:/tmp/pip-7gKQFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:00 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)) 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:00 INFO - Running setup.py (path:/tmp/pip-KKYhl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:00 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)) 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:00 INFO - Running setup.py (path:/tmp/pip-IPMf5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:00 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)) 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:00 INFO - Running setup.py (path:/tmp/pip-N6R4eD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:00 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)) 04:31:00 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)) 04:31:00 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)) 04:31:00 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)) 04:31:00 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)) 04:31:00 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)) 04:31:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:00 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 04:31:00 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 04:31:00 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 04:31:00 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 04:31:00 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 04:31:00 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 04:31:02 INFO - Downloading blessings-1.6.tar.gz 04:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:02 INFO - Installing collected packages: blessings 04:31:02 INFO - Running setup.py install for blessings 04:31:02 INFO - Successfully installed blessings 04:31:02 INFO - Cleaning up... 04:31:03 INFO - Return code: 0 04:31:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:03 INFO - Reading from file tmpfile_stdout 04:31:03 INFO - Current package versions: 04:31:03 INFO - argparse == 1.2.1 04:31:03 INFO - blessings == 1.6 04:31:03 INFO - blobuploader == 1.2.4 04:31:03 INFO - docopt == 0.6.1 04:31:03 INFO - functools32 == 3.2.3-2 04:31:03 INFO - jsonschema == 2.5.1 04:31:03 INFO - manifestparser == 1.1 04:31:03 INFO - mozInstall == 1.12 04:31:03 INFO - mozcrash == 0.17 04:31:03 INFO - mozdebug == 0.1 04:31:03 INFO - mozdevice == 0.48 04:31:03 INFO - mozfile == 1.2 04:31:03 INFO - mozhttpd == 0.7 04:31:03 INFO - mozinfo == 0.9 04:31:03 INFO - mozleak == 0.1 04:31:03 INFO - mozlog == 3.4 04:31:03 INFO - moznetwork == 0.27 04:31:03 INFO - mozprocess == 0.23 04:31:03 INFO - mozprofile == 0.28 04:31:03 INFO - mozrunner == 6.12 04:31:03 INFO - mozscreenshot == 0.1 04:31:03 INFO - mozsystemmonitor == 0.3 04:31:03 INFO - moztest == 0.7 04:31:03 INFO - mozversion == 1.4 04:31:03 INFO - psutil == 3.1.1 04:31:03 INFO - requests == 1.2.3 04:31:03 INFO - wsgiref == 0.1.2 04:31:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:03 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')]} 04:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:03 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')]} 04:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:03 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 0x7f17d2df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2f60>, '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 0x21a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a41d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', '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 04:31:03 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 04:31:03 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 04:31:03 INFO - Using env: {'DISPLAY': ':0', 04:31:03 INFO - 'HOME': '/home/cltbld', 04:31:03 INFO - 'LANG': 'en_US.UTF-8', 04:31:03 INFO - 'LANGUAGE': 'en_US:en', 04:31:03 INFO - 'LOGNAME': 'cltbld', 04:31:03 INFO - 'MAIL': '/var/mail/cltbld', 04:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:03 INFO - 'MOZ_NO_REMOTE': '1', 04:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:03 INFO - 'NO_EM_RESTART': '1', 04:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:03 INFO - 'PWD': '/builds/slave/test', 04:31:03 INFO - 'SHELL': '/bin/bash', 04:31:03 INFO - 'SHLVL': '1', 04:31:03 INFO - 'TERM': 'linux', 04:31:03 INFO - 'TMOUT': '86400', 04:31:03 INFO - 'USER': 'cltbld', 04:31:03 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', 04:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:03 INFO - '_': '/tools/buildbot/bin/python'} 04:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 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)) 04:31:03 INFO - Cleaning up... 04:31:03 INFO - Return code: 0 04:31:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:03 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')]} 04:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:03 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')]} 04:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:03 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 0x7f17d2df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2f60>, '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 0x21a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a41d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', '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 04:31:03 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 04:31:03 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 04:31:03 INFO - Using env: {'DISPLAY': ':0', 04:31:03 INFO - 'HOME': '/home/cltbld', 04:31:03 INFO - 'LANG': 'en_US.UTF-8', 04:31:03 INFO - 'LANGUAGE': 'en_US:en', 04:31:03 INFO - 'LOGNAME': 'cltbld', 04:31:03 INFO - 'MAIL': '/var/mail/cltbld', 04:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:03 INFO - 'MOZ_NO_REMOTE': '1', 04:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:03 INFO - 'NO_EM_RESTART': '1', 04:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:03 INFO - 'PWD': '/builds/slave/test', 04:31:03 INFO - 'SHELL': '/bin/bash', 04:31:03 INFO - 'SHLVL': '1', 04:31:03 INFO - 'TERM': 'linux', 04:31:03 INFO - 'TMOUT': '86400', 04:31:03 INFO - 'USER': 'cltbld', 04:31:03 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', 04:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:03 INFO - '_': '/tools/buildbot/bin/python'} 04:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:31:03 INFO - Cleaning up... 04:31:03 INFO - Return code: 0 04:31:03 INFO - Running post-action listener: _resource_record_post_action 04:31:03 INFO - Running post-action listener: _start_resource_monitoring 04:31:03 INFO - Starting resource monitoring. 04:31:03 INFO - [mozharness: 2016-10-14 11:31:03.773977Z] Finished create-virtualenv step (success) 04:31:03 INFO - [mozharness: 2016-10-14 11:31:03.774496Z] Running install step. 04:31:03 INFO - Running pre-action listener: _resource_record_pre_action 04:31:03 INFO - Running main action method: install 04:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:03 INFO - Reading from file tmpfile_stdout 04:31:03 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:04 INFO - Reading from file tmpfile_stdout 04:31:04 INFO - Output received: 04:31:04 INFO - Usage: mozinstall [options] installer 04:31:04 INFO - Options: 04:31:04 INFO - -h, --help show this help message and exit 04:31:04 INFO - -d DEST, --destination=DEST 04:31:04 INFO - Directory to install application into. [default: 04:31:04 INFO - "/builds/slave/test"] 04:31:04 INFO - --app=APP Application being installed. [default: firefox] 04:31:04 INFO - mkdir: /builds/slave/test/build/application 04:31:04 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'] 04:31:04 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 04:31:20 INFO - Reading from file tmpfile_stdout 04:31:20 INFO - Output received: 04:31:20 INFO - /builds/slave/test/build/application/firefox/firefox 04:31:20 INFO - Running post-action listener: _resource_record_post_action 04:31:20 INFO - [mozharness: 2016-10-14 11:31:20.144527Z] Finished install step (success) 04:31:20 INFO - [mozharness: 2016-10-14 11:31:20.144778Z] Running run-tests step. 04:31:20 INFO - Running pre-action listener: _resource_record_pre_action 04:31:20 INFO - Running main action method: run_tests 04:31:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:31:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:31:20 INFO - Python 2.7.3 04:31:20 INFO - Return code: 0 04:31:20 INFO - grabbing minidump binary from tooltool 04:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:20 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 0x21a2f60>, '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 0x21a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a41d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:31:20 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 04:31:20 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 04:31:20 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 04:31:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:31:20 INFO - Return code: 0 04:31:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:31:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:31:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:31:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:31:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:31:20 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/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 04:31:20 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/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 04:31:20 INFO - Using env: {'DISPLAY': ':0', 04:31:20 INFO - 'HOME': '/home/cltbld', 04:31:20 INFO - 'LANG': 'en_US.UTF-8', 04:31:20 INFO - 'LANGUAGE': 'en_US:en', 04:31:20 INFO - 'LOGNAME': 'cltbld', 04:31:20 INFO - 'MAIL': '/var/mail/cltbld', 04:31:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:31:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:20 INFO - 'MOZ_NO_REMOTE': '1', 04:31:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:31:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:20 INFO - 'NO_EM_RESTART': '1', 04:31:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:20 INFO - 'PWD': '/builds/slave/test', 04:31:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:31:20 INFO - 'SHELL': '/bin/bash', 04:31:20 INFO - 'SHLVL': '1', 04:31:20 INFO - 'TERM': 'linux', 04:31:20 INFO - 'TMOUT': '86400', 04:31:20 INFO - 'USER': 'cltbld', 04:31:20 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211', 04:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:20 INFO - '_': '/tools/buildbot/bin/python'} 04:31:20 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/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 04:31:20 INFO - mozversion application_buildid: 20161014030037 04:31:20 INFO - mozversion application_changeset: 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 04:31:20 INFO - mozversion application_display_name: Nightly 04:31:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:31:20 INFO - mozversion application_name: Firefox 04:31:20 INFO - mozversion application_remotingname: firefox 04:31:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:31:20 INFO - mozversion application_vendor: Mozilla 04:31:20 INFO - mozversion application_version: 52.0a1 04:31:20 INFO - mozversion platform_buildid: 20161014030037 04:31:20 INFO - mozversion platform_changeset: 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 04:31:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:31:20 INFO - mozversion platform_version: 52.0a1 04:31:20 INFO - using testdate: 1476444680 04:31:20 INFO - actual date: 1476444680 04:31:20 INFO - starting webserver on 'localhost:60552' 04:31:20 INFO - SUITE-START | Running 2 tests 04:31:20 INFO - TEST-START | dromaeo_css 04:31:20 INFO - operating with platform_type : linux_ 04:31:20 INFO - Initialising browser for dromaeo_css test... 04:31:20 INFO - TEST-INFO | started process 25322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFJbvQV/profile http://localhost:60552/getInfo.html) 04:31:24 INFO - PROCESS | 25322 | __metrics Screen width/height:1600/1200 04:31:24 INFO - PROCESS | 25322 | colorDepth:24 04:31:24 INFO - PROCESS | 25322 | Browser inner width/height: 1024/697 04:31:24 INFO - PROCESS | 25322 | __metrics 04:31:25 INFO - PROCESS | 25322 | 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" 04:31:25 INFO - PROCESS | 25322 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:31:26 INFO - PROCESS | 25322 | console.error: PushService: 04:31:26 INFO - PROCESS | 25322 | stateChangeProcessEnqueue: Error transitioning state 04:31:26 INFO - PROCESS | 25322 | UnknownError 04:31:27 INFO - TEST-INFO | 25322: exit 0 04:31:27 INFO - Browser initialized. 04:31:27 INFO - Running cycle 1/1 for dromaeo_css test... 04:31:27 INFO - TEST-INFO | started process 25403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFJbvQV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:39 INFO - PROCESS | 25403 | RSS: Main: 174239744 04:31:39 INFO - PROCESS | 25403 | 04:32:30 INFO - PROCESS | 25403 | 1476444750998 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] 04:34:44 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:60552/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60552/tests/dromaeo/cssquery-ext.html) 04:34:46 INFO - PROCESS | 25403 | RSS: Main: 350175232 04:34:46 INFO - PROCESS | 25403 | 04:37:48 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:60552/tests/dromaeo/cssquery-ext.html (next: http://localhost:60552/tests/dromaeo/cssquery-jquery.html) 04:37:49 INFO - PROCESS | 25403 | RSS: Main: 269238272 04:37:49 INFO - PROCESS | 25403 | 04:40:51 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:60552/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60552/tests/dromaeo/cssquery-mootools.html) 04:40:52 INFO - PROCESS | 25403 | RSS: Main: 244473856 04:40:52 INFO - PROCESS | 25403 | 04:43:54 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:60552/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60552/tests/dromaeo/cssquery-prototype.html) 04:43:54 INFO - PROCESS | 25403 | RSS: Main: 238063616 04:43:54 INFO - PROCESS | 25403 | 04:46:58 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:60552/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60552/tests/dromaeo/cssquery-yui.html) 04:46:58 INFO - PROCESS | 25403 | RSS: Main: 222257152 04:46:58 INFO - PROCESS | 25403 | 04:50:01 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:60552/tests/dromaeo/cssquery-yui.html (next: http://localhost:60552/tests/dromaeo/cssquery-dojo.html) 04:50:02 INFO - PROCESS | 25403 | RSS: Main: 309882880 04:50:02 INFO - PROCESS | 25403 | 04:50:02 INFO - PROCESS | 25403 | __start_tp_report 04:50:02 INFO - PROCESS | 25403 | _x_x_mozilla_page_load 04:50:02 INFO - PROCESS | 25403 | _x_x_mozilla_page_load_details 04:50:02 INFO - PROCESS | 25403 | |i|pagename|runs| 04:50:02 INFO - PROCESS | 25403 | |0;dojo.html;2551.0433587404723;2563.9615405768927;2565.307367010907;2604.9869750651255;2617.8167528273016;4395.406620106285;4480.775961201944;4528.977355113224;4540.160070386981;4546.272596384579;4528.049109686962;4531.116432295704;4539.137563862863;4552.157850797605;4560.087982403525;4149.7302675326155;4173.457450531427;4184.351425529033;4216.7259128156575;4232.873013809591;4143.6685065194715;4179.770112643803;4183.079722461053;4184.100418410041;4187.288161012635;4149.419081328617;4152.356384760352;4164.937525937114;4202.684798640099;4217.936730949038;4191.392248124035;4204.096119334357;4205.705600607958;4223.936640950373;4252.08580155265;4056.067104565937;4096.692748043909;4139.958600413987;4142.565030671796;4203.747775133502;4531.388262584542;4542.591166794971;4547.363369128325;4609.838655647036;4621.306803979396;4839.927401088987;4851.878703032452;4869.805207791684;4869.951300486985;4918.581920536759;4697.271922851929;4746.311784791221;4748.6438517111355;4874.561289483928;4899.975500122477;4499.662525310549;4500.842470513517;4506.256467682796;4509.909801803946;4576.656750743708;4947.158982972904;4950.381202349707;4996.225585034325;5007.098722229961;5008.1486147355035;4745.288206768943;4749.4775574686755;4752.453467851241;4755.310479980452;4808.08646357198;4709.905801883943;4763.261694437368;4818;4823.831165909247;4869.123557759566;4731.503192164842;4756.881077973009;4773.236282194832;4776.283557466339;4783.091212669582;4746.121967436035;4782.665213435096;4805.7597120143855;4843.346148270009;4883.731394773322;4170.72890262132;4184.937225941613;4188.727732697426;4199.0552125772065;4223.619874211336;3640.5449318835144;3666.7066634669163;3692.4276737105793;3703.5370578677666;3735.3276410246417;4078.632923036941;4126.607972242632;4128.422020917074;4175.039740859619;4235.2800023996;4812.422509298906;4832.540908613676;4837.201861692782;4837.95162048382;4901.387326584177;4146.647534959562;4152.563980782034;4153.335466325434;4203.726757760735;4206.768627725443;4271.5941985511945;4373.9125217495475;4379.605835474823;4380.561943805594;4433.844815431445;4425.756583387816;4482.103579284091;4497.078098989634;4512.4133862597655;4522.3442600823355;4846.39420072491;4846.975765121293;4848.5636292733825;4896.2410826321975;4907.312976183266;4476.597106260452;4499.302608095751;4514.593686568224;4517.50307466185;4577.29051996941;4650.4186976627925;4651.232546629768;4696.178168820511;4760.452547957029;4777.570018698334;4802.351682522814;4809.759512024455;4811.3264143019305;4815.518448155157;4816.686915350491;4689.718616882998;4724.645651576215;4763.499832517536;4777.259524773665;4817.566419022165;4760.857174284777;4762.571368576845;4764.047190561971;4813.181759100891;4822.107910036654;4610.2623580227;4642.976785116053;4644.164050470948;4648.488666246778;4706.435227772689;4628.9537104628525;4669.906601868011;4672.08894265615;4678.789454474489;4735.147673418817;4652.604528615106;4676.532346765296;4730.408698912636;4731.810727570859;4734.195186818318 04:50:02 INFO - PROCESS | 25403 | |1;ext.html;563.1102857485171;568.7241687781425;570.2899889637403;578.8914229250985;582.9038208695565;27383;30158.84920575397;37823.62176378236;38463.230735385274;38981;38441.80779096107;38734.22531549367;38766;38785.612143878556;38861.22277554447;7538.698452061911;7711.730089446871;7720.575368354738;7720.729774457867;7723.111842138142;7563.319301262885;7655.081390233152;7668.693252269903;7671.846563068735;7674.577898215596;7664.3904779996265;7669.884951725729;7695.615219239044;7711.768646940601;7711.845763084735;7604.201558836326;7611.923880761177;7635.389168866477;7637.8854317185005;7652.426068044919;7599.430042746816;7640.350570201484;7654;7654.234576542357;7663.425243106733;37200.25599488022;37443.25113497742;37548.43677344842;37552;37552.81223593865;2877.5252083406212;2901.823463287;3061.770367222467;3173.666764989666;3270.9532949456184;27469.587956180672;27741.58387624187;28020.299492512648;28116.859415702995;28770;3212.983935080333;3264.5592844965863;3281.803091814475;3317.7345812334956;3318.4856347266214;232670;233291;233662;233712.83143584343;234870;30189.396212075637;49823.50176498261;50177.24734128991;50211.73623714447;50214.24678629824;32735.83632081824;32885.17787055295;32893.67106328954;33010.66989330076;33049.3390132196;12082.516699331929;12252.264864108181;12256.754864902652;12260.754784904251;12260.81608775869;9879.357841740264;9987;10008.64969726056;10016.749581260527;10022.799544009225;7699.191584883619;7751.999288263259;7763.883541746878;7829.530228186327;7830.647620857075;2984.8358340291493;3010.6086208792717;3021.2748940254182;3047.7714171437233;3089.5211242257487;821.7863355527486;829.6391069884498;849.1890244816186;853.0744142605342;860.694453469022;26132.86933565358;26750.732492674822;26927.461450771265;27006.86496567544;27358.17925462239;750.2047829300958;829.369679043919;900.5497251374313;933.0249888866151;935.5322338830584;13394.933025335005;14303;14330.785038224434;14649.726098604493;14706.191159486118;340825;344913;345534;345795;346455;48093;48432.75783621059;48525.5147448521;48539.271910921365;48647.5135248643;1013.3565186106875;1052.3528030261486;1080.2168427889717;1116.8883111688765;1159.9536018559331;24711.50576988486;28300.71699282981;28737.712622873503;28926.276843079093;28954.7104528952;40506.39240411337;40879.38680919729;41079;41104.794476027426;41104.794476027426;274260;274931;275914;276060;276407;23820.642690359313;24530;24888.50222995494;24924.875375623007;25675.486490270465;40249.396259056724;40602;40837.38743918903;40848.18303633851;41487.377689334084;34161.31677366488;34267.82866085654;34422.82788586041;34551.65448345484;34585.48121778125;34078.65921340755;34307;34696;34728.826355868056;34749.47875781815;33456.832715836266;34072.65927340794;34885.65114348925;35376.98591239444;35483.467747984316;29894;31526.842365788023;32331.19172020718;32391.19022024374;32405.51391729173;24470;24824;24854.627180592666;25148.62277065809;25254.49491010206 04:50:02 INFO - PROCESS | 25403 | |2;jquery.html;327.8295286451044;335.7934870054916;337.5274615538246;348.74541584643197;371.21117625046776;11927.403629818507;12825.807612885803;15545.300461479232;16313.83686163138;17619.207135678895;15352.769708454382;15481.14853683047;15907.363705451768;16712.41506547271;16754.66490670186;3728.4966529518574;4849.296851956464;5061.038402703493;5064.822731204408;5069.746512674352;4934.383202099738;4990.625703072266;5005.974970125144;5022.221555658879;5028.723420211887;4922.040528059967;4974.97512512437;4981.9252711209365;4984.501549845005;4988;4861.635377346695;5050.090983622965;5059.74701264939;5066.088104141253;5073.873153171164;4523.982104026601;4524.981879077214;4530.524294949048;4531.728096314232;4531.750753708545;19448.22207111714;20233.595328093503;20424;20521.692174617394;20664.483387915272;1840.6042700819255;1871.2421469304954;1873.990630046841;1906.20892329683;1982.2566537548419;12256.754864902652;13063.738725225443;13471.393787279596;13632.250226237553;13900.443982240698;1680.2438902493805;1681.2602454919795;1733.7919449666122;1751.6671832351813;1788.6154476787553;66263;68380;68493;69844.30155698428;71165.64417177932;9286.95356523213;9387.57755900986;9512.667056652985;9519.571619277149;9622.230221582256;12858.164219325901;12934.960284333174;12956.222626642431;12982.15615984958;12984.350782460839;6884.759033433806;7054.823629409203;7078.690442268196;7081.256468070881;7150.7497237596435;6657.966710166418;6681.198256209286;6835.384815366541;6850.828729281808;6929.203141638675;5664.54683625309;5886.440788125121;5961.642301461926;6062.150534410681;6161.44546990773;1648.2335713893096;1701.7957845058672;1712.8201538838491;1736.1145815634118;1770.5131088950384;787.0987719061642;840.4495055738502;855.9957200214084;894.7923087630061;902.6254104546671;16725.91637041807;16804.243809028623;17181.57046073858;17325.133743313036;17948.461546153638;813.2721214512977;840.5671079394117;848.4824257203101;897.4929165021741;901.693424235763;9952.15406690425;10062.849057264148;10101.292909496411;10146.695599132037;10156.187504999582;290793;294776;295209;391454;392959;74825.12937176506;81120;82685.58657206675;83643.5817820907;83999;899.7975455522455;906.1074841281333;940.2759874896292;941.8634298026748;948.5873644964463;11444.370559619301;15773.417872951512;15854.60363490922;16086.517404477885;16208.270627822012;34969.30061398707;35377.64622353847;36580.81709591435;36736;36804.81597591995;46108.53891461177;46112;46244.76877615725;46386;48265;7071.292870712888;7233.674484648309;7352.338289553966;7356.8896466554115;7478.850422991619;10548.367097974146;11534.826977595176;11683.415829208676;11881.346525941157;12086.637400877988;9378;9638.518074096128;9817.361871478332;10100.141487973604;10132.44271565071;9590.568424421057;9636.180924621485;9862;10011.299209055296;10088.546015429176;9140.588673509576;9562.713118606453;9578.521073946415;9720.76422422861;10048.346857454242;7044.225135235018;7083.256258092826;7089.751858685127;7170.641467926478;7231.385332246818;7575.221238938053;9419;9733.610655573697;9997.250206234416;10006.549705263134 04:50:02 INFO - PROCESS | 25403 | |3;mootools.html;1312.2979206124721;1378.8138601288822;1384.750744865924;1602.6394061336193;1638.5493989152974;6771.661416929159;7342.339189472947;7352.889706654404;7369.152547457044;7378.704851805921;6100.572959892809;6312.526560507958;6824;7025.437964962804;7060.646967651623;2082.4377418097065;2109.599176156533;2113.355426594888;2114.9742374948137;2125.4580082079046;2050.5776205393763;2077.3041031254547;2085.593309304686;2086.885221312827;2094.5706130243266;1754.4911975527145;1827.168638269584;1983.6032793441298;2067.1318046420465;2069.265410779174;2071.3785864240745;2084.9687254691194;2090.4146838885135;2091.1217288738844;2093.1836583732356;2071.979280207194;2105.463106907744;2108.019770806567;2109.514811593342;2115.2279418012467;7045.084139061941;7088.362047415757;7090.574565526085;7110.680019399139;7232.638368081575;4282.379055037033;4404.867853964386;4409.272470042439;4409.757463339515;4415.624671902892;2775.972240277612;2825.4490374377006;2897.6233089698417;2908.2583941095095;2916.970830291691;840.8066144786733;888.9111088891124;907.63694522191;909.6315992023241;919.7562645898843;9289.628414863397;9351.111644393839;9363;9374.250059995184;9375.76560585984;3626.601073881871;3844;3931.0958479549863;3935.8622448214746;3987.322155233617;8163.959180204061;8169.5098294102545;8173.386995975326;8173.877391839127;8176.3867709920805;4443.755593442327;4445.555444455528;4446.755428451466;4448.266036104006;4449.844255451044;4032.5564187939303;4081.0409553754844;4082.408050832672;4084.6936479764136;4085.428040074392;3406.233597440556;3493.47597860323;3521.5950165730756;3543.3976224041976;3564.1624218308675;1090.7273181704575;1111.6053800900725;1113.281933153128;1121.2039451989017;1145.8395824584566;569.3509399284818;608.695652173913;724.873147199238;762.3367670126914;773.4585789947059;4610.792514336863;4676.929846052312;4736.265878788793;4757.476677565465;4870.342503762017;825.2490233887133;829.2785276809215;830.4145577367941;831.7296878514386;847.1570787066908;3342.38165939302;3343.4316166251797;3382.424987752088;3409.3863104640905;3529.9294014119573;8258.504489730636;8558.272546833588;8614.138586141336;8641.913580864237;8653;8581.613827377783;8585.871211931826;8587.828243435097;8591.871121933176;8595.14048595148;6548.476121910236;6623.370779775913;6642;6652.501062420338;6711.63086030273;4468.084042771289;4485.775711214492;4536.546345365437;4554.635629149726;4691.5308469152815;7785.688572457265;7855.7250496232355;7861.292483676497;7876.369890408868;7922.366210703015;8022.558759268296;8047.758567242992;8088.919110809052;8129.674813007414;8141.633626486704;6056.182415373868;6168.599041062316;6180.165677633462;6203.410675985774;6216.875662486635;6501.73993040292;6563.901541476786;6638.369354911276;6643.900341494978;6646.60120392778;4935.284383764406;6088.4215999479975;6140.692965351625;6206.565540412308;6231.501479881689;6058.3335833057445;6121.112438696453;6126.264848218064;6169.321374648875;6212.534059945612;5398.703071330958;5484.643498172606;5497.8075767347955;5505.752241149078;5509.449055094458;4076.857309994136;4140.8136633852155;4185.16296740647;4239.554846741171;4336.457942757155;3936.4882565267476;4085;4094.5495995441074;4177.91644167121;4250.426192464101 04:50:02 INFO - PROCESS | 25403 | |4;prototype.html;283.3242716122047;286.7075582905436;294.3832670555186;295.14555362226355;298.1294619710445;4664.626829853612;4789.832355867546;4891.144049791285;4920.696015555876;4975.950240497598;4642;4719.386479757635;4753.382060332152;4783.808647654098;4788.736619485927;3743.3449146399407;3754.911075788018;3760.0787806987328;3760.2103558252797;3761.4169803680475;3529.7176225901867;3755.43668449732;3756.417755247941;3764.5106136202257;3788.9621103788886;3314.237725323177;3576.874809381672;3706.629337066299;3736.5142531471006;3738.9252214955686;3701.407774756053;3706.5366829146355;3725.5343082114737;3729.4965179700666;3738.4205448155444;3265.346930613887;3286.7041966222914;3288.5530366638604;3296.2583418730833;3297.5218593303834;4496.640268778523;4648.5119062498625;4673.252279635276;4723.36234608327;4747.311639812242;4275.850345237933;4283.400323954649;4287.678424118172;4296.119295544406;4308.879691280258;4950.603951683856;5034.697918124924;5040;5041.924371134399;5056.241563765428;3357.5970883494138;3580.4629305604367;3597.838097285602;3600.981995090034;3604.891853244407;5219.269302297644;5266.3943646480375;5274.92087618686;5285.022270879861;5285.577153827685;3625.5286812714708;3625.927481450356;3629.292288003814;3630.146915474861;3646.7447278690765;3685.94471082934;3701.370766969622;3704.481372607837;3706.7590606610484;3722.8696995605565;4124.8143833527565;4177.4778152730905;4208.200441916026;4241.960719623712;4253.340732186516;5063.139266324733;5067.214581739836;5075.390953085654;5089.720065396365;5100.591952643779;1171.2562522798085;1193.2959553863263;1223.7613665335175;1252.7745005898844;1255.9120861539604;848.6690190825583;849.2526576612541;863.2317237658489;873.4279047223952;879.4195830751673;4398.670099742532;4408.677396780953;4414.84548040817;4415.92451547772;4420.270655341897;5109.718965456936;5133.665247035723;5158.303629010111;5169.276301317818;5174.637775355689;4358.56414358568;4385.758783266951;4395.670324725658;4398.570464599018;4407.382966384709;2311.6301391777233;2399.880005999693;2401.951960960771;2451.3626457121277;2465.6917885264343;4262.296721041055;4273.401723758676;4295.241663544399;4297.763623000765;4301.07526881722;4607.631389488833;4633.258678611406;4639.956009897746;4648.862018137744;4657.278121891112;4078.4494093297617;4185.288500954845;4203.033302340417;4214.1150358425075;4280.810795957032;4552.429411852905;4553.3397657340165;4564.744695208844;4566.794494247833;4575.679702420799;4463.732176069446;4470.396496472935;4482.8879278017;4514.45826500822;4533.863984080483;4052.979735101306;4184.330507118846;4231.413220042484;4238.1523695261685;4247.681423893282;3284.9671503284662;3286.260591366923;3305.471124620049;3309.9809116439433;3323.9501407479393;4615.515370886143;4637.744924029211;4645.674802763774;4653.720226937619;4932.654714169974;4798.184308667465;4963.975180124076;5033.345665063518;5046.621503387334;5049.9495005049475;5007.349044624321;5011.498850114959;5020.945601423596;5024.66353145789;5040.4455509894615;4693.2021556336185;4896.853094407031;4911.778969946433;4917.409910810583;4944.802207911644;5015.943463180079;5046.924296135634;5074.564209179541;5077.34986129502;5084.847454576368;4956.752162391794;4967.180415231591;4973.776180071978;4987.775550100182;5007.974960125176 04:50:02 INFO - PROCESS | 25403 | |5;yui.html;602.1660000898754;643.2988043033093;673.9224989126249;690.3234829866727;694.4305669351131;12372.938135309321;13468.797968030487;13518.188908665486;13550.661233469169;13572.932135339322;12135.939320303409;12234.44944977476;12243.32661703606;12249.142560020802;12249.510019599227;616.1620196532712;631.4380201620561;739.6190961654738;748.9662965166553;759.6847308367021;764.1250767870785;771.294265746841;771.5293670860771;771.9459637825355;772.0272456704564;818.5007145641184;825.8678611422174;826.1696994520498;826.4751882554561;827.185222555782;650.7397041183517;664.3920812456596;784.3137254901961;797.366093955307;821.5686764448652;595.8986972214691;596.0790578556098;596.1564386393248;596.263614436171;596.5347029317096;12461.376931153405;12475.126741128124;12503.74992500154;12503.874961250453;12504.937475312565;11963.820542691867;12233;12350.258984460961;12694.238345699288;12845.421956011909;11326.660200194008;11403.828942565868;11701.771314012076;11774.293542387484;12301.384930753427;3985.143194213229;4003.4395184674167;4058.492688413948;4084.3712414142765;4135.400366946806;60485.39514604842;60514;60825.391746082416;60833.695831521;60840;9483.288753343526;9708.223342132613;10181.389116653025;10412.32319899204;10486.318389304672;17915.552111197325;18426.35507757222;18453.72319415183;18518;18566.628667426576;6531.216254049449;6612.86774264512;6669.633170175687;6679.56582822115;6714.932850671528;3601.441776524643;3613.1328481164855;3637.181634132352;3693.171949361548;3712.1462063725494;2494.550980823433;2579.3551612096976;2579.7162312145647;2581.0966161843203;2971.3314504236373;470.52947052947053;473.15777915310116;474.2270099737406;478.5668969582464;479.9592034677022;428.5757100470512;509.88782467857754;553.177803616927;569.93635379743;579.9333076696234;7951.284384405431;8022.4785388950695;8121.715739949192;8251.677667904169;8344.791380215422;565.9094544872801;570.7231992483643;584.6842704939285;588.7233000489763;606.3633185155658;3676.6690997810324;3975.2447035063824;4059.4722686050623;4079.9592004080173;4164.416981622575;77663.61168194123;99421.50289248652;99694.5015274919;102182;102479.48760256151;76328.61835690786;83124.58437707773;84971.5751421239;85781;87442.56278718566;73815.26184738192;76850.61574692202;77033.61483192549;77461.6126919373;78883.60558197173;7273.054502914587;7403.925960740324;7407.333339999426;7530.472866899265;7568.167501574712;44356.556434435246;45484.77257613691;45638.06705128312;45647.77176114098;47611;57942.710286448295;62426.37573624206;67045.32954670391;67706.32293677;69474.30525694678;9228.584713687766;9320.207782338577;9392.389494682824;9402.623895044122;9550.522473876417;10874.510647021061;10903.78192436131;10970.616028438966;11190.272632278877;12646;10805.783884322427;11186.608468703556;11190.88809111931;11269.830952535554;11964.341961191869;11721.589744358907;12548.811767823307;12675.746485070062;12900.354982251038;13082.149660272053;11302.095832333558;11866.228695134789;12361.814572781235;12760.234385936874;12819.102662813513;9793.45370203738;9991.850122248317;10287.794244115226;10655.25413221067;10843.67468975932;9158.633654653739;9554.035240048359;9963.701088967342;10024.849627255451;10030.64892728751 04:50:02 INFO - PROCESS | 25403 | __end_tp_report 04:50:02 INFO - PROCESS | 25403 | __start_cc_report 04:50:02 INFO - PROCESS | 25403 | _x_x_mozilla_cycle_collect,1969 04:50:02 INFO - PROCESS | 25403 | __end_cc_report 04:50:02 INFO - PROCESS | 25403 | __startTimestamp1476445802012__endTimestamp 04:50:02 INFO - PROCESS | 25403 | 04:50:02 INFO - PROCESS | 25403 | ------- Summary: start ------- 04:50:02 INFO - PROCESS | 25403 | Number of tests: 6 04:50:02 INFO - PROCESS | 25403 | 04:50:02 INFO - PROCESS | 25403 | [#0] dojo.html Cycles:165 Average:4477.50 Median:4577.29 stddev:450.66 (9.8%) stddev-sans-first:425.95 04:50:02 INFO - PROCESS | 25403 | Values: 2551.0 2564.0 2565.3 2605.0 2617.8 4395.4 4480.8 4529.0 4540.2 4546.3 4528.0 4531.1 4539.1 4552.2 4560.1 4149.7 4173.5 4184.4 4216.7 4232.9 4143.7 4179.8 4183.1 4184.1 4187.3 4149.4 4152.4 4164.9 4202.7 4217.9 4191.4 4204.1 4205.7 4223.9 4252.1 4056.1 4096.7 4140.0 4142.6 4203.7 4531.4 4542.6 4547.4 4609.8 4621.3 4839.9 4851.9 4869.8 4870.0 4918.6 4697.3 4746.3 4748.6 4874.6 4900.0 4499.7 4500.8 4506.3 4509.9 4576.7 4947.2 4950.4 4996.2 5007.1 5008.1 4745.3 4749.5 4752.5 4755.3 4808.1 4709.9 4763.3 4818.0 4823.8 4869.1 4731.5 4756.9 4773.2 4776.3 4783.1 4746.1 4782.7 4805.8 4843.3 4883.7 4170.7 4184.9 4188.7 4199.1 4223.6 3640.5 3666.7 3692.4 3703.5 3735.3 4078.6 4126.6 4128.4 4175.0 4235.3 4812.4 4832.5 4837.2 4838.0 4901.4 4146.6 4152.6 4153.3 4203.7 4206.8 4271.6 4373.9 4379.6 4380.6 4433.8 4425.8 4482.1 4497.1 4512.4 4522.3 4846.4 4847.0 4848.6 4896.2 4907.3 4476.6 4499.3 4514.6 4517.5 4577.3 4650.4 4651.2 4696.2 4760.5 4777.6 4802.4 4809.8 4811.3 4815.5 4816.7 4689.7 4724.6 4763.5 4777.3 4817.6 4760.9 4762.6 4764.0 4813.2 4822.1 4610.3 4643.0 4644.2 4648.5 4706.4 4629.0 4669.9 4672.1 4678.8 4735.1 4652.6 4676.5 4730.4 4731.8 4734.2 04:50:02 INFO - PROCESS | 25403 | 04:50:02 INFO - PROCESS | 25403 | [#1] ext.html Cycles:180 Average:42690.23 Median:190042.83 stddev:75808.67 (39.9%) stddev-sans-first:75955.35 04:50:02 INFO - PROCESS | 25403 | Values: 563.1 568.7 570.3 578.9 582.9 27383.0 30158.8 37823.6 38463.2 38981.0 38441.8 38734.2 38766.0 38785.6 38861.2 7538.7 7711.7 7720.6 7720.7 7723.1 7563.3 7655.1 7668.7 7671.8 7674.6 7664.4 7669.9 7695.6 7711.8 7711.8 7604.2 7611.9 7635.4 7637.9 7652.4 7599.4 7640.4 7654.0 7654.2 7663.4 37200.3 37443.3 37548.4 37552.0 37552.8 2877.5 2901.8 3061.8 3173.7 3271.0 27469.6 27741.6 28020.3 28116.9 28770.0 3213.0 3264.6 3281.8 3317.7 3318.5 232670.0 233291.0 233662.0 233712.8 234870.0 30189.4 49823.5 50177.2 50211.7 50214.2 32735.8 32885.2 32893.7 33010.7 33049.3 12082.5 12252.3 12256.8 12260.8 12260.8 9879.4 9987.0 10008.6 10016.7 10022.8 7699.2 7752.0 7763.9 7829.5 7830.6 2984.8 3010.6 3021.3 3047.8 3089.5 821.8 829.6 849.2 853.1 860.7 26132.9 26750.7 26927.5 27006.9 27358.2 750.2 829.4 900.5 933.0 935.5 13394.9 14303.0 14330.8 14649.7 14706.2 340825.0 344913.0 345534.0 345795.0 346455.0 48093.0 48432.8 48525.5 48539.3 48647.5 1013.4 1052.4 1080.2 1116.9 1160.0 24711.5 28300.7 28737.7 28926.3 28954.7 40506.4 40879.4 41079.0 41104.8 41104.8 274260.0 274931.0 275914.0 276060.0 276407.0 23820.6 24530.0 24888.5 24924.9 25675.5 40249.4 40602.0 40837.4 40848.2 41487.4 34161.3 34267.8 34422.8 34551.7 34585.5 34078.7 34307.0 34696.0 34728.8 34749.5 33456.8 34072.7 34885.7 35377.0 35483.5 29894.0 31526.8 32331.2 32391.2 32405.5 24470.0 24824.0 24854.6 25148.6 25254.5 04:50:02 INFO - PROCESS | 25403 | 04:50:02 INFO - PROCESS | 25403 | [#2] jquery.html Cycles:180 Average:22554.86 Median:26557.15 stddev:56081.63 (211.2%) stddev-sans-first:56214.12 04:50:02 INFO - PROCESS | 25403 | Values: 327.8 335.8 337.5 348.7 371.2 11927.4 12825.8 15545.3 16313.8 17619.2 15352.8 15481.1 15907.4 16712.4 16754.7 3728.5 4849.3 5061.0 5064.8 5069.7 4934.4 4990.6 5006.0 5022.2 5028.7 4922.0 4975.0 4981.9 4984.5 4988.0 4861.6 5050.1 5059.7 5066.1 5073.9 4524.0 4525.0 4530.5 4531.7 4531.8 19448.2 20233.6 20424.0 20521.7 20664.5 1840.6 1871.2 1874.0 1906.2 1982.3 12256.8 13063.7 13471.4 13632.3 13900.4 1680.2 1681.3 1733.8 1751.7 1788.6 66263.0 68380.0 68493.0 69844.3 71165.6 9287.0 9387.6 9512.7 9519.6 9622.2 12858.2 12935.0 12956.2 12982.2 12984.4 6884.8 7054.8 7078.7 7081.3 7150.7 6658.0 6681.2 6835.4 6850.8 6929.2 5664.5 5886.4 5961.6 6062.2 6161.4 1648.2 1701.8 1712.8 1736.1 1770.5 787.1 840.4 856.0 894.8 902.6 16725.9 16804.2 17181.6 17325.1 17948.5 813.3 840.6 848.5 897.5 901.7 9952.2 10062.8 10101.3 10146.7 10156.2 290793.0 294776.0 295209.0 391454.0 392959.0 74825.1 81120.0 82685.6 83643.6 83999.0 899.8 906.1 940.3 941.9 948.6 11444.4 15773.4 15854.6 16086.5 16208.3 34969.3 35377.6 36580.8 36736.0 36804.8 46108.5 46112.0 46244.8 46386.0 48265.0 7071.3 7233.7 7352.3 7356.9 7478.9 10548.4 11534.8 11683.4 11881.3 12086.6 9378.0 9638.5 9817.4 10100.1 10132.4 9590.6 9636.2 9862.0 10011.3 10088.5 9140.6 9562.7 9578.5 9720.8 10048.3 7044.2 7083.3 7089.8 7170.6 7231.4 7575.2 9419.0 9733.6 9997.3 10006.5 04:50:02 INFO - PROCESS | 25403 | 04:50:02 INFO - PROCESS | 25403 | [#3] mootools.html Cycles:180 Average:4666.51 Median:5166.99 stddev:2520.39 (48.8%) stddev-sans-first:2514.86 04:50:02 INFO - PROCESS | 25403 | Values: 1312.3 1378.8 1384.8 1602.6 1638.5 6771.7 7342.3 7352.9 7369.2 7378.7 6100.6 6312.5 6824.0 7025.4 7060.6 2082.4 2109.6 2113.4 2115.0 2125.5 2050.6 2077.3 2085.6 2086.9 2094.6 1754.5 1827.2 1983.6 2067.1 2069.3 2071.4 2085.0 2090.4 2091.1 2093.2 2072.0 2105.5 2108.0 2109.5 2115.2 7045.1 7088.4 7090.6 7110.7 7232.6 4282.4 4404.9 4409.3 4409.8 4415.6 2776.0 2825.4 2897.6 2908.3 2917.0 840.8 888.9 907.6 909.6 919.8 9289.6 9351.1 9363.0 9374.3 9375.8 3626.6 3844.0 3931.1 3935.9 3987.3 8164.0 8169.5 8173.4 8173.9 8176.4 4443.8 4445.6 4446.8 4448.3 4449.8 4032.6 4081.0 4082.4 4084.7 4085.4 3406.2 3493.5 3521.6 3543.4 3564.2 1090.7 1111.6 1113.3 1121.2 1145.8 569.4 608.7 724.9 762.3 773.5 4610.8 4676.9 4736.3 4757.5 4870.3 825.2 829.3 830.4 831.7 847.2 3342.4 3343.4 3382.4 3409.4 3529.9 8258.5 8558.3 8614.1 8641.9 8653.0 8581.6 8585.9 8587.8 8591.9 8595.1 6548.5 6623.4 6642.0 6652.5 6711.6 4468.1 4485.8 4536.5 4554.6 4691.5 7785.7 7855.7 7861.3 7876.4 7922.4 8022.6 8047.8 8088.9 8129.7 8141.6 6056.2 6168.6 6180.2 6203.4 6216.9 6501.7 6563.9 6638.4 6643.9 6646.6 4935.3 6088.4 6140.7 6206.6 6231.5 6058.3 6121.1 6126.3 6169.3 6212.5 5398.7 5484.6 5497.8 5505.8 5509.4 4076.9 4140.8 4185.2 4239.6 4336.5 3936.5 4085.0 4094.5 4177.9 4250.4 04:50:02 INFO - PROCESS | 25403 | 04:50:02 INFO - PROCESS | 25403 | [#4] prototype.html Cycles:180 Average:4030.24 Median:4408.03 stddev:1175.56 (26.7%) stddev-sans-first:1144.72 04:50:02 INFO - PROCESS | 25403 | Values: 283.3 286.7 294.4 295.1 298.1 4664.6 4789.8 4891.1 4920.7 4976.0 4642.0 4719.4 4753.4 4783.8 4788.7 3743.3 3754.9 3760.1 3760.2 3761.4 3529.7 3755.4 3756.4 3764.5 3789.0 3314.2 3576.9 3706.6 3736.5 3738.9 3701.4 3706.5 3725.5 3729.5 3738.4 3265.3 3286.7 3288.6 3296.3 3297.5 4496.6 4648.5 4673.3 4723.4 4747.3 4275.9 4283.4 4287.7 4296.1 4308.9 4950.6 5034.7 5040.0 5041.9 5056.2 3357.6 3580.5 3597.8 3601.0 3604.9 5219.3 5266.4 5274.9 5285.0 5285.6 3625.5 3625.9 3629.3 3630.1 3646.7 3685.9 3701.4 3704.5 3706.8 3722.9 4124.8 4177.5 4208.2 4242.0 4253.3 5063.1 5067.2 5075.4 5089.7 5100.6 1171.3 1193.3 1223.8 1252.8 1255.9 848.7 849.3 863.2 873.4 879.4 4398.7 4408.7 4414.8 4415.9 4420.3 5109.7 5133.7 5158.3 5169.3 5174.6 4358.6 4385.8 4395.7 4398.6 4407.4 2311.6 2399.9 2402.0 2451.4 2465.7 4262.3 4273.4 4295.2 4297.8 4301.1 4607.6 4633.3 4640.0 4648.9 4657.3 4078.4 4185.3 4203.0 4214.1 4280.8 4552.4 4553.3 4564.7 4566.8 4575.7 4463.7 4470.4 4482.9 4514.5 4533.9 4053.0 4184.3 4231.4 4238.2 4247.7 3285.0 3286.3 3305.5 3310.0 3324.0 4615.5 4637.7 4645.7 4653.7 4932.7 4798.2 4964.0 5033.3 5046.6 5049.9 5007.3 5011.5 5020.9 5024.7 5040.4 4693.2 4896.9 4911.8 4917.4 4944.8 5015.9 5046.9 5074.6 5077.3 5084.8 4956.8 4967.2 4973.8 4987.8 5008.0 04:50:02 INFO - PROCESS | 25403 | 04:50:02 INFO - PROCESS | 25403 | [#5] yui.html Cycles:180 Average:17717.63 Median:494.92 stddev:25485.65 (5149.4%) stddev-sans-first:25524.74 04:50:02 INFO - PROCESS | 25403 | Values: 602.2 643.3 673.9 690.3 694.4 12372.9 13468.8 13518.2 13550.7 13572.9 12135.9 12234.4 12243.3 12249.1 12249.5 616.2 631.4 739.6 749.0 759.7 764.1 771.3 771.5 771.9 772.0 818.5 825.9 826.2 826.5 827.2 650.7 664.4 784.3 797.4 821.6 595.9 596.1 596.2 596.3 596.5 12461.4 12475.1 12503.7 12503.9 12504.9 11963.8 12233.0 12350.3 12694.2 12845.4 11326.7 11403.8 11701.8 11774.3 12301.4 3985.1 4003.4 4058.5 4084.4 4135.4 60485.4 60514.0 60825.4 60833.7 60840.0 9483.3 9708.2 10181.4 10412.3 10486.3 17915.6 18426.4 18453.7 18518.0 18566.6 6531.2 6612.9 6669.6 6679.6 6714.9 3601.4 3613.1 3637.2 3693.2 3712.1 2494.6 2579.4 2579.7 2581.1 2971.3 470.5 473.2 474.2 478.6 480.0 428.6 509.9 553.2 569.9 579.9 7951.3 8022.5 8121.7 8251.7 8344.8 565.9 570.7 584.7 588.7 606.4 3676.7 3975.2 4059.5 4080.0 4164.4 77663.6 99421.5 99694.5 102182.0 102479.5 76328.6 83124.6 84971.6 85781.0 87442.6 73815.3 76850.6 77033.6 77461.6 78883.6 7273.1 7403.9 7407.3 7530.5 7568.2 44356.6 45484.8 45638.1 45647.8 47611.0 57942.7 62426.4 67045.3 67706.3 69474.3 9228.6 9320.2 9392.4 9402.6 9550.5 10874.5 10903.8 10970.6 11190.3 12646.0 10805.8 11186.6 11190.9 11269.8 11964.3 11721.6 12548.8 12675.7 12900.4 13082.1 11302.1 11866.2 12361.8 12760.2 12819.1 9793.5 9991.9 10287.8 10655.3 10843.7 9158.6 9554.0 9963.7 10024.8 10030.6 04:50:02 INFO - PROCESS | 25403 | -------- Summary: end -------- 04:50:02 INFO - PROCESS | 25403 | 04:50:03 INFO - TEST-INFO | 25403: exit 0 04:50:03 INFO - TEST-OK | dromaeo_css | took 1122594ms 04:50:03 INFO - TEST-START | kraken 04:50:03 INFO - operating with platform_type : linux_ 04:50:03 INFO - Initialising browser for kraken test... 04:50:03 INFO - TEST-INFO | started process 25708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQBtUvW/profile http://localhost:60552/getInfo.html) 04:50:07 INFO - PROCESS | 25708 | __metrics Screen width/height:1600/1200 04:50:07 INFO - PROCESS | 25708 | colorDepth:24 04:50:07 INFO - PROCESS | 25708 | Browser inner width/height: 1024/697 04:50:07 INFO - PROCESS | 25708 | __metrics 04:50:07 INFO - PROCESS | 25708 | 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" 04:50:07 INFO - PROCESS | 25708 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:08 INFO - PROCESS | 25708 | console.error: PushService: 04:50:08 INFO - PROCESS | 25708 | stateChangeProcessEnqueue: Error transitioning state 04:50:08 INFO - PROCESS | 25708 | UnknownError 04:50:09 INFO - TEST-INFO | 25708: exit 0 04:50:09 INFO - Browser initialized. 04:50:09 INFO - Running cycle 1/1 for kraken test... 04:50:09 INFO - TEST-INFO | started process 25788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQBtUvW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:21 INFO - PROCESS | 25788 | RSS: Main: 173895680 04:50:21 INFO - PROCESS | 25788 | 04:50:24 INFO - PROCESS | 25788 | Cycle 1(1): loaded http://localhost:60552/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60552/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:25 INFO - PROCESS | 25788 | RSS: Main: 238338048 04:50:25 INFO - PROCESS | 25788 | 04:50:28 INFO - PROCESS | 25788 | Cycle 1(1): loaded http://localhost:60552/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60552/tests/kraken/driver.html?testName=audio-dft) 04:50:28 INFO - PROCESS | 25788 | RSS: Main: 217583616 04:50:28 INFO - PROCESS | 25788 | 04:50:31 INFO - PROCESS | 25788 | Cycle 1(1): loaded http://localhost:60552/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60552/tests/kraken/driver.html?testName=audio-fft) 04:50:32 INFO - PROCESS | 25788 | RSS: Main: 299839488 04:50:32 INFO - PROCESS | 25788 | 04:50:34 INFO - PROCESS | 25788 | Cycle 1(1): loaded http://localhost:60552/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60552/tests/kraken/driver.html?testName=audio-oscillator) 04:50:35 INFO - PROCESS | 25788 | RSS: Main: 210042880 04:50:35 INFO - PROCESS | 25788 | 04:50:37 INFO - PROCESS | 25788 | Cycle 1(1): loaded http://localhost:60552/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60552/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:50:38 INFO - PROCESS | 25788 | RSS: Main: 212840448 04:50:38 INFO - PROCESS | 25788 | 04:50:41 INFO - PROCESS | 25788 | Cycle 1(1): loaded http://localhost:60552/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60552/tests/kraken/driver.html?testName=imaging-darkroom) 04:50:41 INFO - PROCESS | 25788 | RSS: Main: 249466880 04:50:41 INFO - PROCESS | 25788 | 04:50:45 INFO - PROCESS | 25788 | Cycle 1(1): loaded http://localhost:60552/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60552/tests/kraken/driver.html?testName=imaging-desaturate) 04:50:45 INFO - PROCESS | 25788 | RSS: Main: 248659968 04:50:45 INFO - PROCESS | 25788 | 04:50:48 INFO - PROCESS | 25788 | Cycle 1(1): loaded http://localhost:60552/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60552/tests/kraken/driver.html?testName=json-parse-financial) 04:50:49 INFO - PROCESS | 25788 | RSS: Main: 248094720 04:50:49 INFO - PROCESS | 25788 | 04:50:51 INFO - PROCESS | 25788 | Cycle 1(1): loaded http://localhost:60552/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60552/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:50:51 INFO - PROCESS | 25788 | RSS: Main: 210866176 04:50:51 INFO - PROCESS | 25788 | 04:50:53 INFO - PROCESS | 25788 | Cycle 1(1): loaded http://localhost:60552/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60552/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:50:54 INFO - PROCESS | 25788 | RSS: Main: 218595328 04:50:54 INFO - PROCESS | 25788 | 04:50:56 INFO - PROCESS | 25788 | Cycle 1(1): loaded http://localhost:60552/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60552/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:50:56 INFO - PROCESS | 25788 | RSS: Main: 227155968 04:50:56 INFO - PROCESS | 25788 | 04:50:59 INFO - PROCESS | 25788 | Cycle 1(1): loaded http://localhost:60552/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60552/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:00 INFO - PROCESS | 25788 | RSS: Main: 235937792 04:51:00 INFO - PROCESS | 25788 | 04:51:03 INFO - PROCESS | 25788 | Cycle 1(1): loaded http://localhost:60552/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60552/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:04 INFO - PROCESS | 25788 | RSS: Main: 232275968 04:51:04 INFO - PROCESS | 25788 | 04:51:05 INFO - PROCESS | 25788 | Cycle 1(1): loaded http://localhost:60552/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60552/tests/kraken/driver.html?testName=ai-astar) 04:51:06 INFO - PROCESS | 25788 | RSS: Main: 282423296 04:51:06 INFO - PROCESS | 25788 | 04:51:06 INFO - PROCESS | 25788 | __start_tp_report 04:51:06 INFO - PROCESS | 25788 | _x_x_mozilla_page_load 04:51:06 INFO - PROCESS | 25788 | _x_x_mozilla_page_load_details 04:51:06 INFO - PROCESS | 25788 | |i|pagename|runs| 04:51:06 INFO - PROCESS | 25788 | |0;ai-astar;105;117;116;115;114;114;116;114;114;115 04:51:06 INFO - PROCESS | 25788 | |1;audio-beat-detection;156;127;131;169;126;126;127;133;167;131 04:51:06 INFO - PROCESS | 25788 | |2;audio-dft;161;161;162;163;163;161;163;162;161;162 04:51:06 INFO - PROCESS | 25788 | |3;audio-fft;75;75;75;112;75;76;76;75;112;75 04:51:06 INFO - PROCESS | 25788 | |4;audio-oscillator;83;83;136;84;83;83;113;82;82;116 04:51:06 INFO - PROCESS | 25788 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 04:51:06 INFO - PROCESS | 25788 | |6;imaging-darkroom;147;147;146;147;146;147;147;146;146;147 04:51:06 INFO - PROCESS | 25788 | |7;imaging-desaturate;86;85;85;85;85;85;85;85;85;85 04:51:06 INFO - PROCESS | 25788 | |8;json-parse-financial;65;65;69;64;65;68;69;67;65;66 04:51:06 INFO - PROCESS | 25788 | |9;json-stringify-tinderbox;68;67;67;68;67;68;69;68;68;67 04:51:06 INFO - PROCESS | 25788 | |10;stanford-crypto-aes;83;84;81;82;83;83;84;82;83;81 04:51:06 INFO - PROCESS | 25788 | |11;stanford-crypto-ccm;142;140;139;139;138;145;139;148;188;136 04:51:06 INFO - PROCESS | 25788 | |12;stanford-crypto-pbkdf2;178;178;175;177;173;175;173;173;179;175 04:51:06 INFO - PROCESS | 25788 | |13;stanford-crypto-sha256-iterative;70;70;69;69;68;70;70;70;69;69 04:51:06 INFO - PROCESS | 25788 | __end_tp_report 04:51:06 INFO - PROCESS | 25788 | __start_cc_report 04:51:06 INFO - PROCESS | 25788 | _x_x_mozilla_cycle_collect,1934 04:51:06 INFO - PROCESS | 25788 | __end_cc_report 04:51:06 INFO - PROCESS | 25788 | __startTimestamp1476445866166__endTimestamp 04:51:06 INFO - PROCESS | 25788 | 04:51:06 INFO - PROCESS | 25788 | ------- Summary: start ------- 04:51:06 INFO - PROCESS | 25788 | Number of tests: 14 04:51:06 INFO - PROCESS | 25788 | 04:51:06 INFO - PROCESS | 25788 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:3.33 (2.9%) stddev-sans-first:1.12 04:51:06 INFO - PROCESS | 25788 | Values: 105.0 117.0 116.0 115.0 114.0 114.0 116.0 114.0 114.0 115.0 04:51:06 INFO - PROCESS | 25788 | 04:51:06 INFO - PROCESS | 25788 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:132.00 stddev:17.52 (13.3%) stddev-sans-first:17.51 04:51:06 INFO - PROCESS | 25788 | Values: 156.0 127.0 131.0 169.0 126.0 126.0 127.0 133.0 167.0 131.0 04:51:06 INFO - PROCESS | 25788 | 04:51:06 INFO - PROCESS | 25788 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 04:51:06 INFO - PROCESS | 25788 | Values: 161.0 161.0 162.0 163.0 163.0 161.0 163.0 162.0 161.0 162.0 04:51:06 INFO - PROCESS | 25788 | 04:51:06 INFO - PROCESS | 25788 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:15.50 (20.7%) stddev-sans-first:16.19 04:51:06 INFO - PROCESS | 25788 | Values: 75.0 75.0 75.0 112.0 75.0 76.0 76.0 75.0 112.0 75.0 04:51:06 INFO - PROCESS | 25788 | 04:51:06 INFO - PROCESS | 25788 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:83.00 stddev:19.66 (23.7%) stddev-sans-first:20.41 04:51:06 INFO - PROCESS | 25788 | Values: 83.0 83.0 136.0 84.0 83.0 83.0 113.0 82.0 82.0 116.0 04:51:06 INFO - PROCESS | 25788 | 04:51:06 INFO - PROCESS | 25788 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 04:51:06 INFO - PROCESS | 25788 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 04:51:06 INFO - PROCESS | 25788 | 04:51:06 INFO - PROCESS | 25788 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:51:06 INFO - PROCESS | 25788 | Values: 147.0 147.0 146.0 147.0 146.0 147.0 147.0 146.0 146.0 147.0 04:51:06 INFO - PROCESS | 25788 | 04:51:06 INFO - PROCESS | 25788 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.32 (0.4%) stddev-sans-first:0.00 04:51:06 INFO - PROCESS | 25788 | Values: 86.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 04:51:06 INFO - PROCESS | 25788 | 04:51:06 INFO - PROCESS | 25788 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.50 stddev:1.83 (2.8%) stddev-sans-first:1.88 04:51:06 INFO - PROCESS | 25788 | Values: 65.0 65.0 69.0 64.0 65.0 68.0 69.0 67.0 65.0 66.0 04:51:06 INFO - PROCESS | 25788 | 04:51:06 INFO - PROCESS | 25788 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 04:51:06 INFO - PROCESS | 25788 | Values: 68.0 67.0 67.0 68.0 67.0 68.0 69.0 68.0 68.0 67.0 04:51:06 INFO - PROCESS | 25788 | 04:51:06 INFO - PROCESS | 25788 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:1.07 (1.3%) stddev-sans-first:1.13 04:51:06 INFO - PROCESS | 25788 | Values: 83.0 84.0 81.0 82.0 83.0 83.0 84.0 82.0 83.0 81.0 04:51:06 INFO - PROCESS | 25788 | 04:51:06 INFO - PROCESS | 25788 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:141.00 stddev:15.38 (10.9%) stddev-sans-first:16.26 04:51:06 INFO - PROCESS | 25788 | Values: 142.0 140.0 139.0 139.0 138.0 145.0 139.0 148.0 188.0 136.0 04:51:06 INFO - PROCESS | 25788 | 04:51:06 INFO - PROCESS | 25788 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:176.00 stddev:2.27 (1.3%) stddev-sans-first:2.24 04:51:06 INFO - PROCESS | 25788 | Values: 178.0 178.0 175.0 177.0 173.0 175.0 173.0 173.0 179.0 175.0 04:51:06 INFO - PROCESS | 25788 | 04:51:06 INFO - PROCESS | 25788 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 04:51:06 INFO - PROCESS | 25788 | Values: 70.0 70.0 69.0 69.0 68.0 70.0 70.0 70.0 69.0 69.0 04:51:06 INFO - PROCESS | 25788 | -------- Summary: end -------- 04:51:06 INFO - PROCESS | 25788 | 04:51:07 INFO - TEST-INFO | 25788: exit 0 04:51:07 INFO - TEST-OK | kraken | took 64437ms 04:51:07 INFO - SUITE-END | took 1187s 04:51:07 INFO - Completed test suite (00:19:47) 04:51:07 INFO - javascript benchmark 04:51:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2551.0433587404723, 2563.9615405768927, 2565.307367010907, 2604.9869750651255, 2617.8167528273016, 4395.406620106285, 4480.775961201944, 4528.977355113224, 4540.160070386981, 4546.272596384579, 4528.049109686962, 4531.116432295704, 4539.137563862863, 4552.157850797605, 4560.087982403525, 4149.7302675326155, 4173.457450531427, 4184.351425529033, 4216.7259128156575, 4232.873013809591, 4143.6685065194715, 4179.770112643803, 4183.079722461053, 4184.100418410041, 4187.288161012635, 4149.419081328617, 4152.356384760352, 4164.937525937114, 4202.684798640099, 4217.936730949038, 4191.392248124035, 4204.096119334357, 4205.705600607958, 4223.936640950373, 4252.08580155265, 4056.067104565937, 4096.692748043909, 4139.958600413987, 4142.565030671796, 4203.747775133502, 4531.388262584542, 4542.591166794971, 4547.363369128325, 4609.838655647036, 4621.306803979396, 4839.927401088987, 4851.878703032452, 4869.805207791684, 4869.951300486985, 4918.581920536759, 4697.271922851929, 4746.311784791221, 4748.6438517111355, 4874.561289483928, 4899.975500122477, 4499.662525310549, 4500.842470513517, 4506.256467682796, 4509.909801803946, 4576.656750743708, 4947.158982972904, 4950.381202349707, 4996.225585034325, 5007.098722229961, 5008.1486147355035, 4745.288206768943, 4749.4775574686755, 4752.453467851241, 4755.310479980452, 4808.08646357198, 4709.905801883943, 4763.261694437368, 4818.0, 4823.831165909247, 4869.123557759566, 4731.503192164842, 4756.881077973009, 4773.236282194832, 4776.283557466339, 4783.091212669582, 4746.121967436035, 4782.665213435096, 4805.7597120143855, 4843.346148270009, 4883.731394773322, 4170.72890262132, 4184.937225941613, 4188.727732697426, 4199.0552125772065, 4223.619874211336, 3640.5449318835144, 3666.7066634669163, 3692.4276737105793, 3703.5370578677666, 3735.3276410246417, 4078.632923036941, 4126.607972242632, 4128.422020917074, 4175.039740859619, 4235.2800023996, 4812.422509298906, 4832.540908613676, 4837.201861692782, 4837.95162048382, 4901.387326584177, 4146.647534959562, 4152.563980782034, 4153.335466325434, 4203.726757760735, 4206.768627725443, 4271.5941985511945, 4373.9125217495475, 4379.605835474823, 4380.561943805594, 4433.844815431445, 4425.756583387816, 4482.103579284091, 4497.078098989634, 4512.4133862597655, 4522.3442600823355, 4846.39420072491, 4846.975765121293, 4848.5636292733825, 4896.2410826321975, 4907.312976183266, 4476.597106260452, 4499.302608095751, 4514.593686568224, 4517.50307466185, 4577.29051996941, 4650.4186976627925, 4651.232546629768, 4696.178168820511, 4760.452547957029, 4777.570018698334, 4802.351682522814, 4809.759512024455, 4811.3264143019305, 4815.518448155157, 4816.686915350491, 4689.718616882998, 4724.645651576215, 4763.499832517536, 4777.259524773665, 4817.566419022165, 4760.857174284777, 4762.571368576845, 4764.047190561971, 4813.181759100891, 4822.107910036654, 4610.2623580227, 4642.976785116053, 4644.164050470948, 4648.488666246778, 4706.435227772689, 4628.9537104628525, 4669.906601868011, 4672.08894265615, 4678.789454474489, 4735.147673418817, 4652.604528615106, 4676.532346765296, 4730.408698912636, 4731.810727570859, 4734.195186818318], "value": 4449.9564476806745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.1102857485171, 568.7241687781425, 570.2899889637403, 578.8914229250985, 582.9038208695565, 27383.0, 30158.84920575397, 37823.62176378236, 38463.230735385274, 38981.0, 38441.80779096107, 38734.22531549367, 38766.0, 38785.612143878556, 38861.22277554447, 7538.698452061911, 7711.730089446871, 7720.575368354738, 7720.729774457867, 7723.111842138142, 7563.319301262885, 7655.081390233152, 7668.693252269903, 7671.846563068735, 7674.577898215596, 7664.3904779996265, 7669.884951725729, 7695.615219239044, 7711.768646940601, 7711.845763084735, 7604.201558836326, 7611.923880761177, 7635.389168866477, 7637.8854317185005, 7652.426068044919, 7599.430042746816, 7640.350570201484, 7654.0, 7654.234576542357, 7663.425243106733, 37200.25599488022, 37443.25113497742, 37548.43677344842, 37552.0, 37552.81223593865, 2877.5252083406212, 2901.823463287, 3061.770367222467, 3173.666764989666, 3270.9532949456184, 27469.587956180672, 27741.58387624187, 28020.299492512648, 28116.859415702995, 28770.0, 3212.983935080333, 3264.5592844965863, 3281.803091814475, 3317.7345812334956, 3318.4856347266214, 232670.0, 233291.0, 233662.0, 233712.83143584343, 234870.0, 30189.396212075637, 49823.50176498261, 50177.24734128991, 50211.73623714447, 50214.24678629824, 32735.83632081824, 32885.17787055295, 32893.67106328954, 33010.66989330076, 33049.3390132196, 12082.516699331929, 12252.264864108181, 12256.754864902652, 12260.754784904251, 12260.81608775869, 9879.357841740264, 9987.0, 10008.64969726056, 10016.749581260527, 10022.799544009225, 7699.191584883619, 7751.999288263259, 7763.883541746878, 7829.530228186327, 7830.647620857075, 2984.8358340291493, 3010.6086208792717, 3021.2748940254182, 3047.7714171437233, 3089.5211242257487, 821.7863355527486, 829.6391069884498, 849.1890244816186, 853.0744142605342, 860.694453469022, 26132.86933565358, 26750.732492674822, 26927.461450771265, 27006.86496567544, 27358.17925462239, 750.2047829300958, 829.369679043919, 900.5497251374313, 933.0249888866151, 935.5322338830584, 13394.933025335005, 14303.0, 14330.785038224434, 14649.726098604493, 14706.191159486118, 340825.0, 344913.0, 345534.0, 345795.0, 346455.0, 48093.0, 48432.75783621059, 48525.5147448521, 48539.271910921365, 48647.5135248643, 1013.3565186106875, 1052.3528030261486, 1080.2168427889717, 1116.8883111688765, 1159.9536018559331, 24711.50576988486, 28300.71699282981, 28737.712622873503, 28926.276843079093, 28954.7104528952, 40506.39240411337, 40879.38680919729, 41079.0, 41104.794476027426, 41104.794476027426, 274260.0, 274931.0, 275914.0, 276060.0, 276407.0, 23820.642690359313, 24530.0, 24888.50222995494, 24924.875375623007, 25675.486490270465, 40249.396259056724, 40602.0, 40837.38743918903, 40848.18303633851, 41487.377689334084, 34161.31677366488, 34267.82866085654, 34422.82788586041, 34551.65448345484, 34585.48121778125, 34078.65921340755, 34307.0, 34696.0, 34728.826355868056, 34749.47875781815, 33456.832715836266, 34072.65927340794, 34885.65114348925, 35376.98591239444, 35483.467747984316, 29894.0, 31526.842365788023, 32331.19172020718, 32391.19022024374, 32405.51391729173, 24470.0, 24824.0, 24854.627180592666, 25148.62277065809, 25254.49491010206], "value": 15706.891615884337, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.8295286451044, 335.7934870054916, 337.5274615538246, 348.74541584643197, 371.21117625046776, 11927.403629818507, 12825.807612885803, 15545.300461479232, 16313.83686163138, 17619.207135678895, 15352.769708454382, 15481.14853683047, 15907.363705451768, 16712.41506547271, 16754.66490670186, 3728.4966529518574, 4849.296851956464, 5061.038402703493, 5064.822731204408, 5069.746512674352, 4934.383202099738, 4990.625703072266, 5005.974970125144, 5022.221555658879, 5028.723420211887, 4922.040528059967, 4974.97512512437, 4981.9252711209365, 4984.501549845005, 4988.0, 4861.635377346695, 5050.090983622965, 5059.74701264939, 5066.088104141253, 5073.873153171164, 4523.982104026601, 4524.981879077214, 4530.524294949048, 4531.728096314232, 4531.750753708545, 19448.22207111714, 20233.595328093503, 20424.0, 20521.692174617394, 20664.483387915272, 1840.6042700819255, 1871.2421469304954, 1873.990630046841, 1906.20892329683, 1982.2566537548419, 12256.754864902652, 13063.738725225443, 13471.393787279596, 13632.250226237553, 13900.443982240698, 1680.2438902493805, 1681.2602454919795, 1733.7919449666122, 1751.6671832351813, 1788.6154476787553, 66263.0, 68380.0, 68493.0, 69844.30155698428, 71165.64417177932, 9286.95356523213, 9387.57755900986, 9512.667056652985, 9519.571619277149, 9622.230221582256, 12858.164219325901, 12934.960284333174, 12956.222626642431, 12982.15615984958, 12984.350782460839, 6884.759033433806, 7054.823629409203, 7078.690442268196, 7081.256468070881, 7150.7497237596435, 6657.966710166418, 6681.198256209286, 6835.384815366541, 6850.828729281808, 6929.203141638675, 5664.54683625309, 5886.440788125121, 5961.642301461926, 6062.150534410681, 6161.44546990773, 1648.2335713893096, 1701.7957845058672, 1712.8201538838491, 1736.1145815634118, 1770.5131088950384, 787.0987719061642, 840.4495055738502, 855.9957200214084, 894.7923087630061, 902.6254104546671, 16725.91637041807, 16804.243809028623, 17181.57046073858, 17325.133743313036, 17948.461546153638, 813.2721214512977, 840.5671079394117, 848.4824257203101, 897.4929165021741, 901.693424235763, 9952.15406690425, 10062.849057264148, 10101.292909496411, 10146.695599132037, 10156.187504999582, 290793.0, 294776.0, 295209.0, 391454.0, 392959.0, 74825.12937176506, 81120.0, 82685.58657206675, 83643.5817820907, 83999.0, 899.7975455522455, 906.1074841281333, 940.2759874896292, 941.8634298026748, 948.5873644964463, 11444.370559619301, 15773.417872951512, 15854.60363490922, 16086.517404477885, 16208.270627822012, 34969.30061398707, 35377.64622353847, 36580.81709591435, 36736.0, 36804.81597591995, 46108.53891461177, 46112.0, 46244.76877615725, 46386.0, 48265.0, 7071.292870712888, 7233.674484648309, 7352.338289553966, 7356.8896466554115, 7478.850422991619, 10548.367097974146, 11534.826977595176, 11683.415829208676, 11881.346525941157, 12086.637400877988, 9378.0, 9638.518074096128, 9817.361871478332, 10100.141487973604, 10132.44271565071, 9590.568424421057, 9636.180924621485, 9862.0, 10011.299209055296, 10088.546015429176, 9140.588673509576, 9562.713118606453, 9578.521073946415, 9720.76422422861, 10048.346857454242, 7044.225135235018, 7083.256258092826, 7089.751858685127, 7170.641467926478, 7231.385332246818, 7575.221238938053, 9419.0, 9733.610655573697, 9997.250206234416, 10006.549705263134], "value": 8010.006895194009, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.2979206124721, 1378.8138601288822, 1384.750744865924, 1602.6394061336193, 1638.5493989152974, 6771.661416929159, 7342.339189472947, 7352.889706654404, 7369.152547457044, 7378.704851805921, 6100.572959892809, 6312.526560507958, 6824.0, 7025.437964962804, 7060.646967651623, 2082.4377418097065, 2109.599176156533, 2113.355426594888, 2114.9742374948137, 2125.4580082079046, 2050.5776205393763, 2077.3041031254547, 2085.593309304686, 2086.885221312827, 2094.5706130243266, 1754.4911975527145, 1827.168638269584, 1983.6032793441298, 2067.1318046420465, 2069.265410779174, 2071.3785864240745, 2084.9687254691194, 2090.4146838885135, 2091.1217288738844, 2093.1836583732356, 2071.979280207194, 2105.463106907744, 2108.019770806567, 2109.514811593342, 2115.2279418012467, 7045.084139061941, 7088.362047415757, 7090.574565526085, 7110.680019399139, 7232.638368081575, 4282.379055037033, 4404.867853964386, 4409.272470042439, 4409.757463339515, 4415.624671902892, 2775.972240277612, 2825.4490374377006, 2897.6233089698417, 2908.2583941095095, 2916.970830291691, 840.8066144786733, 888.9111088891124, 907.63694522191, 909.6315992023241, 919.7562645898843, 9289.628414863397, 9351.111644393839, 9363.0, 9374.250059995184, 9375.76560585984, 3626.601073881871, 3844.0, 3931.0958479549863, 3935.8622448214746, 3987.322155233617, 8163.959180204061, 8169.5098294102545, 8173.386995975326, 8173.877391839127, 8176.3867709920805, 4443.755593442327, 4445.555444455528, 4446.755428451466, 4448.266036104006, 4449.844255451044, 4032.5564187939303, 4081.0409553754844, 4082.408050832672, 4084.6936479764136, 4085.428040074392, 3406.233597440556, 3493.47597860323, 3521.5950165730756, 3543.3976224041976, 3564.1624218308675, 1090.7273181704575, 1111.6053800900725, 1113.281933153128, 1121.2039451989017, 1145.8395824584566, 569.3509399284818, 608.695652173913, 724.873147199238, 762.3367670126914, 773.4585789947059, 4610.792514336863, 4676.929846052312, 4736.265878788793, 4757.476677565465, 4870.342503762017, 825.2490233887133, 829.2785276809215, 830.4145577367941, 831.7296878514386, 847.1570787066908, 3342.38165939302, 3343.4316166251797, 3382.424987752088, 3409.3863104640905, 3529.9294014119573, 8258.504489730636, 8558.272546833588, 8614.138586141336, 8641.913580864237, 8653.0, 8581.613827377783, 8585.871211931826, 8587.828243435097, 8591.871121933176, 8595.14048595148, 6548.476121910236, 6623.370779775913, 6642.0, 6652.501062420338, 6711.63086030273, 4468.084042771289, 4485.775711214492, 4536.546345365437, 4554.635629149726, 4691.5308469152815, 7785.688572457265, 7855.7250496232355, 7861.292483676497, 7876.369890408868, 7922.366210703015, 8022.558759268296, 8047.758567242992, 8088.919110809052, 8129.674813007414, 8141.633626486704, 6056.182415373868, 6168.599041062316, 6180.165677633462, 6203.410675985774, 6216.875662486635, 6501.73993040292, 6563.901541476786, 6638.369354911276, 6643.900341494978, 6646.60120392778, 4935.284383764406, 6088.4215999479975, 6140.692965351625, 6206.565540412308, 6231.501479881689, 6058.3335833057445, 6121.112438696453, 6126.264848218064, 6169.321374648875, 6212.534059945612, 5398.703071330958, 5484.643498172606, 5497.8075767347955, 5505.752241149078, 5509.449055094458, 4076.857309994136, 4140.8136633852155, 4185.16296740647, 4239.554846741171, 4336.457942757155, 3936.4882565267476, 4085.0, 4094.5495995441074, 4177.91644167121, 4250.426192464101], "value": 3807.5719345962516, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.3242716122047, 286.7075582905436, 294.3832670555186, 295.14555362226355, 298.1294619710445, 4664.626829853612, 4789.832355867546, 4891.144049791285, 4920.696015555876, 4975.950240497598, 4642.0, 4719.386479757635, 4753.382060332152, 4783.808647654098, 4788.736619485927, 3743.3449146399407, 3754.911075788018, 3760.0787806987328, 3760.2103558252797, 3761.4169803680475, 3529.7176225901867, 3755.43668449732, 3756.417755247941, 3764.5106136202257, 3788.9621103788886, 3314.237725323177, 3576.874809381672, 3706.629337066299, 3736.5142531471006, 3738.9252214955686, 3701.407774756053, 3706.5366829146355, 3725.5343082114737, 3729.4965179700666, 3738.4205448155444, 3265.346930613887, 3286.7041966222914, 3288.5530366638604, 3296.2583418730833, 3297.5218593303834, 4496.640268778523, 4648.5119062498625, 4673.252279635276, 4723.36234608327, 4747.311639812242, 4275.850345237933, 4283.400323954649, 4287.678424118172, 4296.119295544406, 4308.879691280258, 4950.603951683856, 5034.697918124924, 5040.0, 5041.924371134399, 5056.241563765428, 3357.5970883494138, 3580.4629305604367, 3597.838097285602, 3600.981995090034, 3604.891853244407, 5219.269302297644, 5266.3943646480375, 5274.92087618686, 5285.022270879861, 5285.577153827685, 3625.5286812714708, 3625.927481450356, 3629.292288003814, 3630.146915474861, 3646.7447278690765, 3685.94471082934, 3701.370766969622, 3704.481372607837, 3706.7590606610484, 3722.8696995605565, 4124.8143833527565, 4177.4778152730905, 4208.200441916026, 4241.960719623712, 4253.340732186516, 5063.139266324733, 5067.214581739836, 5075.390953085654, 5089.720065396365, 5100.591952643779, 1171.2562522798085, 1193.2959553863263, 1223.7613665335175, 1252.7745005898844, 1255.9120861539604, 848.6690190825583, 849.2526576612541, 863.2317237658489, 873.4279047223952, 879.4195830751673, 4398.670099742532, 4408.677396780953, 4414.84548040817, 4415.92451547772, 4420.270655341897, 5109.718965456936, 5133.665247035723, 5158.303629010111, 5169.276301317818, 5174.637775355689, 4358.56414358568, 4385.758783266951, 4395.670324725658, 4398.570464599018, 4407.382966384709, 2311.6301391777233, 2399.880005999693, 2401.951960960771, 2451.3626457121277, 2465.6917885264343, 4262.296721041055, 4273.401723758676, 4295.241663544399, 4297.763623000765, 4301.07526881722, 4607.631389488833, 4633.258678611406, 4639.956009897746, 4648.862018137744, 4657.278121891112, 4078.4494093297617, 4185.288500954845, 4203.033302340417, 4214.1150358425075, 4280.810795957032, 4552.429411852905, 4553.3397657340165, 4564.744695208844, 4566.794494247833, 4575.679702420799, 4463.732176069446, 4470.396496472935, 4482.8879278017, 4514.45826500822, 4533.863984080483, 4052.979735101306, 4184.330507118846, 4231.413220042484, 4238.1523695261685, 4247.681423893282, 3284.9671503284662, 3286.260591366923, 3305.471124620049, 3309.9809116439433, 3323.9501407479393, 4615.515370886143, 4637.744924029211, 4645.674802763774, 4653.720226937619, 4932.654714169974, 4798.184308667465, 4963.975180124076, 5033.345665063518, 5046.621503387334, 5049.9495005049475, 5007.349044624321, 5011.498850114959, 5020.945601423596, 5024.66353145789, 5040.4455509894615, 4693.2021556336185, 4896.853094407031, 4911.778969946433, 4917.409910810583, 4944.802207911644, 5015.943463180079, 5046.924296135634, 5074.564209179541, 5077.34986129502, 5084.847454576368, 4956.752162391794, 4967.180415231591, 4973.776180071978, 4987.775550100182, 5007.974960125176], "value": 3659.6095132789383, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.1660000898754, 643.2988043033093, 673.9224989126249, 690.3234829866727, 694.4305669351131, 12372.938135309321, 13468.797968030487, 13518.188908665486, 13550.661233469169, 13572.932135339322, 12135.939320303409, 12234.44944977476, 12243.32661703606, 12249.142560020802, 12249.510019599227, 616.1620196532712, 631.4380201620561, 739.6190961654738, 748.9662965166553, 759.6847308367021, 764.1250767870785, 771.294265746841, 771.5293670860771, 771.9459637825355, 772.0272456704564, 818.5007145641184, 825.8678611422174, 826.1696994520498, 826.4751882554561, 827.185222555782, 650.7397041183517, 664.3920812456596, 784.3137254901961, 797.366093955307, 821.5686764448652, 595.8986972214691, 596.0790578556098, 596.1564386393248, 596.263614436171, 596.5347029317096, 12461.376931153405, 12475.126741128124, 12503.74992500154, 12503.874961250453, 12504.937475312565, 11963.820542691867, 12233.0, 12350.258984460961, 12694.238345699288, 12845.421956011909, 11326.660200194008, 11403.828942565868, 11701.771314012076, 11774.293542387484, 12301.384930753427, 3985.143194213229, 4003.4395184674167, 4058.492688413948, 4084.3712414142765, 4135.400366946806, 60485.39514604842, 60514.0, 60825.391746082416, 60833.695831521, 60840.0, 9483.288753343526, 9708.223342132613, 10181.389116653025, 10412.32319899204, 10486.318389304672, 17915.552111197325, 18426.35507757222, 18453.72319415183, 18518.0, 18566.628667426576, 6531.216254049449, 6612.86774264512, 6669.633170175687, 6679.56582822115, 6714.932850671528, 3601.441776524643, 3613.1328481164855, 3637.181634132352, 3693.171949361548, 3712.1462063725494, 2494.550980823433, 2579.3551612096976, 2579.7162312145647, 2581.0966161843203, 2971.3314504236373, 470.52947052947053, 473.15777915310116, 474.2270099737406, 478.5668969582464, 479.9592034677022, 428.5757100470512, 509.88782467857754, 553.177803616927, 569.93635379743, 579.9333076696234, 7951.284384405431, 8022.4785388950695, 8121.715739949192, 8251.677667904169, 8344.791380215422, 565.9094544872801, 570.7231992483643, 584.6842704939285, 588.7233000489763, 606.3633185155658, 3676.6690997810324, 3975.2447035063824, 4059.4722686050623, 4079.9592004080173, 4164.416981622575, 77663.61168194123, 99421.50289248652, 99694.5015274919, 102182.0, 102479.48760256151, 76328.61835690786, 83124.58437707773, 84971.5751421239, 85781.0, 87442.56278718566, 73815.26184738192, 76850.61574692202, 77033.61483192549, 77461.6126919373, 78883.60558197173, 7273.054502914587, 7403.925960740324, 7407.333339999426, 7530.472866899265, 7568.167501574712, 44356.556434435246, 45484.77257613691, 45638.06705128312, 45647.77176114098, 47611.0, 57942.710286448295, 62426.37573624206, 67045.32954670391, 67706.32293677, 69474.30525694678, 9228.584713687766, 9320.207782338577, 9392.389494682824, 9402.623895044122, 9550.522473876417, 10874.510647021061, 10903.78192436131, 10970.616028438966, 11190.272632278877, 12646.0, 10805.783884322427, 11186.608468703556, 11190.88809111931, 11269.830952535554, 11964.341961191869, 11721.589744358907, 12548.811767823307, 12675.746485070062, 12900.354982251038, 13082.149660272053, 11302.095832333558, 11866.228695134789, 12361.814572781235, 12760.234385936874, 12819.102662813513, 9793.45370203738, 9991.850122248317, 10287.794244115226, 10655.25413221067, 10843.67468975932, 9158.633654653739, 9554.035240048359, 9963.701088967342, 10024.849627255451, 10030.64892728751], "value": 6445.47445634701, "unit": "score"}], "name": "dromaeo_css", "value": 6075.442088323361, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 116.0, 115.0, 114.0, 114.0, 116.0, 114.0, 114.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 131.0, 169.0, 126.0, 126.0, 127.0, 133.0, 167.0, 131.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 163.0, 163.0, 161.0, 163.0, 162.0, 161.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 112.0, 75.0, 76.0, 76.0, 75.0, 112.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 136.0, 84.0, 83.0, 83.0, 113.0, 82.0, 82.0, 116.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 69.0, 64.0, 65.0, 68.0, 69.0, 67.0, 65.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 67.0, 68.0, 69.0, 68.0, 68.0, 67.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 81.0, 82.0, 83.0, 83.0, 84.0, 82.0, 83.0, 81.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 140.0, 139.0, 139.0, 138.0, 145.0, 139.0, 148.0, 188.0, 136.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 178.0, 175.0, 177.0, 173.0, 175.0, 173.0, 173.0, 179.0, 175.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 69.0, 68.0, 70.0, 70.0, 70.0, 69.0, 69.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1548.0, "alertThreshold": 2.0}]} 04:51:07 INFO - Return code: 0 04:51:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:51:07 INFO - # TBPL SUCCESS # 04:51:07 INFO - Running post-action listener: _resource_record_post_action 04:51:07 INFO - [mozharness: 2016-10-14 11:51:07.984130Z] Finished run-tests step (success) 04:51:07 INFO - Running post-run listener: _resource_record_post_run 04:51:08 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 8192; Write bytes: 391376896; Read time: 36; Write time: 269864 04:51:08 INFO - TinderboxPrint: CPU usage
13.1% 04:51:08 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 36 04:51:08 INFO - TinderboxPrint: I/O write bytes / time
391,376,896 / 269,864 04:51:08 INFO - TinderboxPrint: CPU idle
8,350.1 (86.9%) 04:51:08 INFO - TinderboxPrint: CPU user
1,207.6 (12.6%) 04:51:08 INFO - TinderboxPrint: Swap in / out
0 / 0 04:51:08 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 98975744; Read time: 0; Write time: 63568 04:51:08 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292401152; Read time: 12; Write time: 206296 04:51:08 INFO - Running post-run listener: _upload_blobber_files 04:51:08 INFO - Blob upload gear active. 04:51:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:08 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 04:51:08 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'] 04:51:08 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 04:51:09 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:51:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:51:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:12 INFO - (blobuploader) - INFO - Done attempting. 04:51:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:51:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:51:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:12 INFO - (blobuploader) - INFO - Done attempting. 04:51:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:51:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:51:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:13 INFO - (blobuploader) - INFO - Done attempting. 04:51:13 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:13 INFO - Return code: 0 04:51:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:51:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3cf331a96ca7319dfa3b8e21c4afe7aae1d40f6ae180b200d7aeae9a5197a079c192c241e85acfe9d98adf60baa255214497bdbcc24b00fa18716585019624b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7fba4a92cf6af48a29566c3fafc934bbc31c14c3f0f7e2b3fdbc8f32c770a654ec4d71cc9be35041d9a51dda1cf040b12fe004ba463f88a201c203d4118bd45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7aceeceac04ed792a8d59cd921004c6ec7caac27cf588748a89e00b1a27b44b505250e933d21ae9bdb2234de0b554a601a62272aed669123162e77ce69e327e5"} 04:51:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:51:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:51:13 INFO - Contents: 04:51:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3cf331a96ca7319dfa3b8e21c4afe7aae1d40f6ae180b200d7aeae9a5197a079c192c241e85acfe9d98adf60baa255214497bdbcc24b00fa18716585019624b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7fba4a92cf6af48a29566c3fafc934bbc31c14c3f0f7e2b3fdbc8f32c770a654ec4d71cc9be35041d9a51dda1cf040b12fe004ba463f88a201c203d4118bd45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7aceeceac04ed792a8d59cd921004c6ec7caac27cf588748a89e00b1a27b44b505250e933d21ae9bdb2234de0b554a601a62272aed669123162e77ce69e327e5"} 04:51:13 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:13 INFO - Copying logs to upload dir... 04:51:13 INFO - mkdir: /builds/slave/test/build/upload/logs 04:51:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.206948 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-14 04:51:13.543043) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 04:51:13.547152) ========= 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=db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211 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/e3cf331a96ca7319dfa3b8e21c4afe7aae1d40f6ae180b200d7aeae9a5197a079c192c241e85acfe9d98adf60baa255214497bdbcc24b00fa18716585019624b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7fba4a92cf6af48a29566c3fafc934bbc31c14c3f0f7e2b3fdbc8f32c770a654ec4d71cc9be35041d9a51dda1cf040b12fe004ba463f88a201c203d4118bd45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7aceeceac04ed792a8d59cd921004c6ec7caac27cf588748a89e00b1a27b44b505250e933d21ae9bdb2234de0b554a601a62272aed669123162e77ce69e327e5"} build_url:https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/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/e3cf331a96ca7319dfa3b8e21c4afe7aae1d40f6ae180b200d7aeae9a5197a079c192c241e85acfe9d98adf60baa255214497bdbcc24b00fa18716585019624b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7fba4a92cf6af48a29566c3fafc934bbc31c14c3f0f7e2b3fdbc8f32c770a654ec4d71cc9be35041d9a51dda1cf040b12fe004ba463f88a201c203d4118bd45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7aceeceac04ed792a8d59cd921004c6ec7caac27cf588748a89e00b1a27b44b505250e933d21ae9bdb2234de0b554a601a62272aed669123162e77ce69e327e5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 04:51:13.576219) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:51:13.576589) ========= 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=db0483c52d987ecb441a263b000001ad-1476444625.297926-854021211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:51:13.663150) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 04:51:13.663947) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 04:51:13.664636) ========= ========= Total master_lag: 0.20 =========