builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1480216277.41 results: success (0) buildid: 20161126175419 builduid: f8c4519588ea4af088cbcf9731dbb1f9 revision: 3d81e7906de637040bb850628487fd8aa921569c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 19:11:17.414774) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 19:11:17.415298) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 19:11:17.415723) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 19:11:17.431505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 19:11:17.431861) ========= 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=31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-26 19:11:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-11-26 19:11:18 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114937 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 19:11:17.561870) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 19:11:17.562291) ========= 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=31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014996 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 19:11:17.615833) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-26 19:11:17.616624) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3d81e7906de637040bb850628487fd8aa921569c --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 3d81e7906de637040bb850628487fd8aa921569c --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=31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-26 19:11:18,871 truncating revision to first 12 chars 2016-11-26 19:11:18,871 Setting DEBUG logging. 2016-11-26 19:11:18,871 attempt 1/10 2016-11-26 19:11:18,871 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3d81e7906de6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-26 19:11:20,161 unpacking tar archive at: mozilla-central-3d81e7906de6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.685396 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-26 19:11:19.339756) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 19:11:19.340154) ========= script_repo_revision: 3d81e7906de637040bb850628487fd8aa921569c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 19:11:19.340611) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 19:11:19.340970) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 19:11:19.361497) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-26 19:11:19.361956) ========= /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=31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:11:20 INFO - MultiFileLogger online at 20161126 19:11:20 in /builds/slave/test 19:11:20 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 19:11:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:11:20 INFO - {'append_to_log': False, 19:11:20 INFO - 'base_work_dir': '/builds/slave/test', 19:11:20 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:11:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:11:20 INFO - 'branch': 'Firefox-Non-PGO', 19:11:20 INFO - 'buildbot_json_path': 'buildprops.json', 19:11:20 INFO - 'config_files': ('talos/linux_config.py',), 19:11:20 INFO - 'default_actions': ('clobber', 19:11:20 INFO - 'read-buildbot-config', 19:11:20 INFO - 'download-and-extract', 19:11:20 INFO - 'populate-webroot', 19:11:20 INFO - 'create-virtualenv', 19:11:20 INFO - 'install', 19:11:20 INFO - 'run-tests'), 19:11:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:11:20 INFO - 'download_minidump_stackwalk': True, 19:11:20 INFO - 'download_symbols': 'ondemand', 19:11:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:11:20 INFO - 'tooltool.py': '/tools/tooltool.py', 19:11:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:11:20 INFO - '/tools/misc-python/virtualenv.py')}, 19:11:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:11:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:11:20 INFO - 'installer_path': 'installer.exe', 19:11:20 INFO - 'log_level': 'info', 19:11:20 INFO - 'log_name': 'talos', 19:11:20 INFO - 'log_to_console': True, 19:11:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:11:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:11:20 INFO - 'opt_config_files': (), 19:11:20 INFO - 'pip_index': False, 19:11:20 INFO - 'sps_profile': False, 19:11:20 INFO - 'sps_profile_interval': 0, 19:11:20 INFO - 'suite': 'dromaeojs', 19:11:20 INFO - 'system_bits': '32', 19:11:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:11:20 INFO - 'title': 'talos-linux64-ix-014', 19:11:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:11:20 INFO - 'use_talos_json': True, 19:11:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:11:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:11:20 INFO - 'work_dir': 'build'} 19:11:20 INFO - [mozharness: 2016-11-27 03:11:20.714459Z] Running clobber step. 19:11:20 INFO - Running pre-action listener: _resource_record_pre_action 19:11:20 INFO - Running main action method: clobber 19:11:20 INFO - rmtree: /builds/slave/test/build 19:11:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:11:21 INFO - Running post-action listener: _resource_record_post_action 19:11:21 INFO - [mozharness: 2016-11-27 03:11:21.189494Z] Finished clobber step (success) 19:11:21 INFO - [mozharness: 2016-11-27 03:11:21.189594Z] Running read-buildbot-config step. 19:11:21 INFO - Running pre-action listener: _resource_record_pre_action 19:11:21 INFO - Running main action method: read_buildbot_config 19:11:21 INFO - Using buildbot properties: 19:11:21 INFO - { 19:11:21 INFO - "project": "", 19:11:21 INFO - "product": "firefox", 19:11:21 INFO - "script_repo_revision": "production", 19:11:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:11:21 INFO - "repository": "", 19:11:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 19:11:21 INFO - "buildid": "20161126175419", 19:11:21 INFO - "pgo_build": "False", 19:11:21 INFO - "basedir": "/builds/slave/test", 19:11:21 INFO - "buildnumber": 837, 19:11:21 INFO - "slavename": "talos-linux64-ix-014", 19:11:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:11:21 INFO - "platform": "ubuntu64_hw", 19:11:21 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 19:11:21 INFO - "branch": "mozilla-central", 19:11:21 INFO - "repo_path": "mozilla-central", 19:11:21 INFO - "revision": "3d81e7906de637040bb850628487fd8aa921569c", 19:11:21 INFO - "stage_platform": "linux64", 19:11:21 INFO - "builduid": "f8c4519588ea4af088cbcf9731dbb1f9", 19:11:21 INFO - "slavebuilddir": "test" 19:11:21 INFO - } 19:11:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 19:11:21 INFO - Running post-action listener: _resource_record_post_action 19:11:21 INFO - [mozharness: 2016-11-27 03:11:21.192008Z] Finished read-buildbot-config step (success) 19:11:21 INFO - [mozharness: 2016-11-27 03:11:21.192747Z] Running download-and-extract step. 19:11:21 INFO - Running pre-action listener: _resource_record_pre_action 19:11:21 INFO - Running main action method: download_and_extract 19:11:21 INFO - mkdir: /builds/slave/test/build/tests 19:11:21 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')]} 19:11:21 INFO - trying https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:11:21 INFO - Downloading https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:11:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:11:22 INFO - Downloaded 1361 bytes. 19:11:22 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:11:22 INFO - Using the following test package requirements: 19:11:22 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:11:22 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:22 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:11:22 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:22 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:11:22 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:22 INFO - u'jsshell-linux-x86_64.zip'], 19:11:22 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:22 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:11:22 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:11:22 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:22 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:11:22 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:22 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:11:22 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:22 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:11:22 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:22 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:11:22 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:11:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 19:11:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:11:22 INFO - Fetch https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:11:22 INFO - Http code: 200 19:11:22 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 19:11:22 INFO - x-amz-cf-id: eukekYBqf8QOTYIx7L0Ls7ABLELeq43hV0s9kL22gWutfERkjPsAuQ== 19:11:22 INFO - x-amz-version-id: _80aIWpovyb.xZfWXiXDx8l1kGJFnNAr 19:11:22 INFO - Expected file size: 20216200 19:11:22 INFO - Obtained file size: 20216200 19:11:26 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:11:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 19:11:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:11:26 INFO - Fetch https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:11:27 INFO - Http code: 200 19:11:27 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 19:11:27 INFO - x-amz-cf-id: K9Qe4D0jJWhZ4RyIyVR41kXO8CJORI0V0wUDd7elI0gAMhnln7PHIA== 19:11:27 INFO - x-amz-version-id: _80aIWpovyb.xZfWXiXDx8l1kGJFnNAr 19:11:27 INFO - Expected file size: 20216200 19:11:27 INFO - Obtained file size: 20216200 19:11:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 19:11:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:11:32 INFO - Fetch https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 19:11:32 INFO - Http code: 200 19:11:32 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 19:11:32 INFO - x-amz-cf-id: XHSuICeSTTeSI_rpWsRXeCNhWmSGtWlPVqA89USnjqcVmeuSkU3abg== 19:11:32 INFO - x-amz-version-id: mj3pwmT3FHlWTahGGrQ.NW3Oggnjrt7Y 19:11:32 INFO - Expected file size: 14409702 19:11:32 INFO - Obtained file size: 14409702 19:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:33 INFO - trying https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:11:33 INFO - Downloading https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:11:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:11:34 INFO - Downloaded 55674149 bytes. 19:11:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:11:34 INFO - mkdir: /builds/slave/test/properties 19:11:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:11:34 INFO - Writing to file /builds/slave/test/properties/build_url 19:11:34 INFO - Contents: 19:11:34 INFO - build_url:https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:11:34 INFO - Running post-action listener: _resource_record_post_action 19:11:34 INFO - Running post-action listener: set_extra_try_arguments 19:11:34 INFO - [mozharness: 2016-11-27 03:11:34.869566Z] Finished download-and-extract step (success) 19:11:34 INFO - [mozharness: 2016-11-27 03:11:34.869795Z] Running populate-webroot step. 19:11:34 INFO - Running pre-action listener: _resource_record_pre_action 19:11:34 INFO - Running main action method: populate_webroot 19:11:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:11:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:11:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:11:34 INFO - '--tppagecycles', 19:11:34 INFO - '7'], 19:11:34 INFO - 'tests': ['tsvgm']}}, 19:11:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:11:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:11:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:11:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:11:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:11:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:11:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:11:34 INFO - 'talos_options': ['--disable-e10s'], 19:11:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:11:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:11:34 INFO - 'talos_options': ['--disable-e10s'], 19:11:34 INFO - 'tests': ['damp', 'tps']}, 19:11:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:11:34 INFO - 'tests': ['damp', 'tps']}, 19:11:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:11:34 INFO - 'tests': ['dromaeo_dom']}, 19:11:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:11:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:11:34 INFO - 'tests': ['basic_compositor_video']}, 19:11:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:11:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:11:34 INFO - 'tests': ['a11yr', 19:11:34 INFO - 'ts_paint', 19:11:34 INFO - 'tpaint', 19:11:34 INFO - 'sessionrestore', 19:11:34 INFO - 'sessionrestore_no_auto_restore', 19:11:34 INFO - 'tabpaint']}, 19:11:34 INFO - 'other-e10s': {'tests': ['a11yr', 19:11:34 INFO - 'ts_paint', 19:11:34 INFO - 'tpaint', 19:11:34 INFO - 'sessionrestore', 19:11:34 INFO - 'sessionrestore_no_auto_restore', 19:11:34 INFO - 'tabpaint']}, 19:11:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:11:34 INFO - 'ts_paint', 19:11:34 INFO - 'tpaint', 19:11:34 INFO - 'sessionrestore', 19:11:34 INFO - 'sessionrestore_no_auto_restore', 19:11:34 INFO - 'tabpaint']}, 19:11:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:11:34 INFO - 'ts_paint', 19:11:34 INFO - 'tpaint', 19:11:34 INFO - 'sessionrestore', 19:11:34 INFO - 'sessionrestore_no_auto_restore', 19:11:34 INFO - 'tabpaint']}, 19:11:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:11:34 INFO - 'tests': ['a11yr', 19:11:34 INFO - 'ts_paint', 19:11:34 INFO - 'tpaint', 19:11:34 INFO - 'sessionrestore', 19:11:34 INFO - 'sessionrestore_no_auto_restore', 19:11:34 INFO - 'tabpaint']}, 19:11:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:11:34 INFO - 'tests': ['a11yr', 19:11:34 INFO - 'ts_paint', 19:11:34 INFO - 'tpaint', 19:11:34 INFO - 'sessionrestore', 19:11:34 INFO - 'sessionrestore_no_auto_restore', 19:11:34 INFO - 'tabpaint']}, 19:11:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:11:34 INFO - 'tests': ['tsvgx', 19:11:34 INFO - 'tsvgr_opacity', 19:11:34 INFO - 'tart', 19:11:34 INFO - 'tscrollx', 19:11:34 INFO - 'cart', 19:11:34 INFO - 'tsvg_static']}, 19:11:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:11:34 INFO - 'tsvgr_opacity', 19:11:34 INFO - 'tart', 19:11:34 INFO - 'tscrollx', 19:11:34 INFO - 'cart', 19:11:34 INFO - 'tsvg_static']}, 19:11:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:11:34 INFO - 'talos_options': ['--disable-e10s'], 19:11:34 INFO - 'tests': ['tp5o']}, 19:11:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:11:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:11:34 INFO - 'talos_options': ['--disable-e10s', 19:11:34 INFO - '--xperf_path', 19:11:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:34 INFO - 'tests': ['tp5n']}, 19:11:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:11:34 INFO - 'talos_options': ['--xperf_path', 19:11:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:34 INFO - 'tests': ['tp5n']}}, 19:11:34 INFO - 'talos.zip': {'path': '', 19:11:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:11:34 INFO - Running post-action listener: _resource_record_post_action 19:11:34 INFO - [mozharness: 2016-11-27 03:11:34.889289Z] Finished populate-webroot step (success) 19:11:34 INFO - [mozharness: 2016-11-27 03:11:34.889377Z] Running create-virtualenv step. 19:11:34 INFO - Running pre-action listener: _resource_record_pre_action 19:11:34 INFO - Running main action method: create_virtualenv 19:11:34 INFO - Creating virtualenv /builds/slave/test/build/venv 19:11:34 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 19:11:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:11:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:11:34 INFO - Using real prefix '/usr' 19:11:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:11:35 INFO - Installing distribute.............................................................................................................................................................................................done. 19:11:37 INFO - Installing pip.................done. 19:11:37 INFO - Return code: 0 19:11:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:11:37 INFO - Reading from file tmpfile_stdout 19:11:37 INFO - Output received: 19:11:37 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) 19:11:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:37 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 0x7f42a3816e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bacb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6fc0>, '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 0x1dd7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8350>, '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': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', '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 19:11:37 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 19:11:37 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 19:11:37 INFO - Using env: {'DISPLAY': ':0', 19:11:37 INFO - 'HOME': '/home/cltbld', 19:11:37 INFO - 'LANG': 'en_US.UTF-8', 19:11:37 INFO - 'LANGUAGE': 'en_US:en', 19:11:37 INFO - 'LOGNAME': 'cltbld', 19:11:37 INFO - 'MAIL': '/var/mail/cltbld', 19:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:37 INFO - 'MOZ_NO_REMOTE': '1', 19:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:37 INFO - 'NO_EM_RESTART': '1', 19:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:37 INFO - 'PWD': '/builds/slave/test', 19:11:37 INFO - 'SHELL': '/bin/bash', 19:11:37 INFO - 'SHLVL': '1', 19:11:37 INFO - 'TERM': 'linux', 19:11:37 INFO - 'TMOUT': '86400', 19:11:37 INFO - 'USER': 'cltbld', 19:11:37 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', 19:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:37 INFO - '_': '/tools/buildbot/bin/python'} 19:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:37 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 19:11:37 INFO - Cleaning up... 19:11:37 INFO - Return code: 0 19:11:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:37 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 0x7f42a3816e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bacb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6fc0>, '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 0x1dd7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8350>, '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': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', '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 19:11:37 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 19:11:37 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 19:11:37 INFO - Using env: {'DISPLAY': ':0', 19:11:37 INFO - 'HOME': '/home/cltbld', 19:11:37 INFO - 'LANG': 'en_US.UTF-8', 19:11:37 INFO - 'LANGUAGE': 'en_US:en', 19:11:37 INFO - 'LOGNAME': 'cltbld', 19:11:37 INFO - 'MAIL': '/var/mail/cltbld', 19:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:37 INFO - 'MOZ_NO_REMOTE': '1', 19:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:37 INFO - 'NO_EM_RESTART': '1', 19:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:37 INFO - 'PWD': '/builds/slave/test', 19:11:37 INFO - 'SHELL': '/bin/bash', 19:11:37 INFO - 'SHLVL': '1', 19:11:37 INFO - 'TERM': 'linux', 19:11:37 INFO - 'TMOUT': '86400', 19:11:37 INFO - 'USER': 'cltbld', 19:11:37 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', 19:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:37 INFO - '_': '/tools/buildbot/bin/python'} 19:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:38 INFO - Downloading/unpacking psutil>=3.1.1 19:11:38 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 19:11:38 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 19:11:38 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 19:11:38 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 19:11:38 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 19:11:38 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 19:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:11:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:40 INFO - Installing collected packages: psutil 19:11:40 INFO - Running setup.py install for psutil 19:11:40 INFO - building 'psutil._psutil_linux' extension 19:11:40 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 19:11:40 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 19:11:40 INFO - building 'psutil._psutil_posix' extension 19:11:40 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 19:11:40 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 19:11:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:40 INFO - Successfully installed psutil 19:11:40 INFO - Cleaning up... 19:11:40 INFO - Return code: 0 19:11:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:40 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 0x7f42a3816e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bacb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6fc0>, '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 0x1dd7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8350>, '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': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', '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 19:11:40 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 19:11:40 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 19:11:40 INFO - Using env: {'DISPLAY': ':0', 19:11:40 INFO - 'HOME': '/home/cltbld', 19:11:40 INFO - 'LANG': 'en_US.UTF-8', 19:11:40 INFO - 'LANGUAGE': 'en_US:en', 19:11:40 INFO - 'LOGNAME': 'cltbld', 19:11:40 INFO - 'MAIL': '/var/mail/cltbld', 19:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:40 INFO - 'MOZ_NO_REMOTE': '1', 19:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:40 INFO - 'NO_EM_RESTART': '1', 19:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:40 INFO - 'PWD': '/builds/slave/test', 19:11:40 INFO - 'SHELL': '/bin/bash', 19:11:40 INFO - 'SHLVL': '1', 19:11:40 INFO - 'TERM': 'linux', 19:11:40 INFO - 'TMOUT': '86400', 19:11:40 INFO - 'USER': 'cltbld', 19:11:40 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', 19:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:40 INFO - '_': '/tools/buildbot/bin/python'} 19:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:11:40 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 19:11:40 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 19:11:40 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 19:11:40 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 19:11:40 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 19:11:40 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 19:11:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:11:42 INFO - Installing collected packages: mozsystemmonitor 19:11:42 INFO - Running setup.py install for mozsystemmonitor 19:11:42 INFO - Successfully installed mozsystemmonitor 19:11:42 INFO - Cleaning up... 19:11:43 INFO - Return code: 0 19:11:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:11:43 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')]} 19:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:43 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')]} 19:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:43 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 0x7f42a3816e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bacb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6fc0>, '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 0x1dd7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8350>, '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': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', '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 19:11:43 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 19:11:43 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 19:11:43 INFO - Using env: {'DISPLAY': ':0', 19:11:43 INFO - 'HOME': '/home/cltbld', 19:11:43 INFO - 'LANG': 'en_US.UTF-8', 19:11:43 INFO - 'LANGUAGE': 'en_US:en', 19:11:43 INFO - 'LOGNAME': 'cltbld', 19:11:43 INFO - 'MAIL': '/var/mail/cltbld', 19:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:43 INFO - 'MOZ_NO_REMOTE': '1', 19:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:43 INFO - 'NO_EM_RESTART': '1', 19:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:43 INFO - 'PWD': '/builds/slave/test', 19:11:43 INFO - 'SHELL': '/bin/bash', 19:11:43 INFO - 'SHLVL': '1', 19:11:43 INFO - 'TERM': 'linux', 19:11:43 INFO - 'TMOUT': '86400', 19:11:43 INFO - 'USER': 'cltbld', 19:11:43 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', 19:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:43 INFO - '_': '/tools/buildbot/bin/python'} 19:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:43 INFO - Downloading/unpacking jsonschema==2.5.1 19:11:43 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 19:11:43 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 19:11:43 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 19:11:43 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 19:11:43 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 19:11:43 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 19:11:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:11:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:11:45 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 19:11:45 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 19:11:45 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 19:11:45 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 19:11:45 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 19:11:45 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 19:11:45 INFO - Downloading functools32-3.2.3-2.tar.gz 19:11:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:11:45 INFO - warning: no files found matching '*.txt' 19:11:45 INFO - no previously-included directories found matching 'build' 19:11:45 INFO - no previously-included directories found matching 'dist' 19:11:45 INFO - no previously-included directories found matching '.git*' 19:11:45 INFO - Installing collected packages: jsonschema, functools32 19:11:45 INFO - Running setup.py install for functools32 19:11:45 INFO - warning: no files found matching '*.txt' 19:11:45 INFO - no previously-included directories found matching 'build' 19:11:45 INFO - no previously-included directories found matching 'dist' 19:11:45 INFO - no previously-included directories found matching '.git*' 19:11:45 INFO - Successfully installed jsonschema functools32 19:11:45 INFO - Cleaning up... 19:11:45 INFO - Return code: 0 19:11:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:11:45 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')]} 19:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:45 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')]} 19:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:45 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 0x7f42a3816e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bacb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6fc0>, '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 0x1dd7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8350>, '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': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', '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 19:11:45 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 19:11:45 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 19:11:45 INFO - Using env: {'DISPLAY': ':0', 19:11:45 INFO - 'HOME': '/home/cltbld', 19:11:45 INFO - 'LANG': 'en_US.UTF-8', 19:11:45 INFO - 'LANGUAGE': 'en_US:en', 19:11:45 INFO - 'LOGNAME': 'cltbld', 19:11:45 INFO - 'MAIL': '/var/mail/cltbld', 19:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:45 INFO - 'MOZ_NO_REMOTE': '1', 19:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:45 INFO - 'NO_EM_RESTART': '1', 19:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:45 INFO - 'PWD': '/builds/slave/test', 19:11:45 INFO - 'SHELL': '/bin/bash', 19:11:45 INFO - 'SHLVL': '1', 19:11:45 INFO - 'TERM': 'linux', 19:11:45 INFO - 'TMOUT': '86400', 19:11:45 INFO - 'USER': 'cltbld', 19:11:45 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', 19:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:45 INFO - '_': '/tools/buildbot/bin/python'} 19:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:11:45 INFO - Cleaning up... 19:11:45 INFO - Return code: 0 19:11:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:11:45 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')]} 19:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:45 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')]} 19:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:45 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 0x7f42a3816e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bacb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6fc0>, '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 0x1dd7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8350>, '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': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', '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 19:11:45 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 19:11:45 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 19:11:45 INFO - Using env: {'DISPLAY': ':0', 19:11:45 INFO - 'HOME': '/home/cltbld', 19:11:45 INFO - 'LANG': 'en_US.UTF-8', 19:11:45 INFO - 'LANGUAGE': 'en_US:en', 19:11:45 INFO - 'LOGNAME': 'cltbld', 19:11:45 INFO - 'MAIL': '/var/mail/cltbld', 19:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:45 INFO - 'MOZ_NO_REMOTE': '1', 19:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:45 INFO - 'NO_EM_RESTART': '1', 19:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:45 INFO - 'PWD': '/builds/slave/test', 19:11:45 INFO - 'SHELL': '/bin/bash', 19:11:45 INFO - 'SHLVL': '1', 19:11:45 INFO - 'TERM': 'linux', 19:11:45 INFO - 'TMOUT': '86400', 19:11:45 INFO - 'USER': 'cltbld', 19:11:45 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', 19:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:45 INFO - '_': '/tools/buildbot/bin/python'} 19:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:46 INFO - Downloading/unpacking blobuploader==1.2.4 19:11:46 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 19:11:46 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 19:11:46 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 19:11:46 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 19:11:46 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 19:11:46 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 19:11:48 INFO - Downloading blobuploader-1.2.4.tar.gz 19:11:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:11:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:11:48 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 19:11:48 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 19:11:48 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 19:11:48 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 19:11:48 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 19:11:48 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 19:11:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:11:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:11:48 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 19:11:48 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 19:11:48 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 19:11:48 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 19:11:48 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 19:11:48 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 19:11:48 INFO - Downloading docopt-0.6.1.tar.gz 19:11:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:11:48 INFO - Installing collected packages: blobuploader, requests, docopt 19:11:48 INFO - Running setup.py install for blobuploader 19:11:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:11:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:11:48 INFO - Running setup.py install for requests 19:11:49 INFO - Running setup.py install for docopt 19:11:49 INFO - Successfully installed blobuploader requests docopt 19:11:49 INFO - Cleaning up... 19:11:49 INFO - Return code: 0 19:11:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:49 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 0x7f42a3816e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bacb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6fc0>, '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 0x1dd7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8350>, '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': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', '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 19:11:49 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 19:11:49 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 19:11:49 INFO - Using env: {'DISPLAY': ':0', 19:11:49 INFO - 'HOME': '/home/cltbld', 19:11:49 INFO - 'LANG': 'en_US.UTF-8', 19:11:49 INFO - 'LANGUAGE': 'en_US:en', 19:11:49 INFO - 'LOGNAME': 'cltbld', 19:11:49 INFO - 'MAIL': '/var/mail/cltbld', 19:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:49 INFO - 'MOZ_NO_REMOTE': '1', 19:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:49 INFO - 'NO_EM_RESTART': '1', 19:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:49 INFO - 'PWD': '/builds/slave/test', 19:11:49 INFO - 'SHELL': '/bin/bash', 19:11:49 INFO - 'SHLVL': '1', 19:11:49 INFO - 'TERM': 'linux', 19:11:49 INFO - 'TMOUT': '86400', 19:11:49 INFO - 'USER': 'cltbld', 19:11:49 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', 19:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:49 INFO - '_': '/tools/buildbot/bin/python'} 19:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:49 INFO - Running setup.py (path:/tmp/pip-wg1u2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:49 INFO - Running setup.py (path:/tmp/pip-h9tjmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:49 INFO - Running setup.py (path:/tmp/pip-XWQzFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:49 INFO - Running setup.py (path:/tmp/pip-tDNVwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:49 INFO - Running setup.py (path:/tmp/pip-29h9iE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:50 INFO - Running setup.py (path:/tmp/pip-Mnnge4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:50 INFO - Running setup.py (path:/tmp/pip-XZfNq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:50 INFO - Running setup.py (path:/tmp/pip-lUTZBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:50 INFO - Running setup.py (path:/tmp/pip-cqIYku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:50 INFO - Running setup.py (path:/tmp/pip-g6aOdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:50 INFO - Running setup.py (path:/tmp/pip-urS8si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:50 INFO - Running setup.py (path:/tmp/pip-A8gLmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:50 INFO - Running setup.py (path:/tmp/pip-X72ehx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:50 INFO - Running setup.py (path:/tmp/pip-TgeDVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:50 INFO - Running setup.py (path:/tmp/pip-4qidLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:50 INFO - Running setup.py (path:/tmp/pip-qty1bO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:50 INFO - Running setup.py (path:/tmp/pip-4v1S9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:11:50 INFO - Running setup.py install for manifestparser 19:11:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:11:50 INFO - Running setup.py install for mozcrash 19:11:51 INFO - Running setup.py install for mozdebug 19:11:51 INFO - Running setup.py install for mozdevice 19:11:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Running setup.py install for mozfile 19:11:51 INFO - Running setup.py install for mozhttpd 19:11:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Running setup.py install for mozinfo 19:11:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Running setup.py install for mozInstall 19:11:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Running setup.py install for mozleak 19:11:51 INFO - Running setup.py install for mozlog 19:11:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Running setup.py install for moznetwork 19:11:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Running setup.py install for mozprocess 19:11:52 INFO - Running setup.py install for mozprofile 19:11:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Running setup.py install for mozrunner 19:11:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Running setup.py install for mozscreenshot 19:11:52 INFO - Running setup.py install for moztest 19:11:52 INFO - Running setup.py install for mozversion 19:11:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:11:52 INFO - Cleaning up... 19:11:52 INFO - Return code: 0 19:11:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:52 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 0x7f42a3816e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bacb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6fc0>, '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 0x1dd7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8350>, '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': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', '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 19:11:52 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 19:11:52 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 19:11:52 INFO - Using env: {'DISPLAY': ':0', 19:11:52 INFO - 'HOME': '/home/cltbld', 19:11:52 INFO - 'LANG': 'en_US.UTF-8', 19:11:52 INFO - 'LANGUAGE': 'en_US:en', 19:11:52 INFO - 'LOGNAME': 'cltbld', 19:11:52 INFO - 'MAIL': '/var/mail/cltbld', 19:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:52 INFO - 'MOZ_NO_REMOTE': '1', 19:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:52 INFO - 'NO_EM_RESTART': '1', 19:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:52 INFO - 'PWD': '/builds/slave/test', 19:11:52 INFO - 'SHELL': '/bin/bash', 19:11:52 INFO - 'SHLVL': '1', 19:11:52 INFO - 'TERM': 'linux', 19:11:52 INFO - 'TMOUT': '86400', 19:11:52 INFO - 'USER': 'cltbld', 19:11:52 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', 19:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:52 INFO - '_': '/tools/buildbot/bin/python'} 19:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:52 INFO - Running setup.py (path:/tmp/pip-B_C5RD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:52 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)) 19:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:52 INFO - Running setup.py (path:/tmp/pip-hIHNTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:53 INFO - Running setup.py (path:/tmp/pip-fXjnTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:53 INFO - Running setup.py (path:/tmp/pip-ngVSsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:53 INFO - Running setup.py (path:/tmp/pip-MPvPZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:53 INFO - Running setup.py (path:/tmp/pip-P4oJJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:53 INFO - Running setup.py (path:/tmp/pip-vtmm0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:53 INFO - Running setup.py (path:/tmp/pip-J47iBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:53 INFO - Running setup.py (path:/tmp/pip-xopcfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:53 INFO - Running setup.py (path:/tmp/pip-lYGB4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:53 INFO - Running setup.py (path:/tmp/pip-BHQb6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:53 INFO - Running setup.py (path:/tmp/pip-r_8Nc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:53 INFO - Running setup.py (path:/tmp/pip-kM2RsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:53 INFO - Running setup.py (path:/tmp/pip-wsAagp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:53 INFO - Running setup.py (path:/tmp/pip-2IT5xY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:54 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)) 19:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:54 INFO - Running setup.py (path:/tmp/pip-jEL1WF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:54 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)) 19:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:54 INFO - Running setup.py (path:/tmp/pip-RkSfmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:54 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)) 19:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:11:54 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)) 19:11:54 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:11:54 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:11:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11:56 INFO - Downloading blessings-1.6.tar.gz 19:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:11:56 INFO - Installing collected packages: blessings 19:11:56 INFO - Running setup.py install for blessings 19:11:56 INFO - Successfully installed blessings 19:11:56 INFO - Cleaning up... 19:11:56 INFO - Return code: 0 19:11:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:11:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:56 INFO - Reading from file tmpfile_stdout 19:11:56 INFO - Current package versions: 19:11:56 INFO - argparse == 1.2.1 19:11:56 INFO - blessings == 1.6 19:11:56 INFO - blobuploader == 1.2.4 19:11:56 INFO - docopt == 0.6.1 19:11:56 INFO - functools32 == 3.2.3-2 19:11:56 INFO - jsonschema == 2.5.1 19:11:56 INFO - manifestparser == 1.1 19:11:56 INFO - mozInstall == 1.12 19:11:56 INFO - mozcrash == 1.0 19:11:56 INFO - mozdebug == 0.1 19:11:56 INFO - mozdevice == 0.49 19:11:56 INFO - mozfile == 1.2 19:11:56 INFO - mozhttpd == 0.7 19:11:56 INFO - mozinfo == 0.9 19:11:56 INFO - mozleak == 0.1 19:11:56 INFO - mozlog == 3.4 19:11:56 INFO - moznetwork == 0.27 19:11:56 INFO - mozprocess == 0.23 19:11:56 INFO - mozprofile == 0.28 19:11:56 INFO - mozrunner == 6.13 19:11:56 INFO - mozscreenshot == 0.1 19:11:56 INFO - mozsystemmonitor == 0.3 19:11:56 INFO - moztest == 0.7 19:11:56 INFO - mozversion == 1.4 19:11:56 INFO - psutil == 3.1.1 19:11:56 INFO - requests == 1.2.3 19:11:56 INFO - wsgiref == 0.1.2 19:11:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:56 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 0x7f42a3816e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bacb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6fc0>, '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 0x1dd7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8350>, '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': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', '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 19:11:56 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 19:11:56 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 19:11:56 INFO - Using env: {'DISPLAY': ':0', 19:11:56 INFO - 'HOME': '/home/cltbld', 19:11:56 INFO - 'LANG': 'en_US.UTF-8', 19:11:56 INFO - 'LANGUAGE': 'en_US:en', 19:11:56 INFO - 'LOGNAME': 'cltbld', 19:11:56 INFO - 'MAIL': '/var/mail/cltbld', 19:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:56 INFO - 'MOZ_NO_REMOTE': '1', 19:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:56 INFO - 'NO_EM_RESTART': '1', 19:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:56 INFO - 'PWD': '/builds/slave/test', 19:11:56 INFO - 'SHELL': '/bin/bash', 19:11:56 INFO - 'SHLVL': '1', 19:11:56 INFO - 'TERM': 'linux', 19:11:56 INFO - 'TMOUT': '86400', 19:11:56 INFO - 'USER': 'cltbld', 19:11:56 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', 19:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:56 INFO - '_': '/tools/buildbot/bin/python'} 19:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:56 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)) 19:11:56 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)) 19:11:56 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)) 19:11:56 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)) 19:11:56 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)) 19:11:56 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)) 19:11:56 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)) 19:11:56 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)) 19:11:56 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)) 19:11:56 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)) 19:11:56 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)) 19:11:56 INFO - Cleaning up... 19:11:56 INFO - Return code: 0 19:11:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:56 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 0x7f42a3816e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bacb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6fc0>, '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 0x1dd7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8350>, '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': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', '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 19:11:56 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 19:11:56 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 19:11:56 INFO - Using env: {'DISPLAY': ':0', 19:11:56 INFO - 'HOME': '/home/cltbld', 19:11:56 INFO - 'LANG': 'en_US.UTF-8', 19:11:56 INFO - 'LANGUAGE': 'en_US:en', 19:11:56 INFO - 'LOGNAME': 'cltbld', 19:11:56 INFO - 'MAIL': '/var/mail/cltbld', 19:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:56 INFO - 'MOZ_NO_REMOTE': '1', 19:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:56 INFO - 'NO_EM_RESTART': '1', 19:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:56 INFO - 'PWD': '/builds/slave/test', 19:11:56 INFO - 'SHELL': '/bin/bash', 19:11:56 INFO - 'SHLVL': '1', 19:11:56 INFO - 'TERM': 'linux', 19:11:56 INFO - 'TMOUT': '86400', 19:11:56 INFO - 'USER': 'cltbld', 19:11:56 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', 19:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:56 INFO - '_': '/tools/buildbot/bin/python'} 19:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:11:57 INFO - Cleaning up... 19:11:57 INFO - Return code: 0 19:11:57 INFO - Running post-action listener: _resource_record_post_action 19:11:57 INFO - Running post-action listener: _start_resource_monitoring 19:11:57 INFO - Starting resource monitoring. 19:11:57 INFO - [mozharness: 2016-11-27 03:11:57.073813Z] Finished create-virtualenv step (success) 19:11:57 INFO - [mozharness: 2016-11-27 03:11:57.074294Z] Running install step. 19:11:57 INFO - Running pre-action listener: _resource_record_pre_action 19:11:57 INFO - Running main action method: install 19:11:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:57 INFO - Reading from file tmpfile_stdout 19:11:57 INFO - Detecting whether we're running mozinstall >=1.0... 19:11:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:11:57 INFO - Reading from file tmpfile_stdout 19:11:57 INFO - Output received: 19:11:57 INFO - Usage: mozinstall [options] installer 19:11:57 INFO - Options: 19:11:57 INFO - -h, --help show this help message and exit 19:11:57 INFO - -d DEST, --destination=DEST 19:11:57 INFO - Directory to install application into. [default: 19:11:57 INFO - "/builds/slave/test"] 19:11:57 INFO - --app=APP Application being installed. [default: firefox] 19:11:57 INFO - mkdir: /builds/slave/test/build/application 19:11:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:12:13 INFO - Reading from file tmpfile_stdout 19:12:13 INFO - Output received: 19:12:13 INFO - /builds/slave/test/build/application/firefox/firefox 19:12:13 INFO - Running post-action listener: _resource_record_post_action 19:12:13 INFO - [mozharness: 2016-11-27 03:12:13.400460Z] Finished install step (success) 19:12:13 INFO - [mozharness: 2016-11-27 03:12:13.400702Z] Running run-tests step. 19:12:13 INFO - Running pre-action listener: _resource_record_pre_action 19:12:13 INFO - Running main action method: run_tests 19:12:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:12:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:12:13 INFO - Python 2.7.3 19:12:13 INFO - Return code: 0 19:12:13 INFO - grabbing minidump binary from tooltool 19:12:13 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')]} 19:12:13 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 0x1dd6fc0>, '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 0x1dd7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:12:13 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 19:12:13 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 19:12:13 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 19:12:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:12:13 INFO - Return code: 0 19:12:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:12:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:12:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:12:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:12:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:12:13 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/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 19:12:13 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/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 19:12:13 INFO - Using env: {'DISPLAY': ':0', 19:12:13 INFO - 'HOME': '/home/cltbld', 19:12:13 INFO - 'LANG': 'en_US.UTF-8', 19:12:13 INFO - 'LANGUAGE': 'en_US:en', 19:12:13 INFO - 'LOGNAME': 'cltbld', 19:12:13 INFO - 'MAIL': '/var/mail/cltbld', 19:12:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:12:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:13 INFO - 'MOZ_NO_REMOTE': '1', 19:12:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:13 INFO - 'NO_EM_RESTART': '1', 19:12:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:13 INFO - 'PWD': '/builds/slave/test', 19:12:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:12:13 INFO - 'SHELL': '/bin/bash', 19:12:13 INFO - 'SHLVL': '1', 19:12:13 INFO - 'TERM': 'linux', 19:12:13 INFO - 'TMOUT': '86400', 19:12:13 INFO - 'USER': 'cltbld', 19:12:13 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835', 19:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:13 INFO - '_': '/tools/buildbot/bin/python'} 19:12:13 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/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 19:12:13 INFO - mozversion application_buildid: 20161126175419 19:12:13 INFO - mozversion application_changeset: 3d81e7906de637040bb850628487fd8aa921569c 19:12:13 INFO - mozversion application_display_name: Nightly 19:12:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:12:13 INFO - mozversion application_name: Firefox 19:12:13 INFO - mozversion application_remotingname: firefox 19:12:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:12:13 INFO - mozversion application_vendor: Mozilla 19:12:13 INFO - mozversion application_version: 53.0a1 19:12:13 INFO - mozversion platform_buildid: 20161126175419 19:12:13 INFO - mozversion platform_changeset: 3d81e7906de637040bb850628487fd8aa921569c 19:12:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:12:13 INFO - mozversion platform_version: 53.0a1 19:12:13 INFO - using testdate: 1480216333 19:12:13 INFO - actual date: 1480216333 19:12:13 INFO - starting webserver on 'localhost:40378' 19:12:13 INFO - SUITE-START | Running 2 tests 19:12:13 INFO - TEST-START | dromaeo_css 19:12:13 INFO - operating with platform_type : linux_ 19:12:13 INFO - Initialising browser for dromaeo_css test... 19:12:13 INFO - TEST-INFO | started process 17959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsK5yIh/profile http://localhost:40378/getInfo.html) 19:12:17 INFO - PROCESS | 17959 | __metrics Screen width/height:1600/1200 19:12:17 INFO - PROCESS | 17959 | colorDepth:24 19:12:17 INFO - PROCESS | 17959 | Browser inner width/height: 1024/697 19:12:17 INFO - PROCESS | 17959 | __metrics 19:12:18 INFO - PROCESS | 17959 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:12:18 INFO - PROCESS | 17959 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:12:19 INFO - PROCESS | 17959 | console.error: PushService: 19:12:19 INFO - PROCESS | 17959 | stateChangeProcessEnqueue: Error transitioning state 19:12:19 INFO - PROCESS | 17959 | UnknownError 19:12:19 INFO - TEST-INFO | 17959: exit 0 19:12:19 INFO - Browser initialized. 19:12:19 INFO - Running cycle 1/1 for dromaeo_css test... 19:12:19 INFO - TEST-INFO | started process 18043 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsK5yIh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:31 INFO - PROCESS | 18043 | RSS: Main: 175640576 19:12:31 INFO - PROCESS | 18043 | 19:13:23 INFO - PROCESS | 18043 | 1480216403344 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] 19:15:37 INFO - PROCESS | 18043 | Cycle 1(1): loaded http://localhost:40378/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40378/tests/dromaeo/cssquery-ext.html) 19:15:39 INFO - PROCESS | 18043 | RSS: Main: 317345792 19:15:39 INFO - PROCESS | 18043 | 19:18:41 INFO - PROCESS | 18043 | Cycle 1(1): loaded http://localhost:40378/tests/dromaeo/cssquery-ext.html (next: http://localhost:40378/tests/dromaeo/cssquery-jquery.html) 19:18:42 INFO - PROCESS | 18043 | RSS: Main: 277291008 19:18:42 INFO - PROCESS | 18043 | 19:21:44 INFO - PROCESS | 18043 | Cycle 1(1): loaded http://localhost:40378/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40378/tests/dromaeo/cssquery-mootools.html) 19:21:45 INFO - PROCESS | 18043 | RSS: Main: 222777344 19:21:45 INFO - PROCESS | 18043 | 19:24:48 INFO - PROCESS | 18043 | Cycle 1(1): loaded http://localhost:40378/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40378/tests/dromaeo/cssquery-prototype.html) 19:24:48 INFO - PROCESS | 18043 | RSS: Main: 219480064 19:24:48 INFO - PROCESS | 18043 | 19:27:51 INFO - PROCESS | 18043 | Cycle 1(1): loaded http://localhost:40378/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40378/tests/dromaeo/cssquery-yui.html) 19:27:52 INFO - PROCESS | 18043 | RSS: Main: 224370688 19:27:52 INFO - PROCESS | 18043 | 19:30:55 INFO - PROCESS | 18043 | Cycle 1(1): loaded http://localhost:40378/tests/dromaeo/cssquery-yui.html (next: http://localhost:40378/tests/dromaeo/cssquery-dojo.html) 19:30:56 INFO - PROCESS | 18043 | RSS: Main: 317034496 19:30:56 INFO - PROCESS | 18043 | 19:30:56 INFO - PROCESS | 18043 | __start_tp_report 19:30:56 INFO - PROCESS | 18043 | _x_x_mozilla_page_load 19:30:56 INFO - PROCESS | 18043 | _x_x_mozilla_page_load_details 19:30:56 INFO - PROCESS | 18043 | |i|pagename|runs| 19:30:56 INFO - PROCESS | 18043 | |0;dojo.html;2554.386947132688;2584.185981415853;2604.830686005409;2613.7778288845448;2624.514464824009;4536.818527258905;4605.9769701151445;4638.420197475316;4678.976605116974;4688.601468875146;4600.42494688164;4614.907701845961;4666.183417901862;4708.199606066968;4749.928751068736;4226.323788193889;4239.9576004240025;4276.208901353244;4310.267254566716;4369.956300436987;3927.913393405506;4222.0922501662135;4351.238533256684;4361.672874534407;4406.845760398371;4213.157368526307;4244;4362.912741745179;4385.605295523418;4436.268015777409;4249.46881639795;4274;4288.099499105192;4292.613664770154;4373.934390984138;4253.574642535753;4254.425652536899;4263.445752052214;4281.272183728774;4300.483941926988;4614.169449499089;4651.790669419885;4655.767211639404;4669.182892993713;4700.882477938045;4685.297205419214;4784.282357646381;4784.330193772875;4872.56146946773;4875.098106850244;4977.0792403405485;5005.57452616528;5011.874703132415;5019.14674505335;5021.447640759514;4628.213203755336;4633.189191891405;4635.884102897455;4636.629069674418;4676.088162808288;4906.092372911023;5066.240063990357;5072.923906141411;5075;5117.923231151536;4727.810887564528;4767.95232047682;4813.711177329302;4814.061258054646;4814.687045342112;4895.461499235082;4937.851864444001;4942.851714448572;5013.749312534359;5016.0971025215085;4907.092187945242;4930.33440485537;4973.179425394842;4973.676711013773;4973.726445045485;4895.167821470359;4912.1158191525865;4918.5161493445585;4919.335889654851;4962.826301079517;4047.3928910663635;4084.9183016339507;4097.508299004079;4146;4181.163767246563;3592.0660628236324;3615.6384361563632;3620.25784714133;3649.7262705297208;3677.0807298175455;4272.829086836554;4273.465816772903;4273.63674087706;4285;4327.32926396409;4949.505049495094;4958.157113290749;4963.379577552806;4963.404391472975;4983.451820299764;4179.122384299331;4193.748375097504;4214.978925105354;4218.873433796991;4227.260229459832;4423.579759922803;4428.82284708608;4442.044960333544;4457.99695068607;4470.351798989193;4630;4639.768011599339;4640.651951103613;4681.67228294023;4686.507916668837;4833.661643685049;4901.656884018084;4912.410510738734;4939.728314942713;4944.505549445027;4678.625709943129;4701.553352431513;4708.882277942942;4732.787024583833;4791.904161916812;4967.40391153064;4975.4278258000795;4977.800887964441;4979.103761322996;5024.598032157345;4791.952080479151;5027.849164524924;5041.193409054534;5042.218456139304;5086.567641750345;4733.290006498915;4784.30627558995;4849.612031037438;4897.118518666532;4901.117798796251;4881.365422495195;4918.655694101379;4920.950790492192;4928.802847886044;4953.455119936876;4862.562369386772;4874.4150701916;4874.4150701916;4876.487968763229;4889.755512224303;4735.455422626442;4784.617230621472;4786.425628924551;4843.564079232886;4964.950350496449;4683.906321873612;4708.952910470988;4715.740634265148;4741.2651039089;4745.549172828576 19:30:56 INFO - PROCESS | 18043 | |1;ext.html;533.9305890234269;545.4572700163338;551.674512037898;553.4354957942899;561.3292115921474;27209.183724488274;29724.40551188975;36518.26963460733;38024.42963355552;38354.61645383545;36493.45259821105;37044.81477592615;37049.814750926205;37114.443283350774;37289.25421491575;7335.743248986273;7487.625618719069;7490.1011878574645;7490.176080631126;7498.8125296867465;7257.637118144098;7457.254274572527;9568.521573921276;9856.950715246414;9868.802623947517;9911.950440247789;9977.90022099777;9989.800203995952;9991.350562213469;9992.550335234895;9767.658131965383;9814.362066465657;9815.803683926353;9831.459269740162;9836.999999999964;9774.706758797247;9831.115199632068;9834.606615735362;9840;9845.45849978251;36513.45229821555;36748.63251367505;36845.63154368449;36851.63148368509;36966.07584810374;3060.617422822147;3096.9535456968165;3103.658597554267;3149.8740050397955;3178.5867837181017;27057.32356691079;27095.458090838074;27449.17652470429;27874.168721512204;28171.154865354074;3114.6418161911442;3133.498640217577;3156.226724452501;3192.122166404234;3231.951520727191;238931.80534097392;238952;239229;239819;240458;49161.754191228814;49579.75210123998;49825.25262121071;49956.25065624018;50005.74997124991;50811.745941270055;50885.49114508882;50911;50943.23585146226;50968.74515627398;13406.93296533511;13716.314184290746;13751.724965500634;13843.16940983524;13894.374753136133;8263.462874913112;8342.791430214293;10037.39775613451;10066.446345450924;10088.949555252324;14332.426702931974;14632.561023169323;14827.406903723946;15204.619884502976;15240.542783716506;6031.487323577545;6053.636781793107;6157.2611286645;6164.961949922807;6165.475934545614;786.9134395216522;867.4708427859001;869.2090197919863;896.9641214351353;953.3088510829732;26815.73184268132;26980.73019269782;27188.59217111745;27787.16638500848;27792.58311125335;941.6798288581915;941.8210539997378;947.3842002698163;970.4710932541782;973.6981535723806;12954;13989;14250.358733857001;14252.144871307755;14254.3585538651;322828;324806;325786;326037;326596;44985.77507112444;45115.54884451179;45135.548644513794;45222.32166517505;45230.32154517619;1029.7271223125877;1084.2681190196743;1124.2467546743537;1191.3447603817865;1218.5004148299154;25082.62376064324;27230.319242019108;27502;28194.43611127807;28204.294892627848;40006.59993400029;40386.19227615373;40387.394189087776;40390.59609403869;40409;228753;230068;231064;231275;231433;20682.896585516977;21410.892945535797;21414.25050123238;21416.250431234832;22985.65521517145;39060.41409378805;39537.60462395454;39938.2012359757;39943.60056399515;40756.79621601873;34394.31211375808;34455.31089378148;34704.826475867456;34909.65090349165;35110;34629.13427164341;34747;34771;34829.12927176841;34945.12637184091;34204.48693269553;34400.655993439745;34448.483272750425;34856.30287394187;35150.824245878604;29577.85211073931;31791.364172715952;31877.840610796797;32028;32120.678793212704;24414.511709766062;24451;24463;25002.874985625684;25019.74980250174 19:30:56 INFO - PROCESS | 18043 | |2;jquery.html;337.65896444590953;345.5594117500187;352.4554563199856;359.62239648369206;376.8002958432032;12710.936445317771;12931;13707.38316775745;13845.584632461017;16861.156942152906;13938.372773225205;14152.92923535381;14492;15271.847281527182;15523.146226957513;4788.233882578788;5012.022655582145;5013.448520662724;5059.49405059493;5322.175062865262;5332.493413125766;5373.247745315659;5374.193870919355;5381.623286369956;5382.5963052771;3349.648286929874;3540.9645903541023;5008.524190201925;5233.973830130844;5258.13240815265;5265.9204863003;5345.1714984177515;5350.518453339179;5350.91973620396;5355.2770375999135;5125.666831655968;5188.45521220274;5211.791528338862;5224.791008359661;5228.2941802856885;11939.641810745692;12176.939115304456;12180;18917.43247702571;19955.102020409115;1783.5362805670488;1854.7588813454165;1891.3947536788232;1936.8160024797621;1985.7815640279703;8897.911020889773;9084.545772711337;9280.071992800666;9609.711708648752;9662.08210220028;1684.8399402056784;1763.4357005758163;1767.849732772716;1778.8221177882237;1787.4012205910906;58977.70511147417;64354.35645643531;65228;65548.3445165547;71563.64218178876;9536.570854311572;9549.800816726474;9846.056275919527;9912.55393507294;9921.603135874628;13400.597982060553;13400.664983375298;13404.932975335061;13416.932915335361;13420.597382078553;6976.651167441608;7167.641617919083;7271.854562908712;7365.005724227268;7396.704131834666;6834.863302733917;6845.623490708059;7018.052562903943;7053.541519801299;7056.858862822714;4167.604077612622;4213.452251207324;4261.701680882308;4313.266744653416;4342.696011279243;1537.1545649892514;1580.4863419388744;1587.7538981457892;1619.6679680665436;1818.7817461904656;766.72226232855;820.4134044158455;824.744329257932;933;946.1201082992745;15669.138197399252;16267.105309208107;16772.496825095266;17044.48866533981;17303.65392692139;825.8802473641408;838.4927119092982;846.4667259626395;888.4846788862444;899.9325050621098;9071.682491112779;9120.58957346921;9497.435692363024;9503.762405939908;9641.180499657466;262197;265906;266054;327147;333671;77651;79498.6025069871;79887;80044.5997770019;80098.59950700325;864.4208380385157;889.3552174673439;920.9309301802392;921.2860033473977;921.709661456639;15202.923985380003;15243.3902643893;15805.288762005968;16058.357665693242;16120.435784747477;35043.47434788531;35456;35545.64454355527;35720.74886894835;36572.81713591415;44427;49271;49444.50555494399;51032.48967510426;51845.7407712959;6839.658017099225;7301.415886729155;7424;7452.403807695479;7495.7001719930595;10332.896671033193;10556.15550755953;10701.678949631523;10771.353718776898;11274.379909105079;9585;9652.469114198786;9860.950695246478;9943.850842237516;10117.08946194846;9516.333856630246;9702.369345992487;9879.95060024724;10042.69871903844;10063.798724025331;9713.9028609713;9731.461809062921;9931.553080111267;10211.132053775214;10278.845817312897;7105.964470177616;7196.460265480006;7235.746748863765;7313.524620899624;7502.924970750441;9229.307801914749;9529.761755956157;9922.900770992197;9965.551550180404;9999.800004000024 19:30:56 INFO - PROCESS | 18043 | |3;mootools.html;1141.115635382578;1312.9102844638949;1344.126317893369;1399.8110255115557;1643.7863077799877;5886.911696324553;6478.805635830927;6711.295313992034;6737.5620584661965;6899.896501552468;6709.597424154542;6767.255601883801;6776.220734615521;6781.932180678204;6792.049113124167;1751.658426606812;1826.6711991841464;1977.4166620846884;2022.1810166882435;2022.7269318641943;1962.5486138188226;2038.7859274776158;2040.3572874544545;2060.3818854343635;2062.3194345865904;1948.756405449319;1951.9024048797573;1952.1898412158937;1957.4616980330452;1963.980360196394;1967.3114409956545;2029.9797002029939;2035;2037.1342179573696;2038.3171637501455;1965.9508512287164;1968.5964377302619;1968.6456437841182;1973.447434718281;1993.7806841247452;6712.194536655633;6807.4894382921475;6867.622280774555;6871.244163142051;6872.209695884937;4038.7980600969836;4159.9376009359885;4160.251154792136;4160.521540022906;4161.25097482453;2468.1731619907355;2619.7118316985116;2671.719469455699;2696.0294294054124;2723.8774255158564;807.5962018990505;858.8196478739472;860.8407444622765;861.1001503428931;864.9069252409184;8773.561321933941;8782.38523303369;8783.209511144029;8788.121187881161;8800.383973121883;3451.137215696076;3656.945145822815;3714.9442758358646;3732.0483276764253;3734.3091528067393;7466.104067511933;7466.141393739789;7477;7478.177400485943;7488.213737557587;4134.793260336971;4149.688773342012;4149.8340066397;4152.626263636287;4153.54311025787;3220.4525230710838;3326.8336583170744;3468.1849765305133;3791.4123310886857;3798.525184351956;3132.530120481946;3212.823294718813;3277.2298509850166;3299.290652509674;3329.6670332966996;1035.9792804143874;1041.8645576075062;1047.3820445936933;1049.9580016799243;1062.6068354708652;598.3418239936123;768.4044865229492;773.3890226720828;778.2412148155503;800.2997377294867;4435.866923992286;4478.305862591238;4666;4738.976305118453;4836.202026665561;769.1808224241165;793.4644115222318;834.1241696218946;841.4951029382322;848.4612271207827;2986.2086547065046;3008.262975570999;3079.6920307969026;3141.3560220154814;3141.403133404646;7300.598467084255;7675.884861727079;7885.763427097197;8099.514029158269;8151.551664658382;7826.608669566499;7831.843363132705;7846.176151504124;7861.842763144819;7898;6315.179026726496;6474.061261117112;6480.351964803576;6492.935070649328;6492.935070649328;4428.225060614444;4464.352668862932;4489.506154323087;4603.700759450625;4781.043791241696;7070.7525236616475;7213.20654727969;7372.152202496782;7409.481336306407;7563.130240022468;7451.3293803557945;7548.622568871425;7571;7580;7618.238176182337;5288.9735551322;5835.9708201458725;6047.516198704181;6053.515718742578;6061.393860613904;5948.018576934757;6163.106349579196;6166.1983942087245;6185.505159587312;6187.969060154851;5988.341282459013;6025.849353766191;6035.064564992434;6071.757129714939;6229.4393504584805;5933.732982015906;5955.940440595538;6030.793202123596;6114.5414093942245;6317.842053948688;5363;5382.111951527954;5405.405405405481;5417.729113544386;5419.945800542102;4049.250888585621;4084.9591504085765;4156.563560826191;4201.432806571196;4288.742675439484;3908.4918960534947;3908.863189788344;3956.465877106669;3962.7622342659533;4125.443065186161 19:30:56 INFO - PROCESS | 18043 | |4;prototype.html;292.48814574494634;294.1997766076273;297.7201430655185;298.2023088238961;300.49816805934086;4755.3104799804005;4785.377900872891;4808.220958245445;4816.325714399983;4823.397075365579;4693.765311734408;4697.318888761136;4715.2219883719235;4723.504032076626;4741.8103275868925;3558.2171922177145;3672.210474747929;3690.2066055798;3699.648533389324;3734.813259337036;3739.8691045813266;3751.536900608765;3751.737378383514;3752.5309336332957;3768.2651882882847;3723.236736469017;3727.3413331067686;3730.682891954187;3730.7688462807346;3733.290674771785;3536.876209332674;3612.6929211017095;3649.8540058397634;3716.937099909549;3739.5138631977807;3306.7183643286057;3313.4698448248164;3315.6850099240773;3316.7014968652697;3328.8169150696704;4581.908361832778;4592.15045216636;4592.540745925414;4597.793099310506;4614.754016415583;4098.426220329156;4251.2347777400055;4255.851045213433;4256.957430425687;4264.253755592759;4893.853184404474;4922.926156107661;4928.507149285078;4935.80256789728;4939.777710003023;3606.1525541497726;3612.512310838056;3614.620464851179;3615.7649752765988;3618.7828730276005;5128.74345785285;5132.435432102466;5158.974205128988;5164.159712158298;5175.637705360664;3603.747737658391;3658.6645874256237;3685.4103343465454;3699.7965111918566;3711.2948539777894;3675;3757.0607348162957;3759.9060023499082;3767.6420740030203;3767.773933563995;4171.812268447867;4184.853530126431;4186.6859985501205;4204.201201771715;4220.746755194698;4799.400074990626;4830.798563603092;4886.633502487328;4889.902201955941;4899.314096026559;1242.7949388350821;1252.5428218700108;1258.5280519805074;1260.4580030586935;1260.5462033667873;848.7665891879659;869.6434461870602;869.7738587967174;880.3221519430003;885.1148851148852;4238.6397156242065;4348.543238015237;4353.25994580922;4356.302991521341;4362.781860906942;4967.254911763264;4993.625478089158;5025.623078269145;5113.1563292057135;5124.231365295235;4411.647068234533;4416.4258646375765;4428.235999400548;4429.357743127293;4431.933520997188;2557.1588456311424;2605.5310044191847;2635.8418494890366;2642.947141057168;2644.418227989878;4587.678862479661;4658.464276608166;4678.345031695565;4679.157751604744;4696.272077827942;5005.1491246488185;5014.548690617862;5034.84895453137;5036.715637512484;5070.442251352349;4477.283634618446;4673.392458980379;4681.178386262155;4684.414448193976;4709.62323014158;4979.3277907482025;4986.850394488171;5005.6996580205305;5016.169098279175;5035.446100928968;4899.730514821719;4917.237828136645;4920.335754673073;4927.310176575354;4956.925646115239;4464.722991274539;4687.703025517404;4705.341252224623;4713.29300604912;4717.292406139107;3594;3596.4065929121402;3597.5323207982797;3602.8378722957004;3603.135247540624;5002.749862506933;5003.574696150868;5003.974980125222;5015.17249653803;5027.497250274943;4692.202325604587;4833.830815921426;4861.368022157097;4861.562459378673;4871.488493708252;4843.418789745253;4848.781804818721;4857.805687772449;4863.659543831898;4873.707577545359;4624.768761561976;4785.569298763128;4798.832040878552;4801.855944321676;4815.590674792682;4607.285870689914;4768.499307572793;4841.322214889848;4875.952529668957;4891.73095479752;4685.437747470325;4692.178868698033;4694.647901407477;4725.480197178239;4732.337472753886 19:30:56 INFO - PROCESS | 18043 | |5;yui.html;577.2870504926415;653.5818264641222;703.0754557756549;707.8442742596627;755.550447483747;11110;11542.711432214199;11813.291202527844;12714.491420343174;12902.80645790314;11980.64058078259;12110.15228933975;12121.636350909486;12122.575709850134;12130.332831694253;630.7413960276288;754.6113751418025;761.6306091545596;762.1768490030781;763.2100775697155;644.0403798340486;746.2127455534409;789.8973133492667;790.4190420041265;798.5647821937058;840.9537475438848;843.4517563583659;843.5992903370881;843.6456688190974;843.9831203375929;644.1400730025422;838.3795990966702;839.064443145891;839.1692224697506;839.668331009251;498.52390966626785;568.408854791021;597.9133025711291;602.1028667285757;605.503487140545;12283.263004219776;12309.630711078682;12325.383730813513;12332.506699732;12341.5063397464;11543.653690389301;11705.648830535098;11914.225575337576;12178.81731774024;12504.124711270215;10776.5689372425;10912.23614346996;10989.61536346232;11160.441977901153;11218.719532011764;3960.485136932209;3962.8612998544913;3963.8414463421427;3968.72218944674;4015.297322968469;42161.367579486636;45954;45966.77016614929;45995.54004459946;46805.063898722176;9335.299852510952;9386.483743394043;9490.857637135448;9734.9026509734;9927.851082233772;16986.150692465326;17224.311027559008;17234.052127132876;17539.824601754073;17549.736753948702;6757.763478278237;6833.350831670983;6881.10545629065;6902.585844849325;6986.650667466606;3465.8786942457396;3625.456181572785;3642.562892452923;3679.172186258124;3701.3892707703467;2594.8313359631943;2683.5303821831103;2696.9595456068173;2724.0874307106947;2765.737254960816;467.6329081670872;472.89123501594827;474.4448994676237;483.97338146402285;486.151665343977;495.46489791025607;541.0963690636646;577.3735496985734;624.3974564545235;627.9529035322369;7640.69437222516;8027.598620068973;8240.83518329642;8254.876176857351;8446.155384461505;469.89427378839486;544.7004147718818;546.2243614067953;561.848300958747;562.8283373571101;3726.1988672435555;3775.2638235543805;3784.4890939723336;3979.3633018717446;3979.503161427568;42195.7890210547;48346;67356;73715.26284737085;73956.63021684857;59100.113498297556;61142;61153.694231528556;61176;61449.69275153596;55589.722051390294;55854;57052.42947570554;57233.71383143058;59189.40810592011;7714.537127772352;7861.371090312876;7876.09424916142;7970.840583188187;8155.959220203861;38741.2251754969;39277.60722392739;39462.40806387849;40022.59977400305;40752.33229009403;53778.193327100904;53887.73056134694;54154.18768718551;54180;55120.724396379366;9033.728988130366;9150.816983660156;9301.395409298373;9328.53357332117;9547.42715437076;10764.586519527269;10906.672799816019;10929.289596176222;11260.324380537195;11465.254758440675;9526.85709714341;9976.650817221653;10040.598376064876;10050.09549140581;10248.53881575316;9991.750206244902;10311.793764124826;10513.526891289757;10803.621873234399;10805.297655652357;9443.480608566595;9735.123838854537;10022.949885250528;10374.014468625468;10395;7821.178776228414;7876.794258373343;7951.244631759973;8020.919790802251;8201.835963280582;7900.2889739923685;8314;8421.789455263422;8485.915140848512;8621.310295176496 19:30:56 INFO - PROCESS | 18043 | __end_tp_report 19:30:56 INFO - PROCESS | 18043 | __start_cc_report 19:30:56 INFO - PROCESS | 18043 | _x_x_mozilla_cycle_collect,1491 19:30:56 INFO - PROCESS | 18043 | __end_cc_report 19:30:56 INFO - PROCESS | 18043 | __startTimestamp1480217456006__endTimestamp 19:30:56 INFO - PROCESS | 18043 | 19:30:56 INFO - PROCESS | 18043 | ------- Summary: start ------- 19:30:56 INFO - PROCESS | 18043 | Number of tests: 6 19:30:56 INFO - PROCESS | 18043 | 19:30:56 INFO - PROCESS | 18043 | [#0] dojo.html Cycles:165 Average:4581.43 Median:4708.20 stddev:484.70 (10.3%) stddev-sans-first:459.37 19:30:56 INFO - PROCESS | 18043 | Values: 2554.4 2584.2 2604.8 2613.8 2624.5 4536.8 4606.0 4638.4 4679.0 4688.6 4600.4 4614.9 4666.2 4708.2 4749.9 4226.3 4240.0 4276.2 4310.3 4370.0 3927.9 4222.1 4351.2 4361.7 4406.8 4213.2 4244.0 4362.9 4385.6 4436.3 4249.5 4274.0 4288.1 4292.6 4373.9 4253.6 4254.4 4263.4 4281.3 4300.5 4614.2 4651.8 4655.8 4669.2 4700.9 4685.3 4784.3 4784.3 4872.6 4875.1 4977.1 5005.6 5011.9 5019.1 5021.4 4628.2 4633.2 4635.9 4636.6 4676.1 4906.1 5066.2 5072.9 5075.0 5117.9 4727.8 4768.0 4813.7 4814.1 4814.7 4895.5 4937.9 4942.9 5013.7 5016.1 4907.1 4930.3 4973.2 4973.7 4973.7 4895.2 4912.1 4918.5 4919.3 4962.8 4047.4 4084.9 4097.5 4146.0 4181.2 3592.1 3615.6 3620.3 3649.7 3677.1 4272.8 4273.5 4273.6 4285.0 4327.3 4949.5 4958.2 4963.4 4963.4 4983.5 4179.1 4193.7 4215.0 4218.9 4227.3 4423.6 4428.8 4442.0 4458.0 4470.4 4630.0 4639.8 4640.7 4681.7 4686.5 4833.7 4901.7 4912.4 4939.7 4944.5 4678.6 4701.6 4708.9 4732.8 4791.9 4967.4 4975.4 4977.8 4979.1 5024.6 4792.0 5027.8 5041.2 5042.2 5086.6 4733.3 4784.3 4849.6 4897.1 4901.1 4881.4 4918.7 4921.0 4928.8 4953.5 4862.6 4874.4 4874.4 4876.5 4889.8 4735.5 4784.6 4786.4 4843.6 4965.0 4683.9 4709.0 4715.7 4741.3 4745.5 19:30:56 INFO - PROCESS | 18043 | 19:30:56 INFO - PROCESS | 18043 | [#1] ext.html Cycles:180 Average:41845.71 Median:34882.98 stddev:70221.55 (201.3%) stddev-sans-first:70350.03 19:30:56 INFO - PROCESS | 18043 | Values: 533.9 545.5 551.7 553.4 561.3 27209.2 29724.4 36518.3 38024.4 38354.6 36493.5 37044.8 37049.8 37114.4 37289.3 7335.7 7487.6 7490.1 7490.2 7498.8 7257.6 7457.3 9568.5 9857.0 9868.8 9912.0 9977.9 9989.8 9991.4 9992.6 9767.7 9814.4 9815.8 9831.5 9837.0 9774.7 9831.1 9834.6 9840.0 9845.5 36513.5 36748.6 36845.6 36851.6 36966.1 3060.6 3097.0 3103.7 3149.9 3178.6 27057.3 27095.5 27449.2 27874.2 28171.2 3114.6 3133.5 3156.2 3192.1 3232.0 238931.8 238952.0 239229.0 239819.0 240458.0 49161.8 49579.8 49825.3 49956.3 50005.7 50811.7 50885.5 50911.0 50943.2 50968.7 13406.9 13716.3 13751.7 13843.2 13894.4 8263.5 8342.8 10037.4 10066.4 10088.9 14332.4 14632.6 14827.4 15204.6 15240.5 6031.5 6053.6 6157.3 6165.0 6165.5 786.9 867.5 869.2 897.0 953.3 26815.7 26980.7 27188.6 27787.2 27792.6 941.7 941.8 947.4 970.5 973.7 12954.0 13989.0 14250.4 14252.1 14254.4 322828.0 324806.0 325786.0 326037.0 326596.0 44985.8 45115.5 45135.5 45222.3 45230.3 1029.7 1084.3 1124.2 1191.3 1218.5 25082.6 27230.3 27502.0 28194.4 28204.3 40006.6 40386.2 40387.4 40390.6 40409.0 228753.0 230068.0 231064.0 231275.0 231433.0 20682.9 21410.9 21414.3 21416.3 22985.7 39060.4 39537.6 39938.2 39943.6 40756.8 34394.3 34455.3 34704.8 34909.7 35110.0 34629.1 34747.0 34771.0 34829.1 34945.1 34204.5 34400.7 34448.5 34856.3 35150.8 29577.9 31791.4 31877.8 32028.0 32120.7 24414.5 24451.0 24463.0 25002.9 25019.7 19:30:56 INFO - PROCESS | 18043 | 19:30:56 INFO - PROCESS | 18043 | [#2] jquery.html Cycles:180 Average:20974.78 Median:5226.54 stddev:49196.72 (941.3%) stddev-sans-first:49310.33 19:30:56 INFO - PROCESS | 18043 | Values: 337.7 345.6 352.5 359.6 376.8 12710.9 12931.0 13707.4 13845.6 16861.2 13938.4 14152.9 14492.0 15271.8 15523.1 4788.2 5012.0 5013.4 5059.5 5322.2 5332.5 5373.2 5374.2 5381.6 5382.6 3349.6 3541.0 5008.5 5234.0 5258.1 5265.9 5345.2 5350.5 5350.9 5355.3 5125.7 5188.5 5211.8 5224.8 5228.3 11939.6 12176.9 12180.0 18917.4 19955.1 1783.5 1854.8 1891.4 1936.8 1985.8 8897.9 9084.5 9280.1 9609.7 9662.1 1684.8 1763.4 1767.8 1778.8 1787.4 58977.7 64354.4 65228.0 65548.3 71563.6 9536.6 9549.8 9846.1 9912.6 9921.6 13400.6 13400.7 13404.9 13416.9 13420.6 6976.7 7167.6 7271.9 7365.0 7396.7 6834.9 6845.6 7018.1 7053.5 7056.9 4167.6 4213.5 4261.7 4313.3 4342.7 1537.2 1580.5 1587.8 1619.7 1818.8 766.7 820.4 824.7 933.0 946.1 15669.1 16267.1 16772.5 17044.5 17303.7 825.9 838.5 846.5 888.5 899.9 9071.7 9120.6 9497.4 9503.8 9641.2 262197.0 265906.0 266054.0 327147.0 333671.0 77651.0 79498.6 79887.0 80044.6 80098.6 864.4 889.4 920.9 921.3 921.7 15202.9 15243.4 15805.3 16058.4 16120.4 35043.5 35456.0 35545.6 35720.7 36572.8 44427.0 49271.0 49444.5 51032.5 51845.7 6839.7 7301.4 7424.0 7452.4 7495.7 10332.9 10556.2 10701.7 10771.4 11274.4 9585.0 9652.5 9861.0 9943.9 10117.1 9516.3 9702.4 9880.0 10042.7 10063.8 9713.9 9731.5 9931.6 10211.1 10278.8 7106.0 7196.5 7235.7 7313.5 7502.9 9229.3 9529.8 9922.9 9965.6 9999.8 19:30:56 INFO - PROCESS | 18043 | 19:30:56 INFO - PROCESS | 18043 | [#3] mootools.html Cycles:180 Average:4427.56 Median:5325.99 stddev:2362.62 (44.4%) stddev-sans-first:2356.34 19:30:56 INFO - PROCESS | 18043 | Values: 1141.1 1312.9 1344.1 1399.8 1643.8 5886.9 6478.8 6711.3 6737.6 6899.9 6709.6 6767.3 6776.2 6781.9 6792.0 1751.7 1826.7 1977.4 2022.2 2022.7 1962.5 2038.8 2040.4 2060.4 2062.3 1948.8 1951.9 1952.2 1957.5 1964.0 1967.3 2030.0 2035.0 2037.1 2038.3 1966.0 1968.6 1968.6 1973.4 1993.8 6712.2 6807.5 6867.6 6871.2 6872.2 4038.8 4159.9 4160.3 4160.5 4161.3 2468.2 2619.7 2671.7 2696.0 2723.9 807.6 858.8 860.8 861.1 864.9 8773.6 8782.4 8783.2 8788.1 8800.4 3451.1 3656.9 3714.9 3732.0 3734.3 7466.1 7466.1 7477.0 7478.2 7488.2 4134.8 4149.7 4149.8 4152.6 4153.5 3220.5 3326.8 3468.2 3791.4 3798.5 3132.5 3212.8 3277.2 3299.3 3329.7 1036.0 1041.9 1047.4 1050.0 1062.6 598.3 768.4 773.4 778.2 800.3 4435.9 4478.3 4666.0 4739.0 4836.2 769.2 793.5 834.1 841.5 848.5 2986.2 3008.3 3079.7 3141.4 3141.4 7300.6 7675.9 7885.8 8099.5 8151.6 7826.6 7831.8 7846.2 7861.8 7898.0 6315.2 6474.1 6480.4 6492.9 6492.9 4428.2 4464.4 4489.5 4603.7 4781.0 7070.8 7213.2 7372.2 7409.5 7563.1 7451.3 7548.6 7571.0 7580.0 7618.2 5289.0 5836.0 6047.5 6053.5 6061.4 5948.0 6163.1 6166.2 6185.5 6188.0 5988.3 6025.8 6035.1 6071.8 6229.4 5933.7 5955.9 6030.8 6114.5 6317.8 5363.0 5382.1 5405.4 5417.7 5419.9 4049.3 4085.0 4156.6 4201.4 4288.7 3908.5 3908.9 3956.5 3962.8 4125.4 19:30:56 INFO - PROCESS | 18043 | 19:30:56 INFO - PROCESS | 18043 | [#4] prototype.html Cycles:180 Average:4081.63 Median:4665.93 stddev:1162.25 (24.9%) stddev-sans-first:1130.18 19:30:56 INFO - PROCESS | 18043 | Values: 292.5 294.2 297.7 298.2 300.5 4755.3 4785.4 4808.2 4816.3 4823.4 4693.8 4697.3 4715.2 4723.5 4741.8 3558.2 3672.2 3690.2 3699.6 3734.8 3739.9 3751.5 3751.7 3752.5 3768.3 3723.2 3727.3 3730.7 3730.8 3733.3 3536.9 3612.7 3649.9 3716.9 3739.5 3306.7 3313.5 3315.7 3316.7 3328.8 4581.9 4592.2 4592.5 4597.8 4614.8 4098.4 4251.2 4255.9 4257.0 4264.3 4893.9 4922.9 4928.5 4935.8 4939.8 3606.2 3612.5 3614.6 3615.8 3618.8 5128.7 5132.4 5159.0 5164.2 5175.6 3603.7 3658.7 3685.4 3699.8 3711.3 3675.0 3757.1 3759.9 3767.6 3767.8 4171.8 4184.9 4186.7 4204.2 4220.7 4799.4 4830.8 4886.6 4889.9 4899.3 1242.8 1252.5 1258.5 1260.5 1260.5 848.8 869.6 869.8 880.3 885.1 4238.6 4348.5 4353.3 4356.3 4362.8 4967.3 4993.6 5025.6 5113.2 5124.2 4411.6 4416.4 4428.2 4429.4 4431.9 2557.2 2605.5 2635.8 2642.9 2644.4 4587.7 4658.5 4678.3 4679.2 4696.3 5005.1 5014.5 5034.8 5036.7 5070.4 4477.3 4673.4 4681.2 4684.4 4709.6 4979.3 4986.9 5005.7 5016.2 5035.4 4899.7 4917.2 4920.3 4927.3 4956.9 4464.7 4687.7 4705.3 4713.3 4717.3 3594.0 3596.4 3597.5 3602.8 3603.1 5002.7 5003.6 5004.0 5015.2 5027.5 4692.2 4833.8 4861.4 4861.6 4871.5 4843.4 4848.8 4857.8 4863.7 4873.7 4624.8 4785.6 4798.8 4801.9 4815.6 4607.3 4768.5 4841.3 4876.0 4891.7 4685.4 4692.2 4694.6 4725.5 4732.3 19:30:56 INFO - PROCESS | 18043 | 19:30:56 INFO - PROCESS | 18043 | [#5] yui.html Cycles:180 Average:14293.76 Median:545.46 stddev:18353.51 (3364.8%) stddev-sans-first:18376.09 19:30:56 INFO - PROCESS | 18043 | Values: 577.3 653.6 703.1 707.8 755.6 11110.0 11542.7 11813.3 12714.5 12902.8 11980.6 12110.2 12121.6 12122.6 12130.3 630.7 754.6 761.6 762.2 763.2 644.0 746.2 789.9 790.4 798.6 841.0 843.5 843.6 843.6 844.0 644.1 838.4 839.1 839.2 839.7 498.5 568.4 597.9 602.1 605.5 12283.3 12309.6 12325.4 12332.5 12341.5 11543.7 11705.6 11914.2 12178.8 12504.1 10776.6 10912.2 10989.6 11160.4 11218.7 3960.5 3962.9 3963.8 3968.7 4015.3 42161.4 45954.0 45966.8 45995.5 46805.1 9335.3 9386.5 9490.9 9734.9 9927.9 16986.2 17224.3 17234.1 17539.8 17549.7 6757.8 6833.4 6881.1 6902.6 6986.7 3465.9 3625.5 3642.6 3679.2 3701.4 2594.8 2683.5 2697.0 2724.1 2765.7 467.6 472.9 474.4 484.0 486.2 495.5 541.1 577.4 624.4 628.0 7640.7 8027.6 8240.8 8254.9 8446.2 469.9 544.7 546.2 561.8 562.8 3726.2 3775.3 3784.5 3979.4 3979.5 42195.8 48346.0 67356.0 73715.3 73956.6 59100.1 61142.0 61153.7 61176.0 61449.7 55589.7 55854.0 57052.4 57233.7 59189.4 7714.5 7861.4 7876.1 7970.8 8156.0 38741.2 39277.6 39462.4 40022.6 40752.3 53778.2 53887.7 54154.2 54180.0 55120.7 9033.7 9150.8 9301.4 9328.5 9547.4 10764.6 10906.7 10929.3 11260.3 11465.3 9526.9 9976.7 10040.6 10050.1 10248.5 9991.8 10311.8 10513.5 10803.6 10805.3 9443.5 9735.1 10022.9 10374.0 10395.0 7821.2 7876.8 7951.2 8020.9 8201.8 7900.3 8314.0 8421.8 8485.9 8621.3 19:30:56 INFO - PROCESS | 18043 | -------- Summary: end -------- 19:30:56 INFO - PROCESS | 18043 | 19:30:57 INFO - TEST-INFO | 18043: exit 0 19:30:57 INFO - TEST-OK | dromaeo_css | took 1123339ms 19:30:57 INFO - TEST-START | kraken 19:30:57 INFO - operating with platform_type : linux_ 19:30:57 INFO - Initialising browser for kraken test... 19:30:57 INFO - TEST-INFO | started process 18352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3m5TSA/profile http://localhost:40378/getInfo.html) 19:31:01 INFO - PROCESS | 18352 | __metrics Screen width/height:1600/1200 19:31:01 INFO - PROCESS | 18352 | colorDepth:24 19:31:01 INFO - PROCESS | 18352 | Browser inner width/height: 1024/697 19:31:01 INFO - PROCESS | 18352 | __metrics 19:31:01 INFO - PROCESS | 18352 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:31:01 INFO - PROCESS | 18352 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:31:02 INFO - PROCESS | 18352 | console.error: PushService: 19:31:02 INFO - PROCESS | 18352 | stateChangeProcessEnqueue: Error transitioning state 19:31:02 INFO - PROCESS | 18352 | UnknownError 19:31:03 INFO - TEST-INFO | 18352: exit 0 19:31:03 INFO - Browser initialized. 19:31:03 INFO - Running cycle 1/1 for kraken test... 19:31:03 INFO - TEST-INFO | started process 18433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3m5TSA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:31:15 INFO - PROCESS | 18433 | RSS: Main: 175378432 19:31:15 INFO - PROCESS | 18433 | 19:31:18 INFO - PROCESS | 18433 | Cycle 1(1): loaded http://localhost:40378/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40378/tests/kraken/driver.html?testName=audio-beat-detection) 19:31:19 INFO - PROCESS | 18433 | RSS: Main: 240656384 19:31:19 INFO - PROCESS | 18433 | 19:31:22 INFO - PROCESS | 18433 | Cycle 1(1): loaded http://localhost:40378/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40378/tests/kraken/driver.html?testName=audio-dft) 19:31:22 INFO - PROCESS | 18433 | RSS: Main: 218542080 19:31:22 INFO - PROCESS | 18433 | 19:31:25 INFO - PROCESS | 18433 | Cycle 1(1): loaded http://localhost:40378/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40378/tests/kraken/driver.html?testName=audio-fft) 19:31:26 INFO - PROCESS | 18433 | RSS: Main: 301404160 19:31:26 INFO - PROCESS | 18433 | 19:31:28 INFO - PROCESS | 18433 | Cycle 1(1): loaded http://localhost:40378/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40378/tests/kraken/driver.html?testName=audio-oscillator) 19:31:29 INFO - PROCESS | 18433 | RSS: Main: 212307968 19:31:29 INFO - PROCESS | 18433 | 19:31:31 INFO - PROCESS | 18433 | Cycle 1(1): loaded http://localhost:40378/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40378/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:31:32 INFO - PROCESS | 18433 | RSS: Main: 214609920 19:31:32 INFO - PROCESS | 18433 | 19:31:35 INFO - PROCESS | 18433 | Cycle 1(1): loaded http://localhost:40378/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40378/tests/kraken/driver.html?testName=imaging-darkroom) 19:31:35 INFO - PROCESS | 18433 | RSS: Main: 254644224 19:31:35 INFO - PROCESS | 18433 | 19:31:39 INFO - PROCESS | 18433 | Cycle 1(1): loaded http://localhost:40378/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40378/tests/kraken/driver.html?testName=imaging-desaturate) 19:31:40 INFO - PROCESS | 18433 | RSS: Main: 248516608 19:31:40 INFO - PROCESS | 18433 | 19:31:42 INFO - PROCESS | 18433 | Cycle 1(1): loaded http://localhost:40378/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40378/tests/kraken/driver.html?testName=json-parse-financial) 19:31:43 INFO - PROCESS | 18433 | RSS: Main: 249892864 19:31:43 INFO - PROCESS | 18433 | 19:31:45 INFO - PROCESS | 18433 | Cycle 1(1): loaded http://localhost:40378/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40378/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:31:45 INFO - PROCESS | 18433 | RSS: Main: 213860352 19:31:45 INFO - PROCESS | 18433 | 19:31:47 INFO - PROCESS | 18433 | Cycle 1(1): loaded http://localhost:40378/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40378/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:31:48 INFO - PROCESS | 18433 | RSS: Main: 221466624 19:31:48 INFO - PROCESS | 18433 | 19:31:50 INFO - PROCESS | 18433 | Cycle 1(1): loaded http://localhost:40378/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40378/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:31:51 INFO - PROCESS | 18433 | RSS: Main: 230010880 19:31:51 INFO - PROCESS | 18433 | 19:31:54 INFO - PROCESS | 18433 | Cycle 1(1): loaded http://localhost:40378/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:31:54 INFO - PROCESS | 18433 | RSS: Main: 238796800 19:31:54 INFO - PROCESS | 18433 | 19:31:57 INFO - PROCESS | 18433 | Cycle 1(1): loaded http://localhost:40378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:31:58 INFO - PROCESS | 18433 | RSS: Main: 236126208 19:31:58 INFO - PROCESS | 18433 | 19:32:00 INFO - PROCESS | 18433 | Cycle 1(1): loaded http://localhost:40378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40378/tests/kraken/driver.html?testName=ai-astar) 19:32:00 INFO - PROCESS | 18433 | RSS: Main: 285622272 19:32:00 INFO - PROCESS | 18433 | 19:32:00 INFO - PROCESS | 18433 | __start_tp_report 19:32:00 INFO - PROCESS | 18433 | _x_x_mozilla_page_load 19:32:00 INFO - PROCESS | 18433 | _x_x_mozilla_page_load_details 19:32:00 INFO - PROCESS | 18433 | |i|pagename|runs| 19:32:00 INFO - PROCESS | 18433 | |0;ai-astar;109;116;119;117;116;118;116;117;119;117 19:32:00 INFO - PROCESS | 18433 | |1;audio-beat-detection;156;131;132;179;132;130;130;129;150;134 19:32:00 INFO - PROCESS | 18433 | |2;audio-dft;161;161;161;162;162;161;162;162;161;160 19:32:00 INFO - PROCESS | 18433 | |3;audio-fft;77;78;78;122;81;81;77;79;91;78 19:32:00 INFO - PROCESS | 18433 | |4;audio-oscillator;83;83;117;84;83;83;105;83;85;101 19:32:00 INFO - PROCESS | 18433 | |5;imaging-gaussian-blur;117;117;118;117;116;117;117;118;118;117 19:32:00 INFO - PROCESS | 18433 | |6;imaging-darkroom;147;147;146;146;147;146;146;146;146;145 19:32:00 INFO - PROCESS | 18433 | |7;imaging-desaturate;95;95;95;95;95;95;96;96;95;95 19:32:00 INFO - PROCESS | 18433 | |8;json-parse-financial;65;64;64;64;64;67;64;64;65;64 19:32:00 INFO - PROCESS | 18433 | |9;json-stringify-tinderbox;65;66;66;66;67;66;68;67;67;67 19:32:00 INFO - PROCESS | 18433 | |10;stanford-crypto-aes;86;85;85;85;85;85;85;85;86;86 19:32:00 INFO - PROCESS | 18433 | |11;stanford-crypto-ccm;146;142;144;141;144;142;145;144;184;143 19:32:00 INFO - PROCESS | 18433 | |12;stanford-crypto-pbkdf2;178;179;178;176;176;177;177;181;181;178 19:32:00 INFO - PROCESS | 18433 | |13;stanford-crypto-sha256-iterative;71;72;71;71;74;70;73;70;70;70 19:32:00 INFO - PROCESS | 18433 | __end_tp_report 19:32:00 INFO - PROCESS | 18433 | __start_cc_report 19:32:00 INFO - PROCESS | 18433 | _x_x_mozilla_cycle_collect,1997 19:32:00 INFO - PROCESS | 18433 | __end_cc_report 19:32:00 INFO - PROCESS | 18433 | __startTimestamp1480217520605__endTimestamp 19:32:00 INFO - PROCESS | 18433 | 19:32:00 INFO - PROCESS | 18433 | ------- Summary: start ------- 19:32:00 INFO - PROCESS | 18433 | Number of tests: 14 19:32:00 INFO - PROCESS | 18433 | 19:32:00 INFO - PROCESS | 18433 | [#0] ai-astar Cycles:10 Average:116.40 Median:117.00 stddev:2.84 (2.4%) stddev-sans-first:1.20 19:32:00 INFO - PROCESS | 18433 | Values: 109.0 116.0 119.0 117.0 116.0 118.0 116.0 117.0 119.0 117.0 19:32:00 INFO - PROCESS | 18433 | 19:32:00 INFO - PROCESS | 18433 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:133.00 stddev:16.47 (12.4%) stddev-sans-first:16.46 19:32:00 INFO - PROCESS | 18433 | Values: 156.0 131.0 132.0 179.0 132.0 130.0 130.0 129.0 150.0 134.0 19:32:00 INFO - PROCESS | 18433 | 19:32:00 INFO - PROCESS | 18433 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 19:32:00 INFO - PROCESS | 18433 | Values: 161.0 161.0 161.0 162.0 162.0 161.0 162.0 162.0 161.0 160.0 19:32:00 INFO - PROCESS | 18433 | 19:32:00 INFO - PROCESS | 18433 | [#3] audio-fft Cycles:10 Average:84.20 Median:78.50 stddev:13.91 (17.7%) stddev-sans-first:14.51 19:32:00 INFO - PROCESS | 18433 | Values: 77.0 78.0 78.0 122.0 81.0 81.0 77.0 79.0 91.0 78.0 19:32:00 INFO - PROCESS | 18433 | 19:32:00 INFO - PROCESS | 18433 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:83.00 stddev:12.37 (14.9%) stddev-sans-first:12.80 19:32:00 INFO - PROCESS | 18433 | Values: 83.0 83.0 117.0 84.0 83.0 83.0 105.0 83.0 85.0 101.0 19:32:00 INFO - PROCESS | 18433 | 19:32:00 INFO - PROCESS | 18433 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 19:32:00 INFO - PROCESS | 18433 | Values: 117.0 117.0 118.0 117.0 116.0 117.0 117.0 118.0 118.0 117.0 19:32:00 INFO - PROCESS | 18433 | 19:32:00 INFO - PROCESS | 18433 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 19:32:00 INFO - PROCESS | 18433 | Values: 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 19:32:00 INFO - PROCESS | 18433 | 19:32:00 INFO - PROCESS | 18433 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:32:00 INFO - PROCESS | 18433 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 19:32:00 INFO - PROCESS | 18433 | 19:32:00 INFO - PROCESS | 18433 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 19:32:00 INFO - PROCESS | 18433 | Values: 65.0 64.0 64.0 64.0 64.0 67.0 64.0 64.0 65.0 64.0 19:32:00 INFO - PROCESS | 18433 | 19:32:00 INFO - PROCESS | 18433 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 19:32:00 INFO - PROCESS | 18433 | Values: 65.0 66.0 66.0 66.0 67.0 66.0 68.0 67.0 67.0 67.0 19:32:00 INFO - PROCESS | 18433 | 19:32:00 INFO - PROCESS | 18433 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 19:32:00 INFO - PROCESS | 18433 | Values: 86.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 86.0 86.0 19:32:00 INFO - PROCESS | 18433 | 19:32:00 INFO - PROCESS | 18433 | [#11] stanford-crypto-ccm Cycles:10 Average:147.50 Median:144.00 stddev:12.91 (9.0%) stddev-sans-first:13.68 19:32:00 INFO - PROCESS | 18433 | Values: 146.0 142.0 144.0 141.0 144.0 142.0 145.0 144.0 184.0 143.0 19:32:00 INFO - PROCESS | 18433 | 19:32:00 INFO - PROCESS | 18433 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.10 Median:178.00 stddev:1.79 (1.0%) stddev-sans-first:1.90 19:32:00 INFO - PROCESS | 18433 | Values: 178.0 179.0 178.0 176.0 176.0 177.0 177.0 181.0 181.0 178.0 19:32:00 INFO - PROCESS | 18433 | 19:32:00 INFO - PROCESS | 18433 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.00 stddev:1.40 (2.0%) stddev-sans-first:1.48 19:32:00 INFO - PROCESS | 18433 | Values: 71.0 72.0 71.0 71.0 74.0 70.0 73.0 70.0 70.0 70.0 19:32:00 INFO - PROCESS | 18433 | -------- Summary: end -------- 19:32:00 INFO - PROCESS | 18433 | 19:32:01 INFO - TEST-INFO | 18433: exit 0 19:32:01 INFO - TEST-OK | kraken | took 64916ms 19:32:01 INFO - SUITE-END | took 1188s 19:32:02 INFO - Completed test suite (00:19:48) 19:32:02 INFO - javascript benchmark 19:32:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2554.386947132688, 2584.185981415853, 2604.830686005409, 2613.7778288845448, 2624.514464824009, 4536.818527258905, 4605.9769701151445, 4638.420197475316, 4678.976605116974, 4688.601468875146, 4600.42494688164, 4614.907701845961, 4666.183417901862, 4708.199606066968, 4749.928751068736, 4226.323788193889, 4239.9576004240025, 4276.208901353244, 4310.267254566716, 4369.956300436987, 3927.913393405506, 4222.0922501662135, 4351.238533256684, 4361.672874534407, 4406.845760398371, 4213.157368526307, 4244.0, 4362.912741745179, 4385.605295523418, 4436.268015777409, 4249.46881639795, 4274.0, 4288.099499105192, 4292.613664770154, 4373.934390984138, 4253.574642535753, 4254.425652536899, 4263.445752052214, 4281.272183728774, 4300.483941926988, 4614.169449499089, 4651.790669419885, 4655.767211639404, 4669.182892993713, 4700.882477938045, 4685.297205419214, 4784.282357646381, 4784.330193772875, 4872.56146946773, 4875.098106850244, 4977.0792403405485, 5005.57452616528, 5011.874703132415, 5019.14674505335, 5021.447640759514, 4628.213203755336, 4633.189191891405, 4635.884102897455, 4636.629069674418, 4676.088162808288, 4906.092372911023, 5066.240063990357, 5072.923906141411, 5075.0, 5117.923231151536, 4727.810887564528, 4767.95232047682, 4813.711177329302, 4814.061258054646, 4814.687045342112, 4895.461499235082, 4937.851864444001, 4942.851714448572, 5013.749312534359, 5016.0971025215085, 4907.092187945242, 4930.33440485537, 4973.179425394842, 4973.676711013773, 4973.726445045485, 4895.167821470359, 4912.1158191525865, 4918.5161493445585, 4919.335889654851, 4962.826301079517, 4047.3928910663635, 4084.9183016339507, 4097.508299004079, 4146.0, 4181.163767246563, 3592.0660628236324, 3615.6384361563632, 3620.25784714133, 3649.7262705297208, 3677.0807298175455, 4272.829086836554, 4273.465816772903, 4273.63674087706, 4285.0, 4327.32926396409, 4949.505049495094, 4958.157113290749, 4963.379577552806, 4963.404391472975, 4983.451820299764, 4179.122384299331, 4193.748375097504, 4214.978925105354, 4218.873433796991, 4227.260229459832, 4423.579759922803, 4428.82284708608, 4442.044960333544, 4457.99695068607, 4470.351798989193, 4630.0, 4639.768011599339, 4640.651951103613, 4681.67228294023, 4686.507916668837, 4833.661643685049, 4901.656884018084, 4912.410510738734, 4939.728314942713, 4944.505549445027, 4678.625709943129, 4701.553352431513, 4708.882277942942, 4732.787024583833, 4791.904161916812, 4967.40391153064, 4975.4278258000795, 4977.800887964441, 4979.103761322996, 5024.598032157345, 4791.952080479151, 5027.849164524924, 5041.193409054534, 5042.218456139304, 5086.567641750345, 4733.290006498915, 4784.30627558995, 4849.612031037438, 4897.118518666532, 4901.117798796251, 4881.365422495195, 4918.655694101379, 4920.950790492192, 4928.802847886044, 4953.455119936876, 4862.562369386772, 4874.4150701916, 4874.4150701916, 4876.487968763229, 4889.755512224303, 4735.455422626442, 4784.617230621472, 4786.425628924551, 4843.564079232886, 4964.950350496449, 4683.906321873612, 4708.952910470988, 4715.740634265148, 4741.2651039089, 4745.549172828576], "value": 4550.3780183777935, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.9305890234269, 545.4572700163338, 551.674512037898, 553.4354957942899, 561.3292115921474, 27209.183724488274, 29724.40551188975, 36518.26963460733, 38024.42963355552, 38354.61645383545, 36493.45259821105, 37044.81477592615, 37049.814750926205, 37114.443283350774, 37289.25421491575, 7335.743248986273, 7487.625618719069, 7490.1011878574645, 7490.176080631126, 7498.8125296867465, 7257.637118144098, 7457.254274572527, 9568.521573921276, 9856.950715246414, 9868.802623947517, 9911.950440247789, 9977.90022099777, 9989.800203995952, 9991.350562213469, 9992.550335234895, 9767.658131965383, 9814.362066465657, 9815.803683926353, 9831.459269740162, 9836.999999999964, 9774.706758797247, 9831.115199632068, 9834.606615735362, 9840.0, 9845.45849978251, 36513.45229821555, 36748.63251367505, 36845.63154368449, 36851.63148368509, 36966.07584810374, 3060.617422822147, 3096.9535456968165, 3103.658597554267, 3149.8740050397955, 3178.5867837181017, 27057.32356691079, 27095.458090838074, 27449.17652470429, 27874.168721512204, 28171.154865354074, 3114.6418161911442, 3133.498640217577, 3156.226724452501, 3192.122166404234, 3231.951520727191, 238931.80534097392, 238952.0, 239229.0, 239819.0, 240458.0, 49161.754191228814, 49579.75210123998, 49825.25262121071, 49956.25065624018, 50005.74997124991, 50811.745941270055, 50885.49114508882, 50911.0, 50943.23585146226, 50968.74515627398, 13406.93296533511, 13716.314184290746, 13751.724965500634, 13843.16940983524, 13894.374753136133, 8263.462874913112, 8342.791430214293, 10037.39775613451, 10066.446345450924, 10088.949555252324, 14332.426702931974, 14632.561023169323, 14827.406903723946, 15204.619884502976, 15240.542783716506, 6031.487323577545, 6053.636781793107, 6157.2611286645, 6164.961949922807, 6165.475934545614, 786.9134395216522, 867.4708427859001, 869.2090197919863, 896.9641214351353, 953.3088510829732, 26815.73184268132, 26980.73019269782, 27188.59217111745, 27787.16638500848, 27792.58311125335, 941.6798288581915, 941.8210539997378, 947.3842002698163, 970.4710932541782, 973.6981535723806, 12954.0, 13989.0, 14250.358733857001, 14252.144871307755, 14254.3585538651, 322828.0, 324806.0, 325786.0, 326037.0, 326596.0, 44985.77507112444, 45115.54884451179, 45135.548644513794, 45222.32166517505, 45230.32154517619, 1029.7271223125877, 1084.2681190196743, 1124.2467546743537, 1191.3447603817865, 1218.5004148299154, 25082.62376064324, 27230.319242019108, 27502.0, 28194.43611127807, 28204.294892627848, 40006.59993400029, 40386.19227615373, 40387.394189087776, 40390.59609403869, 40409.0, 228753.0, 230068.0, 231064.0, 231275.0, 231433.0, 20682.896585516977, 21410.892945535797, 21414.25050123238, 21416.250431234832, 22985.65521517145, 39060.41409378805, 39537.60462395454, 39938.2012359757, 39943.60056399515, 40756.79621601873, 34394.31211375808, 34455.31089378148, 34704.826475867456, 34909.65090349165, 35110.0, 34629.13427164341, 34747.0, 34771.0, 34829.12927176841, 34945.12637184091, 34204.48693269553, 34400.655993439745, 34448.483272750425, 34856.30287394187, 35150.824245878604, 29577.85211073931, 31791.364172715952, 31877.840610796797, 32028.0, 32120.678793212704, 24414.511709766062, 24451.0, 24463.0, 25002.874985625684, 25019.74980250174], "value": 16747.01976155169, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.65896444590953, 345.5594117500187, 352.4554563199856, 359.62239648369206, 376.8002958432032, 12710.936445317771, 12931.0, 13707.38316775745, 13845.584632461017, 16861.156942152906, 13938.372773225205, 14152.92923535381, 14492.0, 15271.847281527182, 15523.146226957513, 4788.233882578788, 5012.022655582145, 5013.448520662724, 5059.49405059493, 5322.175062865262, 5332.493413125766, 5373.247745315659, 5374.193870919355, 5381.623286369956, 5382.5963052771, 3349.648286929874, 3540.9645903541023, 5008.524190201925, 5233.973830130844, 5258.13240815265, 5265.9204863003, 5345.1714984177515, 5350.518453339179, 5350.91973620396, 5355.2770375999135, 5125.666831655968, 5188.45521220274, 5211.791528338862, 5224.791008359661, 5228.2941802856885, 11939.641810745692, 12176.939115304456, 12180.0, 18917.43247702571, 19955.102020409115, 1783.5362805670488, 1854.7588813454165, 1891.3947536788232, 1936.8160024797621, 1985.7815640279703, 8897.911020889773, 9084.545772711337, 9280.071992800666, 9609.711708648752, 9662.08210220028, 1684.8399402056784, 1763.4357005758163, 1767.849732772716, 1778.8221177882237, 1787.4012205910906, 58977.70511147417, 64354.35645643531, 65228.0, 65548.3445165547, 71563.64218178876, 9536.570854311572, 9549.800816726474, 9846.056275919527, 9912.55393507294, 9921.603135874628, 13400.597982060553, 13400.664983375298, 13404.932975335061, 13416.932915335361, 13420.597382078553, 6976.651167441608, 7167.641617919083, 7271.854562908712, 7365.005724227268, 7396.704131834666, 6834.863302733917, 6845.623490708059, 7018.052562903943, 7053.541519801299, 7056.858862822714, 4167.604077612622, 4213.452251207324, 4261.701680882308, 4313.266744653416, 4342.696011279243, 1537.1545649892514, 1580.4863419388744, 1587.7538981457892, 1619.6679680665436, 1818.7817461904656, 766.72226232855, 820.4134044158455, 824.744329257932, 933.0, 946.1201082992745, 15669.138197399252, 16267.105309208107, 16772.496825095266, 17044.48866533981, 17303.65392692139, 825.8802473641408, 838.4927119092982, 846.4667259626395, 888.4846788862444, 899.9325050621098, 9071.682491112779, 9120.58957346921, 9497.435692363024, 9503.762405939908, 9641.180499657466, 262197.0, 265906.0, 266054.0, 327147.0, 333671.0, 77651.0, 79498.6025069871, 79887.0, 80044.5997770019, 80098.59950700325, 864.4208380385157, 889.3552174673439, 920.9309301802392, 921.2860033473977, 921.709661456639, 15202.923985380003, 15243.3902643893, 15805.288762005968, 16058.357665693242, 16120.435784747477, 35043.47434788531, 35456.0, 35545.64454355527, 35720.74886894835, 36572.81713591415, 44427.0, 49271.0, 49444.50555494399, 51032.48967510426, 51845.7407712959, 6839.658017099225, 7301.415886729155, 7424.0, 7452.403807695479, 7495.7001719930595, 10332.896671033193, 10556.15550755953, 10701.678949631523, 10771.353718776898, 11274.379909105079, 9585.0, 9652.469114198786, 9860.950695246478, 9943.850842237516, 10117.08946194846, 9516.333856630246, 9702.369345992487, 9879.95060024724, 10042.69871903844, 10063.798724025331, 9713.9028609713, 9731.461809062921, 9931.553080111267, 10211.132053775214, 10278.845817312897, 7105.964470177616, 7196.460265480006, 7235.746748863765, 7313.524620899624, 7502.924970750441, 9229.307801914749, 9529.761755956157, 9922.900770992197, 9965.551550180404, 9999.800004000024], "value": 7782.395093176563, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1141.115635382578, 1312.9102844638949, 1344.126317893369, 1399.8110255115557, 1643.7863077799877, 5886.911696324553, 6478.805635830927, 6711.295313992034, 6737.5620584661965, 6899.896501552468, 6709.597424154542, 6767.255601883801, 6776.220734615521, 6781.932180678204, 6792.049113124167, 1751.658426606812, 1826.6711991841464, 1977.4166620846884, 2022.1810166882435, 2022.7269318641943, 1962.5486138188226, 2038.7859274776158, 2040.3572874544545, 2060.3818854343635, 2062.3194345865904, 1948.756405449319, 1951.9024048797573, 1952.1898412158937, 1957.4616980330452, 1963.980360196394, 1967.3114409956545, 2029.9797002029939, 2035.0, 2037.1342179573696, 2038.3171637501455, 1965.9508512287164, 1968.5964377302619, 1968.6456437841182, 1973.447434718281, 1993.7806841247452, 6712.194536655633, 6807.4894382921475, 6867.622280774555, 6871.244163142051, 6872.209695884937, 4038.7980600969836, 4159.9376009359885, 4160.251154792136, 4160.521540022906, 4161.25097482453, 2468.1731619907355, 2619.7118316985116, 2671.719469455699, 2696.0294294054124, 2723.8774255158564, 807.5962018990505, 858.8196478739472, 860.8407444622765, 861.1001503428931, 864.9069252409184, 8773.561321933941, 8782.38523303369, 8783.209511144029, 8788.121187881161, 8800.383973121883, 3451.137215696076, 3656.945145822815, 3714.9442758358646, 3732.0483276764253, 3734.3091528067393, 7466.104067511933, 7466.141393739789, 7477.0, 7478.177400485943, 7488.213737557587, 4134.793260336971, 4149.688773342012, 4149.8340066397, 4152.626263636287, 4153.54311025787, 3220.4525230710838, 3326.8336583170744, 3468.1849765305133, 3791.4123310886857, 3798.525184351956, 3132.530120481946, 3212.823294718813, 3277.2298509850166, 3299.290652509674, 3329.6670332966996, 1035.9792804143874, 1041.8645576075062, 1047.3820445936933, 1049.9580016799243, 1062.6068354708652, 598.3418239936123, 768.4044865229492, 773.3890226720828, 778.2412148155503, 800.2997377294867, 4435.866923992286, 4478.305862591238, 4666.0, 4738.976305118453, 4836.202026665561, 769.1808224241165, 793.4644115222318, 834.1241696218946, 841.4951029382322, 848.4612271207827, 2986.2086547065046, 3008.262975570999, 3079.6920307969026, 3141.3560220154814, 3141.403133404646, 7300.598467084255, 7675.884861727079, 7885.763427097197, 8099.514029158269, 8151.551664658382, 7826.608669566499, 7831.843363132705, 7846.176151504124, 7861.842763144819, 7898.0, 6315.179026726496, 6474.061261117112, 6480.351964803576, 6492.935070649328, 6492.935070649328, 4428.225060614444, 4464.352668862932, 4489.506154323087, 4603.700759450625, 4781.043791241696, 7070.7525236616475, 7213.20654727969, 7372.152202496782, 7409.481336306407, 7563.130240022468, 7451.3293803557945, 7548.622568871425, 7571.0, 7580.0, 7618.238176182337, 5288.9735551322, 5835.9708201458725, 6047.516198704181, 6053.515718742578, 6061.393860613904, 5948.018576934757, 6163.106349579196, 6166.1983942087245, 6185.505159587312, 6187.969060154851, 5988.341282459013, 6025.849353766191, 6035.064564992434, 6071.757129714939, 6229.4393504584805, 5933.732982015906, 5955.940440595538, 6030.793202123596, 6114.5414093942245, 6317.842053948688, 5363.0, 5382.111951527954, 5405.405405405481, 5417.729113544386, 5419.945800542102, 4049.250888585621, 4084.9591504085765, 4156.563560826191, 4201.432806571196, 4288.742675439484, 3908.4918960534947, 3908.863189788344, 3956.465877106669, 3962.7622342659533, 4125.443065186161], "value": 3629.3270425651526, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.48814574494634, 294.1997766076273, 297.7201430655185, 298.2023088238961, 300.49816805934086, 4755.3104799804005, 4785.377900872891, 4808.220958245445, 4816.325714399983, 4823.397075365579, 4693.765311734408, 4697.318888761136, 4715.2219883719235, 4723.504032076626, 4741.8103275868925, 3558.2171922177145, 3672.210474747929, 3690.2066055798, 3699.648533389324, 3734.813259337036, 3739.8691045813266, 3751.536900608765, 3751.737378383514, 3752.5309336332957, 3768.2651882882847, 3723.236736469017, 3727.3413331067686, 3730.682891954187, 3730.7688462807346, 3733.290674771785, 3536.876209332674, 3612.6929211017095, 3649.8540058397634, 3716.937099909549, 3739.5138631977807, 3306.7183643286057, 3313.4698448248164, 3315.6850099240773, 3316.7014968652697, 3328.8169150696704, 4581.908361832778, 4592.15045216636, 4592.540745925414, 4597.793099310506, 4614.754016415583, 4098.426220329156, 4251.2347777400055, 4255.851045213433, 4256.957430425687, 4264.253755592759, 4893.853184404474, 4922.926156107661, 4928.507149285078, 4935.80256789728, 4939.777710003023, 3606.1525541497726, 3612.512310838056, 3614.620464851179, 3615.7649752765988, 3618.7828730276005, 5128.74345785285, 5132.435432102466, 5158.974205128988, 5164.159712158298, 5175.637705360664, 3603.747737658391, 3658.6645874256237, 3685.4103343465454, 3699.7965111918566, 3711.2948539777894, 3675.0, 3757.0607348162957, 3759.9060023499082, 3767.6420740030203, 3767.773933563995, 4171.812268447867, 4184.853530126431, 4186.6859985501205, 4204.201201771715, 4220.746755194698, 4799.400074990626, 4830.798563603092, 4886.633502487328, 4889.902201955941, 4899.314096026559, 1242.7949388350821, 1252.5428218700108, 1258.5280519805074, 1260.4580030586935, 1260.5462033667873, 848.7665891879659, 869.6434461870602, 869.7738587967174, 880.3221519430003, 885.1148851148852, 4238.6397156242065, 4348.543238015237, 4353.25994580922, 4356.302991521341, 4362.781860906942, 4967.254911763264, 4993.625478089158, 5025.623078269145, 5113.1563292057135, 5124.231365295235, 4411.647068234533, 4416.4258646375765, 4428.235999400548, 4429.357743127293, 4431.933520997188, 2557.1588456311424, 2605.5310044191847, 2635.8418494890366, 2642.947141057168, 2644.418227989878, 4587.678862479661, 4658.464276608166, 4678.345031695565, 4679.157751604744, 4696.272077827942, 5005.1491246488185, 5014.548690617862, 5034.84895453137, 5036.715637512484, 5070.442251352349, 4477.283634618446, 4673.392458980379, 4681.178386262155, 4684.414448193976, 4709.62323014158, 4979.3277907482025, 4986.850394488171, 5005.6996580205305, 5016.169098279175, 5035.446100928968, 4899.730514821719, 4917.237828136645, 4920.335754673073, 4927.310176575354, 4956.925646115239, 4464.722991274539, 4687.703025517404, 4705.341252224623, 4713.29300604912, 4717.292406139107, 3594.0, 3596.4065929121402, 3597.5323207982797, 3602.8378722957004, 3603.135247540624, 5002.749862506933, 5003.574696150868, 5003.974980125222, 5015.17249653803, 5027.497250274943, 4692.202325604587, 4833.830815921426, 4861.368022157097, 4861.562459378673, 4871.488493708252, 4843.418789745253, 4848.781804818721, 4857.805687772449, 4863.659543831898, 4873.707577545359, 4624.768761561976, 4785.569298763128, 4798.832040878552, 4801.855944321676, 4815.590674792682, 4607.285870689914, 4768.499307572793, 4841.322214889848, 4875.952529668957, 4891.73095479752, 4685.437747470325, 4692.178868698033, 4694.647901407477, 4725.480197178239, 4732.337472753886], "value": 3714.495216518475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.2870504926415, 653.5818264641222, 703.0754557756549, 707.8442742596627, 755.550447483747, 11110.0, 11542.711432214199, 11813.291202527844, 12714.491420343174, 12902.80645790314, 11980.64058078259, 12110.15228933975, 12121.636350909486, 12122.575709850134, 12130.332831694253, 630.7413960276288, 754.6113751418025, 761.6306091545596, 762.1768490030781, 763.2100775697155, 644.0403798340486, 746.2127455534409, 789.8973133492667, 790.4190420041265, 798.5647821937058, 840.9537475438848, 843.4517563583659, 843.5992903370881, 843.6456688190974, 843.9831203375929, 644.1400730025422, 838.3795990966702, 839.064443145891, 839.1692224697506, 839.668331009251, 498.52390966626785, 568.408854791021, 597.9133025711291, 602.1028667285757, 605.503487140545, 12283.263004219776, 12309.630711078682, 12325.383730813513, 12332.506699732, 12341.5063397464, 11543.653690389301, 11705.648830535098, 11914.225575337576, 12178.81731774024, 12504.124711270215, 10776.5689372425, 10912.23614346996, 10989.61536346232, 11160.441977901153, 11218.719532011764, 3960.485136932209, 3962.8612998544913, 3963.8414463421427, 3968.72218944674, 4015.297322968469, 42161.367579486636, 45954.0, 45966.77016614929, 45995.54004459946, 46805.063898722176, 9335.299852510952, 9386.483743394043, 9490.857637135448, 9734.9026509734, 9927.851082233772, 16986.150692465326, 17224.311027559008, 17234.052127132876, 17539.824601754073, 17549.736753948702, 6757.763478278237, 6833.350831670983, 6881.10545629065, 6902.585844849325, 6986.650667466606, 3465.8786942457396, 3625.456181572785, 3642.562892452923, 3679.172186258124, 3701.3892707703467, 2594.8313359631943, 2683.5303821831103, 2696.9595456068173, 2724.0874307106947, 2765.737254960816, 467.6329081670872, 472.89123501594827, 474.4448994676237, 483.97338146402285, 486.151665343977, 495.46489791025607, 541.0963690636646, 577.3735496985734, 624.3974564545235, 627.9529035322369, 7640.69437222516, 8027.598620068973, 8240.83518329642, 8254.876176857351, 8446.155384461505, 469.89427378839486, 544.7004147718818, 546.2243614067953, 561.848300958747, 562.8283373571101, 3726.1988672435555, 3775.2638235543805, 3784.4890939723336, 3979.3633018717446, 3979.503161427568, 42195.7890210547, 48346.0, 67356.0, 73715.26284737085, 73956.63021684857, 59100.113498297556, 61142.0, 61153.694231528556, 61176.0, 61449.69275153596, 55589.722051390294, 55854.0, 57052.42947570554, 57233.71383143058, 59189.40810592011, 7714.537127772352, 7861.371090312876, 7876.09424916142, 7970.840583188187, 8155.959220203861, 38741.2251754969, 39277.60722392739, 39462.40806387849, 40022.59977400305, 40752.33229009403, 53778.193327100904, 53887.73056134694, 54154.18768718551, 54180.0, 55120.724396379366, 9033.728988130366, 9150.816983660156, 9301.395409298373, 9328.53357332117, 9547.42715437076, 10764.586519527269, 10906.672799816019, 10929.289596176222, 11260.324380537195, 11465.254758440675, 9526.85709714341, 9976.650817221653, 10040.598376064876, 10050.09549140581, 10248.53881575316, 9991.750206244902, 10311.793764124826, 10513.526891289757, 10803.621873234399, 10805.297655652357, 9443.480608566595, 9735.123838854537, 10022.949885250528, 10374.014468625468, 10395.0, 7821.178776228414, 7876.794258373343, 7951.244631759973, 8020.919790802251, 8201.835963280582, 7900.2889739923685, 8314.0, 8421.789455263422, 8485.915140848512, 8621.310295176496], "value": 5962.441623830979, "unit": "score"}], "name": "dromaeo_css", "value": 6021.671093105674, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 119.0, 117.0, 116.0, 118.0, 116.0, 117.0, 119.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 131.0, 132.0, 179.0, 132.0, 130.0, 130.0, 129.0, 150.0, 134.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 162.0, 161.0, 162.0, 162.0, 161.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 122.0, 81.0, 81.0, 77.0, 79.0, 91.0, 78.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 117.0, 84.0, 83.0, 83.0, 105.0, 83.0, 85.0, 101.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 64.0, 67.0, 64.0, 64.0, 65.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 67.0, 66.0, 68.0, 67.0, 67.0, 67.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 86.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 142.0, 144.0, 141.0, 144.0, 142.0, 145.0, 144.0, 184.0, 143.0], "value": 147.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 179.0, 178.0, 176.0, 176.0, 177.0, 177.0, 181.0, 181.0, 178.0], "value": 178.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 71.0, 71.0, 74.0, 70.0, 73.0, 70.0, 70.0, 70.0], "value": 71.2, "unit": "score"}], "name": "kraken", "value": 1564.6000000000001, "alertThreshold": 2.0}]} 19:32:02 INFO - Return code: 0 19:32:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:32:02 INFO - # TBPL SUCCESS # 19:32:02 INFO - Running post-action listener: _resource_record_post_action 19:32:02 INFO - [mozharness: 2016-11-27 03:32:02.400602Z] Finished run-tests step (success) 19:32:02 INFO - Running post-run listener: _resource_record_post_run 19:32:02 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391987200; Read time: 8; Write time: 181836 19:32:02 INFO - TinderboxPrint: CPU usage
13.1% 19:32:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:32:02 INFO - TinderboxPrint: I/O write bytes / time
391,987,200 / 181,836 19:32:02 INFO - TinderboxPrint: CPU idle
8,352.1 (86.9%) 19:32:02 INFO - TinderboxPrint: CPU user
1,212.4 (12.6%) 19:32:02 INFO - TinderboxPrint: Swap in / out
0 / 0 19:32:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 98992128; Read time: 0; Write time: 48108 19:32:02 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 291848192; Read time: 0; Write time: 133656 19:32:03 INFO - Running post-run listener: _upload_blobber_files 19:32:03 INFO - Blob upload gear active. 19:32:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:32:03 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 19:32:03 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'] 19:32:03 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 19:32:03 INFO - (blobuploader) - INFO - Open directory for files ... 19:32:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:32:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:32:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:04 INFO - (blobuploader) - INFO - Done attempting. 19:32:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:32:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:32:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:07 INFO - (blobuploader) - INFO - Done attempting. 19:32:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:32:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:32:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:08 INFO - (blobuploader) - INFO - Done attempting. 19:32:08 INFO - (blobuploader) - INFO - Iteration through files over. 19:32:08 INFO - Return code: 0 19:32:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:32:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:32:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6e5603f00f3d20c121914948b9f2bdc9977039b5f24188b4737b05d9a79e7b381cac4c0588d31c5b35c17361490c6c0918ce50db1c151cba3e881c0bc252e34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2e5371cee0aeda9f94af1461176df5b6f9f340cf6f6cf607856487ce1cf2906b3c4a26a01e6b17c89e3c9768ea030795ef75fece3d76cc364dbc59de2c07b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e6df2388151bd41555300776b6941166c7d6e9b3725495f1588d9f174fac053081467895a9399389b4e7c5158ffbc9b495636f027a2b0106f0c738ab8a02410"} 19:32:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:32:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:32:08 INFO - Contents: 19:32:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6e5603f00f3d20c121914948b9f2bdc9977039b5f24188b4737b05d9a79e7b381cac4c0588d31c5b35c17361490c6c0918ce50db1c151cba3e881c0bc252e34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2e5371cee0aeda9f94af1461176df5b6f9f340cf6f6cf607856487ce1cf2906b3c4a26a01e6b17c89e3c9768ea030795ef75fece3d76cc364dbc59de2c07b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e6df2388151bd41555300776b6941166c7d6e9b3725495f1588d9f174fac053081467895a9399389b4e7c5158ffbc9b495636f027a2b0106f0c738ab8a02410"} 19:32:08 INFO - Running post-run listener: copy_logs_to_upload_dir 19:32:08 INFO - Copying logs to upload dir... 19:32:08 INFO - mkdir: /builds/slave/test/build/upload/logs 19:32:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.965315 ========= master_lag: 0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-26 19:32:07.510675) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 19:32:07.514104) ========= 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=31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835 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/d6e5603f00f3d20c121914948b9f2bdc9977039b5f24188b4737b05d9a79e7b381cac4c0588d31c5b35c17361490c6c0918ce50db1c151cba3e881c0bc252e34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2e5371cee0aeda9f94af1461176df5b6f9f340cf6f6cf607856487ce1cf2906b3c4a26a01e6b17c89e3c9768ea030795ef75fece3d76cc364dbc59de2c07b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e6df2388151bd41555300776b6941166c7d6e9b3725495f1588d9f174fac053081467895a9399389b4e7c5158ffbc9b495636f027a2b0106f0c738ab8a02410"} build_url:https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011819 build_url: 'https://queue.taskcluster.net/v1/task/HxBf7IudQNmpixCl_8UgTA/artifacts/public/build/firefox-53.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/d6e5603f00f3d20c121914948b9f2bdc9977039b5f24188b4737b05d9a79e7b381cac4c0588d31c5b35c17361490c6c0918ce50db1c151cba3e881c0bc252e34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2e5371cee0aeda9f94af1461176df5b6f9f340cf6f6cf607856487ce1cf2906b3c4a26a01e6b17c89e3c9768ea030795ef75fece3d76cc364dbc59de2c07b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e6df2388151bd41555300776b6941166c7d6e9b3725495f1588d9f174fac053081467895a9399389b4e7c5158ffbc9b495636f027a2b0106f0c738ab8a02410"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 19:32:07.540269) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 19:32:07.540627) ========= 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=31acecf42b6a79ec49471d4a000001bb-1480216262.45513-1285604835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 19:32:07.593728) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 19:32:07.594115) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 19:32:07.594486) ========= ========= Total master_lag: 0.34 =========