builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1479204772.16 results: success (0) buildid: 20161113060519 builduid: 779a7a71919a48e09ad57065daef1a40 revision: 47e0584afe0ab0b867412189c610b302b6ba0ea7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 02:12:52.161362) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 02:12:52.161975) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 02:12:52.162389) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 02:12:52.229881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 02:12:52.230169) ========= 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=fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-15 02:12:52-- 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% 21.3M=0.001s 2016-11-15 02:12:52 (21.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101898 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 02:12:52.369469) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 02:12:52.369791) ========= 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=fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013281 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 02:12:52.431591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-15 02:12:52.431898) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 47e0584afe0ab0b867412189c610b302b6ba0ea7 --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 47e0584afe0ab0b867412189c610b302b6ba0ea7 --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=fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-15 02:12:52,677 truncating revision to first 12 chars 2016-11-15 02:12:52,678 Setting DEBUG logging. 2016-11-15 02:12:52,678 attempt 1/10 2016-11-15 02:12:52,678 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/47e0584afe0a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-15 02:12:53,396 unpacking tar archive at: mozilla-central-47e0584afe0a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.035093 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-15 02:12:53.483084) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 02:12:53.483404) ========= script_repo_revision: 47e0584afe0ab0b867412189c610b302b6ba0ea7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 02:12:53.483805) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 02:12:53.484114) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 02:12:53.496670) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-11-15 02:12:53.497012) ========= /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=fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:12:53 INFO - MultiFileLogger online at 20161115 02:12:53 in /builds/slave/test 02:12:53 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 02:12:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:12:53 INFO - {'append_to_log': False, 02:12:53 INFO - 'base_work_dir': '/builds/slave/test', 02:12:53 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:12:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:12:53 INFO - 'branch': 'Firefox-Non-PGO', 02:12:53 INFO - 'buildbot_json_path': 'buildprops.json', 02:12:53 INFO - 'config_files': ('talos/linux_config.py',), 02:12:53 INFO - 'default_actions': ('clobber', 02:12:53 INFO - 'read-buildbot-config', 02:12:53 INFO - 'download-and-extract', 02:12:53 INFO - 'populate-webroot', 02:12:53 INFO - 'create-virtualenv', 02:12:53 INFO - 'install', 02:12:53 INFO - 'run-tests'), 02:12:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:12:53 INFO - 'download_minidump_stackwalk': True, 02:12:53 INFO - 'download_symbols': 'ondemand', 02:12:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:12:53 INFO - 'tooltool.py': '/tools/tooltool.py', 02:12:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:12:53 INFO - '/tools/misc-python/virtualenv.py')}, 02:12:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:12:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:12:53 INFO - 'installer_path': 'installer.exe', 02:12:53 INFO - 'log_level': 'info', 02:12:53 INFO - 'log_name': 'talos', 02:12:53 INFO - 'log_to_console': True, 02:12:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:12:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:12:53 INFO - 'opt_config_files': (), 02:12:53 INFO - 'pip_index': False, 02:12:53 INFO - 'sps_profile': False, 02:12:53 INFO - 'sps_profile_interval': 0, 02:12:53 INFO - 'suite': 'dromaeojs', 02:12:53 INFO - 'system_bits': '32', 02:12:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:12:53 INFO - 'title': 'talos-linux64-ix-048', 02:12:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:12:53 INFO - 'use_talos_json': True, 02:12:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:12:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:12:53 INFO - 'work_dir': 'build'} 02:12:53 INFO - [mozharness: 2016-11-15 10:12:53.836751Z] Running clobber step. 02:12:53 INFO - Running pre-action listener: _resource_record_pre_action 02:12:53 INFO - Running main action method: clobber 02:12:53 INFO - rmtree: /builds/slave/test/build 02:12:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:12:54 INFO - Running post-action listener: _resource_record_post_action 02:12:54 INFO - [mozharness: 2016-11-15 10:12:54.793242Z] Finished clobber step (success) 02:12:54 INFO - [mozharness: 2016-11-15 10:12:54.793342Z] Running read-buildbot-config step. 02:12:54 INFO - Running pre-action listener: _resource_record_pre_action 02:12:54 INFO - Running main action method: read_buildbot_config 02:12:54 INFO - Using buildbot properties: 02:12:54 INFO - { 02:12:54 INFO - "project": "", 02:12:54 INFO - "product": "firefox", 02:12:54 INFO - "script_repo_revision": "production", 02:12:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 02:12:54 INFO - "repository": "", 02:12:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 02:12:54 INFO - "buildid": "20161113060519", 02:12:54 INFO - "pgo_build": "False", 02:12:54 INFO - "basedir": "/builds/slave/test", 02:12:54 INFO - "buildnumber": 712, 02:12:54 INFO - "slavename": "talos-linux64-ix-048", 02:12:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:12:54 INFO - "platform": "ubuntu64_hw", 02:12:54 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 02:12:54 INFO - "branch": "mozilla-central", 02:12:54 INFO - "repo_path": "mozilla-central", 02:12:54 INFO - "revision": "47e0584afe0ab0b867412189c610b302b6ba0ea7", 02:12:54 INFO - "stage_platform": "linux64", 02:12:54 INFO - "builduid": "779a7a71919a48e09ad57065daef1a40", 02:12:54 INFO - "slavebuilddir": "test" 02:12:54 INFO - } 02:12:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 02:12:54 INFO - Running post-action listener: _resource_record_post_action 02:12:54 INFO - [mozharness: 2016-11-15 10:12:54.795744Z] Finished read-buildbot-config step (success) 02:12:54 INFO - [mozharness: 2016-11-15 10:12:54.795833Z] Running download-and-extract step. 02:12:54 INFO - Running pre-action listener: _resource_record_pre_action 02:12:54 INFO - Running main action method: download_and_extract 02:12:54 INFO - mkdir: /builds/slave/test/build/tests 02:12:54 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')]} 02:12:54 INFO - trying https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:12:54 INFO - Downloading https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:12:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:12:55 INFO - Downloaded 1361 bytes. 02:12:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:12:55 INFO - Using the following test package requirements: 02:12:55 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:12:55 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:12:55 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:12:55 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:55 INFO - u'jsshell-linux-x86_64.zip'], 02:12:55 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:12:55 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:12:55 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:12:55 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:12:55 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:12:55 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:12:55 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:12:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:12:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:12:55 INFO - Fetch https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:12:55 INFO - Http code: 200 02:12:55 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 02:12:55 INFO - x-amz-cf-id: C3p0tsbA4ytHNv7R5fII5c9Zucwza4xLWByXlbKggxyMcXWzOBugIg== 02:12:55 INFO - x-amz-version-id: vB0LmcFG0vtNyyoxgkp9XtTB4FxOa3Yu 02:12:56 INFO - Expected file size: 20419451 02:12:56 INFO - Obtained file size: 20419451 02:13:00 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:13:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:13:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:13:00 INFO - Fetch https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:13:01 INFO - Http code: 200 02:13:01 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 02:13:01 INFO - x-amz-cf-id: g81jbcTHTcgr_7UXBcnEnycZkHr4TuAdumuBEwOO9D56qqc3cJTIUA== 02:13:01 INFO - x-amz-version-id: vB0LmcFG0vtNyyoxgkp9XtTB4FxOa3Yu 02:13:01 INFO - Expected file size: 20419451 02:13:01 INFO - Obtained file size: 20419451 02:13:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 02:13:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:13:06 INFO - Fetch https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 02:13:06 INFO - Http code: 200 02:13:06 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 02:13:06 INFO - x-amz-cf-id: 3oKM5HJO2n6QUcoJOegeDilHkZCD_ayXXuA5426cjFxw292gBq7wlA== 02:13:06 INFO - x-amz-version-id: 4JBLJlO2PobgasJaFoyc184lCp06p2e5 02:13:07 INFO - Expected file size: 14409038 02:13:07 INFO - Obtained file size: 14409038 02:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:07 INFO - trying https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:13:07 INFO - Downloading https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:13:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:13:11 INFO - Downloaded 55661626 bytes. 02:13:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:13:11 INFO - mkdir: /builds/slave/test/properties 02:13:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:13:11 INFO - Writing to file /builds/slave/test/properties/build_url 02:13:11 INFO - Contents: 02:13:11 INFO - build_url:https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:13:11 INFO - Running post-action listener: _resource_record_post_action 02:13:11 INFO - Running post-action listener: set_extra_try_arguments 02:13:11 INFO - [mozharness: 2016-11-15 10:13:11.691519Z] Finished download-and-extract step (success) 02:13:11 INFO - [mozharness: 2016-11-15 10:13:11.691745Z] Running populate-webroot step. 02:13:11 INFO - Running pre-action listener: _resource_record_pre_action 02:13:11 INFO - Running main action method: populate_webroot 02:13:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:13:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:13:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:13:11 INFO - '--tppagecycles', 02:13:11 INFO - '7'], 02:13:11 INFO - 'tests': ['tsvgm']}}, 02:13:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:13:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:13:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:13:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:13:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:13:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:13:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:11 INFO - 'talos_options': ['--disable-e10s'], 02:13:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:11 INFO - 'talos_options': ['--disable-e10s'], 02:13:11 INFO - 'tests': ['damp', 'tps']}, 02:13:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:11 INFO - 'tests': ['damp', 'tps']}, 02:13:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:13:11 INFO - 'tests': ['dromaeo_dom']}, 02:13:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:13:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:13:11 INFO - 'tests': ['basic_compositor_video']}, 02:13:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:13:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:13:11 INFO - 'tests': ['a11yr', 02:13:11 INFO - 'ts_paint', 02:13:11 INFO - 'tpaint', 02:13:11 INFO - 'sessionrestore', 02:13:11 INFO - 'sessionrestore_no_auto_restore', 02:13:11 INFO - 'tabpaint']}, 02:13:11 INFO - 'other-e10s': {'tests': ['a11yr', 02:13:11 INFO - 'ts_paint', 02:13:11 INFO - 'tpaint', 02:13:11 INFO - 'sessionrestore', 02:13:11 INFO - 'sessionrestore_no_auto_restore', 02:13:11 INFO - 'tabpaint']}, 02:13:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:13:11 INFO - 'ts_paint', 02:13:11 INFO - 'tpaint', 02:13:11 INFO - 'sessionrestore', 02:13:11 INFO - 'sessionrestore_no_auto_restore', 02:13:11 INFO - 'tabpaint']}, 02:13:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:13:11 INFO - 'ts_paint', 02:13:11 INFO - 'tpaint', 02:13:11 INFO - 'sessionrestore', 02:13:11 INFO - 'sessionrestore_no_auto_restore', 02:13:11 INFO - 'tabpaint']}, 02:13:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:13:11 INFO - 'tests': ['a11yr', 02:13:11 INFO - 'ts_paint', 02:13:11 INFO - 'tpaint', 02:13:11 INFO - 'sessionrestore', 02:13:11 INFO - 'sessionrestore_no_auto_restore', 02:13:11 INFO - 'tabpaint']}, 02:13:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:13:11 INFO - 'tests': ['a11yr', 02:13:11 INFO - 'ts_paint', 02:13:11 INFO - 'tpaint', 02:13:11 INFO - 'sessionrestore', 02:13:11 INFO - 'sessionrestore_no_auto_restore', 02:13:11 INFO - 'tabpaint']}, 02:13:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:13:11 INFO - 'tests': ['tsvgx', 02:13:11 INFO - 'tsvgr_opacity', 02:13:11 INFO - 'tart', 02:13:11 INFO - 'tscrollx', 02:13:11 INFO - 'cart']}, 02:13:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:13:11 INFO - 'tsvgr_opacity', 02:13:11 INFO - 'tart', 02:13:11 INFO - 'tscrollx', 02:13:11 INFO - 'cart']}, 02:13:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:11 INFO - 'talos_options': ['--disable-e10s'], 02:13:11 INFO - 'tests': ['tp5o']}, 02:13:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:11 INFO - 'tests': ['tp5o']}, 02:13:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:11 INFO - 'talos_options': ['--disable-e10s', 02:13:11 INFO - '--xperf_path', 02:13:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:11 INFO - 'tests': ['tp5n']}, 02:13:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:11 INFO - 'talos_options': ['--xperf_path', 02:13:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:11 INFO - 'tests': ['tp5n']}}, 02:13:11 INFO - 'talos.zip': {'path': '', 02:13:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:13:11 INFO - Running post-action listener: _resource_record_post_action 02:13:11 INFO - [mozharness: 2016-11-15 10:13:11.711002Z] Finished populate-webroot step (success) 02:13:11 INFO - [mozharness: 2016-11-15 10:13:11.711089Z] Running create-virtualenv step. 02:13:11 INFO - Running pre-action listener: _resource_record_pre_action 02:13:11 INFO - Running main action method: create_virtualenv 02:13:11 INFO - Creating virtualenv /builds/slave/test/build/venv 02:13:11 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 02:13:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:13:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:13:11 INFO - Using real prefix '/usr' 02:13:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:13:12 INFO - Installing distribute.............................................................................................................................................................................................done. 02:13:14 INFO - Installing pip.................done. 02:13:14 INFO - Return code: 0 02:13:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:13:14 INFO - Reading from file tmpfile_stdout 02:13:14 INFO - Output received: 02:13:14 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) 02:13:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd96692f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f42ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ff60>, '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 0x1f40d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f411d0>, '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': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', '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 02:13:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:13:14 INFO - Using env: {'DISPLAY': ':0', 02:13:14 INFO - 'HOME': '/home/cltbld', 02:13:14 INFO - 'LANG': 'en_US.UTF-8', 02:13:14 INFO - 'LANGUAGE': 'en_US:en', 02:13:14 INFO - 'LOGNAME': 'cltbld', 02:13:14 INFO - 'MAIL': '/var/mail/cltbld', 02:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:14 INFO - 'MOZ_NO_REMOTE': '1', 02:13:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:14 INFO - 'NO_EM_RESTART': '1', 02:13:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:14 INFO - 'PWD': '/builds/slave/test', 02:13:14 INFO - 'SHELL': '/bin/bash', 02:13:14 INFO - 'SHLVL': '1', 02:13:14 INFO - 'TERM': 'linux', 02:13:14 INFO - 'TMOUT': '86400', 02:13:14 INFO - 'USER': 'cltbld', 02:13:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', 02:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:14 INFO - '_': '/tools/buildbot/bin/python'} 02:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:14 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 02:13:14 INFO - Cleaning up... 02:13:14 INFO - Return code: 0 02:13:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffd96692f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f42ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ff60>, '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 0x1f40d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f411d0>, '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': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', '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 02:13:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:13:14 INFO - Using env: {'DISPLAY': ':0', 02:13:14 INFO - 'HOME': '/home/cltbld', 02:13:14 INFO - 'LANG': 'en_US.UTF-8', 02:13:14 INFO - 'LANGUAGE': 'en_US:en', 02:13:14 INFO - 'LOGNAME': 'cltbld', 02:13:14 INFO - 'MAIL': '/var/mail/cltbld', 02:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:14 INFO - 'MOZ_NO_REMOTE': '1', 02:13:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:14 INFO - 'NO_EM_RESTART': '1', 02:13:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:14 INFO - 'PWD': '/builds/slave/test', 02:13:14 INFO - 'SHELL': '/bin/bash', 02:13:14 INFO - 'SHLVL': '1', 02:13:14 INFO - 'TERM': 'linux', 02:13:14 INFO - 'TMOUT': '86400', 02:13:14 INFO - 'USER': 'cltbld', 02:13:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', 02:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:14 INFO - '_': '/tools/buildbot/bin/python'} 02:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:14 INFO - Downloading/unpacking psutil>=3.1.1 02:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:13:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:13:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:13:16 INFO - Installing collected packages: psutil 02:13:16 INFO - Running setup.py install for psutil 02:13:17 INFO - building 'psutil._psutil_linux' extension 02:13:17 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 02:13:17 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 02:13:17 INFO - building 'psutil._psutil_posix' extension 02:13:17 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 02:13:17 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 02:13:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:13:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:13:17 INFO - Successfully installed psutil 02:13:17 INFO - Cleaning up... 02:13:17 INFO - Return code: 0 02:13:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:13:17 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')]} 02:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:17 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')]} 02:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd96692f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f42ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ff60>, '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 0x1f40d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f411d0>, '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': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', '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 02:13:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:13:17 INFO - Using env: {'DISPLAY': ':0', 02:13:17 INFO - 'HOME': '/home/cltbld', 02:13:17 INFO - 'LANG': 'en_US.UTF-8', 02:13:17 INFO - 'LANGUAGE': 'en_US:en', 02:13:17 INFO - 'LOGNAME': 'cltbld', 02:13:17 INFO - 'MAIL': '/var/mail/cltbld', 02:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:17 INFO - 'MOZ_NO_REMOTE': '1', 02:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:17 INFO - 'NO_EM_RESTART': '1', 02:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:17 INFO - 'PWD': '/builds/slave/test', 02:13:17 INFO - 'SHELL': '/bin/bash', 02:13:17 INFO - 'SHLVL': '1', 02:13:17 INFO - 'TERM': 'linux', 02:13:17 INFO - 'TMOUT': '86400', 02:13:17 INFO - 'USER': 'cltbld', 02:13:17 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', 02:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:17 INFO - '_': '/tools/buildbot/bin/python'} 02:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:13:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:13:19 INFO - Installing collected packages: mozsystemmonitor 02:13:19 INFO - Running setup.py install for mozsystemmonitor 02:13:19 INFO - Successfully installed mozsystemmonitor 02:13:19 INFO - Cleaning up... 02:13:19 INFO - Return code: 0 02:13:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:19 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 0x7ffd96692f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f42ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ff60>, '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 0x1f40d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f411d0>, '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': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', '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 02:13:19 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 02:13:19 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 02:13:19 INFO - Using env: {'DISPLAY': ':0', 02:13:19 INFO - 'HOME': '/home/cltbld', 02:13:19 INFO - 'LANG': 'en_US.UTF-8', 02:13:19 INFO - 'LANGUAGE': 'en_US:en', 02:13:19 INFO - 'LOGNAME': 'cltbld', 02:13:19 INFO - 'MAIL': '/var/mail/cltbld', 02:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:19 INFO - 'MOZ_NO_REMOTE': '1', 02:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:19 INFO - 'NO_EM_RESTART': '1', 02:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:19 INFO - 'PWD': '/builds/slave/test', 02:13:19 INFO - 'SHELL': '/bin/bash', 02:13:19 INFO - 'SHLVL': '1', 02:13:19 INFO - 'TERM': 'linux', 02:13:19 INFO - 'TMOUT': '86400', 02:13:19 INFO - 'USER': 'cltbld', 02:13:19 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', 02:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:19 INFO - '_': '/tools/buildbot/bin/python'} 02:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:20 INFO - Downloading/unpacking jsonschema==2.5.1 02:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:13:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:13:22 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 02:13:22 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 02:13:22 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 02:13:22 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 02:13:22 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 02:13:22 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 02:13:22 INFO - Downloading functools32-3.2.3-2.tar.gz 02:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:13:22 INFO - warning: no files found matching '*.txt' 02:13:22 INFO - no previously-included directories found matching 'build' 02:13:22 INFO - no previously-included directories found matching 'dist' 02:13:22 INFO - no previously-included directories found matching '.git*' 02:13:22 INFO - Installing collected packages: jsonschema, functools32 02:13:22 INFO - Running setup.py install for functools32 02:13:22 INFO - warning: no files found matching '*.txt' 02:13:22 INFO - no previously-included directories found matching 'build' 02:13:22 INFO - no previously-included directories found matching 'dist' 02:13:22 INFO - no previously-included directories found matching '.git*' 02:13:22 INFO - Successfully installed jsonschema functools32 02:13:22 INFO - Cleaning up... 02:13:22 INFO - Return code: 0 02:13:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:22 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 0x7ffd96692f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f42ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ff60>, '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 0x1f40d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f411d0>, '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': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', '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 02:13:22 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 02:13:22 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 02:13:22 INFO - Using env: {'DISPLAY': ':0', 02:13:22 INFO - 'HOME': '/home/cltbld', 02:13:22 INFO - 'LANG': 'en_US.UTF-8', 02:13:22 INFO - 'LANGUAGE': 'en_US:en', 02:13:22 INFO - 'LOGNAME': 'cltbld', 02:13:22 INFO - 'MAIL': '/var/mail/cltbld', 02:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:22 INFO - 'MOZ_NO_REMOTE': '1', 02:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:22 INFO - 'NO_EM_RESTART': '1', 02:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:22 INFO - 'PWD': '/builds/slave/test', 02:13:22 INFO - 'SHELL': '/bin/bash', 02:13:22 INFO - 'SHLVL': '1', 02:13:22 INFO - 'TERM': 'linux', 02:13:22 INFO - 'TMOUT': '86400', 02:13:22 INFO - 'USER': 'cltbld', 02:13:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', 02:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:22 INFO - '_': '/tools/buildbot/bin/python'} 02:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:13:22 INFO - Cleaning up... 02:13:22 INFO - Return code: 0 02:13:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:22 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 0x7ffd96692f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f42ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ff60>, '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 0x1f40d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f411d0>, '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': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', '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 02:13:22 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 02:13:22 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 02:13:22 INFO - Using env: {'DISPLAY': ':0', 02:13:22 INFO - 'HOME': '/home/cltbld', 02:13:22 INFO - 'LANG': 'en_US.UTF-8', 02:13:22 INFO - 'LANGUAGE': 'en_US:en', 02:13:22 INFO - 'LOGNAME': 'cltbld', 02:13:22 INFO - 'MAIL': '/var/mail/cltbld', 02:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:22 INFO - 'MOZ_NO_REMOTE': '1', 02:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:22 INFO - 'NO_EM_RESTART': '1', 02:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:22 INFO - 'PWD': '/builds/slave/test', 02:13:22 INFO - 'SHELL': '/bin/bash', 02:13:22 INFO - 'SHLVL': '1', 02:13:22 INFO - 'TERM': 'linux', 02:13:22 INFO - 'TMOUT': '86400', 02:13:22 INFO - 'USER': 'cltbld', 02:13:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', 02:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:22 INFO - '_': '/tools/buildbot/bin/python'} 02:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:22 INFO - Downloading/unpacking blobuploader==1.2.4 02:13:22 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 02:13:22 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 02:13:22 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 02:13:22 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 02:13:22 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 02:13:22 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 02:13:24 INFO - Downloading blobuploader-1.2.4.tar.gz 02:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:13:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:13:24 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 02:13:24 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 02:13:24 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 02:13:24 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 02:13:24 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 02:13:24 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 02:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:13:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:25 INFO - Downloading docopt-0.6.1.tar.gz 02:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:13:25 INFO - Installing collected packages: blobuploader, requests, docopt 02:13:25 INFO - Running setup.py install for blobuploader 02:13:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:13:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:13:25 INFO - Running setup.py install for requests 02:13:26 INFO - Running setup.py install for docopt 02:13:26 INFO - Successfully installed blobuploader requests docopt 02:13:26 INFO - Cleaning up... 02:13:26 INFO - Return code: 0 02:13:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:26 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 0x7ffd96692f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f42ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ff60>, '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 0x1f40d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f411d0>, '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': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', '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 02:13:26 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 02:13:26 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 02:13:26 INFO - Using env: {'DISPLAY': ':0', 02:13:26 INFO - 'HOME': '/home/cltbld', 02:13:26 INFO - 'LANG': 'en_US.UTF-8', 02:13:26 INFO - 'LANGUAGE': 'en_US:en', 02:13:26 INFO - 'LOGNAME': 'cltbld', 02:13:26 INFO - 'MAIL': '/var/mail/cltbld', 02:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:26 INFO - 'MOZ_NO_REMOTE': '1', 02:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:26 INFO - 'NO_EM_RESTART': '1', 02:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:26 INFO - 'PWD': '/builds/slave/test', 02:13:26 INFO - 'SHELL': '/bin/bash', 02:13:26 INFO - 'SHLVL': '1', 02:13:26 INFO - 'TERM': 'linux', 02:13:26 INFO - 'TMOUT': '86400', 02:13:26 INFO - 'USER': 'cltbld', 02:13:26 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', 02:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:26 INFO - '_': '/tools/buildbot/bin/python'} 02:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:13:26 INFO - Running setup.py (path:/tmp/pip-1jsOw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:13:26 INFO - Running setup.py (path:/tmp/pip-aji6PN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:13:26 INFO - Running setup.py (path:/tmp/pip-eNmJv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:13:26 INFO - Running setup.py (path:/tmp/pip-70QJ5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:13:26 INFO - Running setup.py (path:/tmp/pip-WXEKyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:13:26 INFO - Running setup.py (path:/tmp/pip-Z423Q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:13:26 INFO - Running setup.py (path:/tmp/pip-mLPn1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:13:27 INFO - Running setup.py (path:/tmp/pip-IucjIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:13:27 INFO - Running setup.py (path:/tmp/pip-PtFI8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:13:27 INFO - Running setup.py (path:/tmp/pip-7Ta19T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:13:27 INFO - Running setup.py (path:/tmp/pip-IwVpE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:13:27 INFO - Running setup.py (path:/tmp/pip-v59qqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:13:27 INFO - Running setup.py (path:/tmp/pip-XPS8tC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:13:27 INFO - Running setup.py (path:/tmp/pip-AxF6Nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:27 INFO - Running setup.py (path:/tmp/pip-Vp3kKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:13:27 INFO - Running setup.py (path:/tmp/pip-B_Jv0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:13:27 INFO - Running setup.py (path:/tmp/pip-dq2usb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:13:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:13:27 INFO - Running setup.py install for manifestparser 02:13:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:13:27 INFO - Running setup.py install for mozcrash 02:13:27 INFO - Running setup.py install for mozdebug 02:13:28 INFO - Running setup.py install for mozdevice 02:13:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:13:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:13:28 INFO - Running setup.py install for mozfile 02:13:28 INFO - Running setup.py install for mozhttpd 02:13:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:13:28 INFO - Running setup.py install for mozinfo 02:13:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:13:28 INFO - Running setup.py install for mozInstall 02:13:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:13:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:13:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:13:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:13:28 INFO - Running setup.py install for mozleak 02:13:28 INFO - Running setup.py install for mozlog 02:13:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:13:28 INFO - Running setup.py install for moznetwork 02:13:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:13:28 INFO - Running setup.py install for mozprocess 02:13:28 INFO - Running setup.py install for mozprofile 02:13:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:13:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:13:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:13:29 INFO - Running setup.py install for mozrunner 02:13:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:13:29 INFO - Running setup.py install for mozscreenshot 02:13:29 INFO - Running setup.py install for moztest 02:13:29 INFO - Running setup.py install for mozversion 02:13:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:13:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:13:29 INFO - Cleaning up... 02:13:29 INFO - Return code: 0 02:13:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13:29 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')]} 02:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:29 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')]} 02:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:29 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 0x7ffd96692f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f42ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ff60>, '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 0x1f40d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f411d0>, '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': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', '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 02:13:29 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 02:13:29 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 02:13:29 INFO - Using env: {'DISPLAY': ':0', 02:13:29 INFO - 'HOME': '/home/cltbld', 02:13:29 INFO - 'LANG': 'en_US.UTF-8', 02:13:29 INFO - 'LANGUAGE': 'en_US:en', 02:13:29 INFO - 'LOGNAME': 'cltbld', 02:13:29 INFO - 'MAIL': '/var/mail/cltbld', 02:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:29 INFO - 'MOZ_NO_REMOTE': '1', 02:13:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:29 INFO - 'NO_EM_RESTART': '1', 02:13:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:29 INFO - 'PWD': '/builds/slave/test', 02:13:29 INFO - 'SHELL': '/bin/bash', 02:13:29 INFO - 'SHLVL': '1', 02:13:29 INFO - 'TERM': 'linux', 02:13:29 INFO - 'TMOUT': '86400', 02:13:29 INFO - 'USER': 'cltbld', 02:13:29 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', 02:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:29 INFO - '_': '/tools/buildbot/bin/python'} 02:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:13:29 INFO - Running setup.py (path:/tmp/pip-n9ORGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:13:29 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)) 02:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:13:29 INFO - Running setup.py (path:/tmp/pip-qQLG7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:13:29 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)) 02:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:13:29 INFO - Running setup.py (path:/tmp/pip-gr0SoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:13:29 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)) 02:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:13:29 INFO - Running setup.py (path:/tmp/pip-0CcA9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:13:30 INFO - Running setup.py (path:/tmp/pip-f3GHdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:13:30 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)) 02:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:13:30 INFO - Running setup.py (path:/tmp/pip-G6AV4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:13:30 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)) 02:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:13:30 INFO - Running setup.py (path:/tmp/pip-XMfr6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:13:30 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)) 02:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:13:30 INFO - Running setup.py (path:/tmp/pip-9Doo5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:13:30 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)) 02:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:13:30 INFO - Running setup.py (path:/tmp/pip-bjj42u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:13:30 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)) 02:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:13:30 INFO - Running setup.py (path:/tmp/pip-BjTRyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:13:30 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)) 02:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:13:30 INFO - Running setup.py (path:/tmp/pip-A8lIJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:13:30 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)) 02:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:13:30 INFO - Running setup.py (path:/tmp/pip-iziPSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:13:30 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)) 02:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:13:30 INFO - Running setup.py (path:/tmp/pip-wCnCpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:13:30 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)) 02:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:13:30 INFO - Running setup.py (path:/tmp/pip-RVqqQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:13:30 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)) 02:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:30 INFO - Running setup.py (path:/tmp/pip-5iAi5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:30 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)) 02:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:13:30 INFO - Running setup.py (path:/tmp/pip-Fr5Y5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:13:30 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)) 02:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:13:30 INFO - Running setup.py (path:/tmp/pip-bL0UWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:13:31 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)) 02:13:31 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)) 02:13:31 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)) 02:13:31 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)) 02:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:13:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:13:31 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 02:13:31 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 02:13:31 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 02:13:31 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 02:13:31 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 02:13:31 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 02:13:32 INFO - Downloading blessings-1.6.tar.gz 02:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:13:33 INFO - Installing collected packages: blessings 02:13:33 INFO - Running setup.py install for blessings 02:13:33 INFO - Successfully installed blessings 02:13:33 INFO - Cleaning up... 02:13:33 INFO - Return code: 0 02:13:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:13:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:13:33 INFO - Reading from file tmpfile_stdout 02:13:33 INFO - Current package versions: 02:13:33 INFO - argparse == 1.2.1 02:13:33 INFO - blessings == 1.6 02:13:33 INFO - blobuploader == 1.2.4 02:13:33 INFO - docopt == 0.6.1 02:13:33 INFO - functools32 == 3.2.3-2 02:13:33 INFO - jsonschema == 2.5.1 02:13:33 INFO - manifestparser == 1.1 02:13:33 INFO - mozInstall == 1.12 02:13:33 INFO - mozcrash == 1.0 02:13:33 INFO - mozdebug == 0.1 02:13:33 INFO - mozdevice == 0.48 02:13:33 INFO - mozfile == 1.2 02:13:33 INFO - mozhttpd == 0.7 02:13:33 INFO - mozinfo == 0.9 02:13:33 INFO - mozleak == 0.1 02:13:33 INFO - mozlog == 3.4 02:13:33 INFO - moznetwork == 0.27 02:13:33 INFO - mozprocess == 0.23 02:13:33 INFO - mozprofile == 0.28 02:13:33 INFO - mozrunner == 6.13 02:13:33 INFO - mozscreenshot == 0.1 02:13:33 INFO - mozsystemmonitor == 0.3 02:13:33 INFO - moztest == 0.7 02:13:33 INFO - mozversion == 1.4 02:13:33 INFO - psutil == 3.1.1 02:13:33 INFO - requests == 1.2.3 02:13:33 INFO - wsgiref == 0.1.2 02:13:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13: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')]} 02:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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')]} 02:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:33 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 0x7ffd96692f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f42ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ff60>, '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 0x1f40d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f411d0>, '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': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', '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 02:13:33 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 02:13:33 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 02:13:33 INFO - Using env: {'DISPLAY': ':0', 02:13:33 INFO - 'HOME': '/home/cltbld', 02:13:33 INFO - 'LANG': 'en_US.UTF-8', 02:13:33 INFO - 'LANGUAGE': 'en_US:en', 02:13:33 INFO - 'LOGNAME': 'cltbld', 02:13:33 INFO - 'MAIL': '/var/mail/cltbld', 02:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:33 INFO - 'MOZ_NO_REMOTE': '1', 02:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:33 INFO - 'NO_EM_RESTART': '1', 02:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:33 INFO - 'PWD': '/builds/slave/test', 02:13:33 INFO - 'SHELL': '/bin/bash', 02:13:33 INFO - 'SHLVL': '1', 02:13:33 INFO - 'TERM': 'linux', 02:13:33 INFO - 'TMOUT': '86400', 02:13:33 INFO - 'USER': 'cltbld', 02:13:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', 02:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:33 INFO - '_': '/tools/buildbot/bin/python'} 02:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:33 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)) 02:13:33 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)) 02:13:33 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)) 02:13:33 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)) 02:13:33 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)) 02:13:33 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)) 02:13:33 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)) 02:13:33 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)) 02:13:33 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)) 02:13:33 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)) 02:13:33 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)) 02:13:33 INFO - Cleaning up... 02:13:33 INFO - Return code: 0 02:13:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:13: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')]} 02:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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')]} 02:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:33 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 0x7ffd96692f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f42ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ff60>, '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 0x1f40d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f411d0>, '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': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', '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 02:13:33 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 02:13:33 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 02:13:33 INFO - Using env: {'DISPLAY': ':0', 02:13:33 INFO - 'HOME': '/home/cltbld', 02:13:33 INFO - 'LANG': 'en_US.UTF-8', 02:13:33 INFO - 'LANGUAGE': 'en_US:en', 02:13:33 INFO - 'LOGNAME': 'cltbld', 02:13:33 INFO - 'MAIL': '/var/mail/cltbld', 02:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:33 INFO - 'MOZ_NO_REMOTE': '1', 02:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:33 INFO - 'NO_EM_RESTART': '1', 02:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:33 INFO - 'PWD': '/builds/slave/test', 02:13:33 INFO - 'SHELL': '/bin/bash', 02:13:33 INFO - 'SHLVL': '1', 02:13:33 INFO - 'TERM': 'linux', 02:13:33 INFO - 'TMOUT': '86400', 02:13:33 INFO - 'USER': 'cltbld', 02:13:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', 02:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:33 INFO - '_': '/tools/buildbot/bin/python'} 02:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:13:33 INFO - Cleaning up... 02:13:33 INFO - Return code: 0 02:13:33 INFO - Running post-action listener: _resource_record_post_action 02:13:33 INFO - Running post-action listener: _start_resource_monitoring 02:13:33 INFO - Starting resource monitoring. 02:13:33 INFO - [mozharness: 2016-11-15 10:13:33.929176Z] Finished create-virtualenv step (success) 02:13:33 INFO - [mozharness: 2016-11-15 10:13:33.929738Z] Running install step. 02:13:33 INFO - Running pre-action listener: _resource_record_pre_action 02:13:33 INFO - Running main action method: install 02:13:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:13:34 INFO - Reading from file tmpfile_stdout 02:13:34 INFO - Detecting whether we're running mozinstall >=1.0... 02:13:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:13:34 INFO - Reading from file tmpfile_stdout 02:13:34 INFO - Output received: 02:13:34 INFO - Usage: mozinstall [options] installer 02:13:34 INFO - Options: 02:13:34 INFO - -h, --help show this help message and exit 02:13:34 INFO - -d DEST, --destination=DEST 02:13:34 INFO - Directory to install application into. [default: 02:13:34 INFO - "/builds/slave/test"] 02:13:34 INFO - --app=APP Application being installed. [default: firefox] 02:13:34 INFO - mkdir: /builds/slave/test/build/application 02:13:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:13:50 INFO - Reading from file tmpfile_stdout 02:13:50 INFO - Output received: 02:13:50 INFO - /builds/slave/test/build/application/firefox/firefox 02:13:50 INFO - Running post-action listener: _resource_record_post_action 02:13:50 INFO - [mozharness: 2016-11-15 10:13:50.266650Z] Finished install step (success) 02:13:50 INFO - [mozharness: 2016-11-15 10:13:50.266893Z] Running run-tests step. 02:13:50 INFO - Running pre-action listener: _resource_record_pre_action 02:13:50 INFO - Running main action method: run_tests 02:13:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:13:50 INFO - Python 2.7.3 02:13:50 INFO - Return code: 0 02:13:50 INFO - grabbing minidump binary from tooltool 02:13:50 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')]} 02:13:50 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 0x1f3ff60>, '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 0x1f40d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f411d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:13:50 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 02:13:50 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 02:13:50 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 02:13:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:13:50 INFO - Return code: 0 02:13:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:13:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:13:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:13:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:13:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:13:50 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/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 02:13:50 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/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 02:13:50 INFO - Using env: {'DISPLAY': ':0', 02:13:50 INFO - 'HOME': '/home/cltbld', 02:13:50 INFO - 'LANG': 'en_US.UTF-8', 02:13:50 INFO - 'LANGUAGE': 'en_US:en', 02:13:50 INFO - 'LOGNAME': 'cltbld', 02:13:50 INFO - 'MAIL': '/var/mail/cltbld', 02:13:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:13:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:50 INFO - 'MOZ_NO_REMOTE': '1', 02:13:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:50 INFO - 'NO_EM_RESTART': '1', 02:13:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:50 INFO - 'PWD': '/builds/slave/test', 02:13:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:13:50 INFO - 'SHELL': '/bin/bash', 02:13:50 INFO - 'SHLVL': '1', 02:13:50 INFO - 'TERM': 'linux', 02:13:50 INFO - 'TMOUT': '86400', 02:13:50 INFO - 'USER': 'cltbld', 02:13:50 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218', 02:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:50 INFO - '_': '/tools/buildbot/bin/python'} 02:13:50 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/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 02:13:50 INFO - mozversion application_buildid: 20161113060519 02:13:50 INFO - mozversion application_changeset: 47e0584afe0ab0b867412189c610b302b6ba0ea7 02:13:50 INFO - mozversion application_display_name: Nightly 02:13:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:13:50 INFO - mozversion application_name: Firefox 02:13:50 INFO - mozversion application_remotingname: firefox 02:13:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:13:50 INFO - mozversion application_vendor: Mozilla 02:13:50 INFO - mozversion application_version: 52.0a1 02:13:50 INFO - mozversion platform_buildid: 20161113060519 02:13:50 INFO - mozversion platform_changeset: 47e0584afe0ab0b867412189c610b302b6ba0ea7 02:13:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:13:50 INFO - mozversion platform_version: 52.0a1 02:13:50 INFO - using testdate: 1479204830 02:13:50 INFO - actual date: 1479204830 02:13:50 INFO - starting webserver on 'localhost:50463' 02:13:50 INFO - SUITE-START | Running 2 tests 02:13:50 INFO - TEST-START | dromaeo_css 02:13:50 INFO - operating with platform_type : linux_ 02:13:50 INFO - Initialising browser for dromaeo_css test... 02:13:50 INFO - TEST-INFO | started process 5437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOhDvVt/profile http://localhost:50463/getInfo.html) 02:13:55 INFO - PROCESS | 5437 | __metrics Screen width/height:1600/1200 02:13:55 INFO - PROCESS | 5437 | colorDepth:24 02:13:55 INFO - PROCESS | 5437 | Browser inner width/height: 1024/697 02:13:55 INFO - PROCESS | 5437 | __metrics 02:13:55 INFO - PROCESS | 5437 | 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" 02:13:55 INFO - PROCESS | 5437 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:13:56 INFO - PROCESS | 5437 | console.error: PushService: 02:13:56 INFO - PROCESS | 5437 | stateChangeProcessEnqueue: Error transitioning state 02:13:56 INFO - PROCESS | 5437 | UnknownError 02:13:57 INFO - TEST-INFO | 5437: exit 0 02:13:57 INFO - Browser initialized. 02:13:57 INFO - Running cycle 1/1 for dromaeo_css test... 02:13:57 INFO - TEST-INFO | started process 5520 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOhDvVt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:14:09 INFO - PROCESS | 5520 | RSS: Main: 174587904 02:14:09 INFO - PROCESS | 5520 | 02:15:01 INFO - PROCESS | 5520 | 1479204901376 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] 02:17:15 INFO - PROCESS | 5520 | Cycle 1(1): loaded http://localhost:50463/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50463/tests/dromaeo/cssquery-ext.html) 02:17:16 INFO - PROCESS | 5520 | RSS: Main: 306741248 02:17:16 INFO - PROCESS | 5520 | 02:20:19 INFO - PROCESS | 5520 | Cycle 1(1): loaded http://localhost:50463/tests/dromaeo/cssquery-ext.html (next: http://localhost:50463/tests/dromaeo/cssquery-jquery.html) 02:20:19 INFO - PROCESS | 5520 | RSS: Main: 284975104 02:20:19 INFO - PROCESS | 5520 | 02:23:22 INFO - PROCESS | 5520 | Cycle 1(1): loaded http://localhost:50463/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50463/tests/dromaeo/cssquery-mootools.html) 02:23:22 INFO - PROCESS | 5520 | RSS: Main: 224694272 02:23:22 INFO - PROCESS | 5520 | 02:26:25 INFO - PROCESS | 5520 | Cycle 1(1): loaded http://localhost:50463/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50463/tests/dromaeo/cssquery-prototype.html) 02:26:25 INFO - PROCESS | 5520 | RSS: Main: 226697216 02:26:25 INFO - PROCESS | 5520 | 02:29:28 INFO - PROCESS | 5520 | Cycle 1(1): loaded http://localhost:50463/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50463/tests/dromaeo/cssquery-yui.html) 02:29:29 INFO - PROCESS | 5520 | RSS: Main: 225964032 02:29:29 INFO - PROCESS | 5520 | 02:32:32 INFO - PROCESS | 5520 | Cycle 1(1): loaded http://localhost:50463/tests/dromaeo/cssquery-yui.html (next: http://localhost:50463/tests/dromaeo/cssquery-dojo.html) 02:32:32 INFO - PROCESS | 5520 | RSS: Main: 319684608 02:32:32 INFO - PROCESS | 5520 | 02:32:32 INFO - PROCESS | 5520 | __start_tp_report 02:32:32 INFO - PROCESS | 5520 | _x_x_mozilla_page_load 02:32:32 INFO - PROCESS | 5520 | _x_x_mozilla_page_load_details 02:32:32 INFO - PROCESS | 5520 | |i|pagename|runs| 02:32:32 INFO - PROCESS | 5520 | |0;dojo.html;2589.1326405654104;2618.0967566189656;2642.048862409533;2655.442357105008;2668.506326329628;4512.16524942885;4596.218642830719;4664.137134630096;4690.976545117274;4693.155232058232;4620.260758278676;4630.62954963603;4633.930491042637;4640.443146822386;4640.6055485283705;4274.252005898971;4284.828606855722;4303.462067241595;4325.091730736549;4341.044970106572;4364.236258654739;4374.912501749963;4384.079343337903;4399.362092496602;4402.471703395581;4328.826846926119;4342.652587792969;4363.280058790296;4376.474823021242;4403.757793321366;4406.030673251879;4442.555744425547;4442.911141777178;4444.044530425974;4485.798139083749;4224.366345048236;4231.915361692749;4251.511076226243;4340.153670034345;4344.218040752663;4628.25947848346;4629.328747331618;4633.559811817872;4638.8608341749805;4706.952930470686;4965.875853103666;5009.924851127236;5015.673981191211;5020.648554601179;5038.193888977746;4815.109204797123;4845.660803743739;4846.39420072491;5011.84964451067;5066.518680725325;4626.259798432235;4668.206404911173;4669.649776266793;4694.460137084279;4720.905581888343;5092.057969275622;5111.539961403491;5113.642045056885;5136.255242989746;5216.165413533817;4739.336492890998;4959.70241785494;4963.875903102379;4969.279454479152;5021.748912554358;4842.927356089662;4920.6309526785635;4921.311016457699;4924.064427758786;4926.9014619707405;4789.95210047902;4809.711417314972;4830.3479030331155;4862.927056094161;4884.877878053077;4843.491433399513;4848.272759086165;4876.804927802919;4898.118338698997;4898.338724272177;4168.854090106832;4201.915961680749;4202.663786897041;4241.597048280409;4244.427002354704;3623.221007483404;3666.2944202927515;3682.889513314551;3683.834227459771;3718.3678774608384;4225.535191128974;4262.083652014831;4264.445622069111;4269.935950960738;4322.286822674224;4991.650584459126;4997.675151115166;5001.424836143818;5001.874953126128;5048.0913435581215;4267.530571637118;4277.871663850089;4279.529251782302;4280.67894907877;4318.114786468766;4443.488998765119;4445.911081778347;4493.326001099861;4495.955040449554;4524.773761311922;4685.437747470325;4686.953130468652;4687.3906392170165;4709.81160753566;4731.29030645406;4939.950600493949;4992.650514463952;5000.224965130411;5000.974995125001;5031.270465782514;4493.236149854467;4530.275155975029;4573.291139873325;4657.580817726421;4694.859154225379;4862.07620552094;4945.060438516671;4946.777395017161;4988.5260900214425;4996.325496057985;5011.824586139468;5012.598992080698;5013.899722005613;5016.974915125401;5065.088284108896;4687.695299805502;4740.336352910526;4883.974365383309;4891.29076283944;4936.975315123402;4773.570378665937;4809.158397280532;4816.686915350491;4868.634852386014;4894.19245824435;4729.456112547101;4733.053389322218;4735.692180008288;4753.453352864327;4772.284157376283;4757.738324392191;4856.8300109495995;4872.561469467765;4879.146149423766;4906.484819093944;4641.535846415331;4712.81148754046;4715.363425937592;4734.4081989751285;4816.301636262652 02:32:32 INFO - PROCESS | 5520 | |1;ext.html;546.1534621336928;556.2157358125045;566.422249305708;569.4504802865234;587.7854583077178;27475.587866182;37532;38800.61199388009;38869.22261554774;41249.38125928106;38527.80736096323;38883.22233555327;38938.41592376117;38969.41545876807;39041.60958390415;7487.887681684765;7620.847583048336;7626.961865190667;7628;7631;7573.447443274144;7663.425243106762;7669.156392796788;7671.731489397872;7675.078990521145;7654.196309387517;7686.769396918102;7693.576853273068;7698.461107722462;7700.807479812994;7637.579933103677;7671.7314893979;7679.308862202401;7680;7681.615919204018;7500.8124796879965;7568.886466703004;7575.848483030309;7575.886361704579;7583.924160758377;35889.64110358889;36102;36146.63853361459;36172;36221.45667814985;2910.83990380529;2948.8673009714616;2980.389020250865;3221.2430078931434;3534.8232588370734;26430;27159.592606110924;27203;27264.318392040357;28271.869125234967;3051.4659934511374;3165.398574270881;3166.255929856482;3168.065420700899;3188.2029492626843;227258;228087;228528;228826;230853;26641.86679066592;47598.76200618975;47944;47953.520464795605;47966;32135.839320803247;32234.516482252784;32306.676933230836;32407.51388729171;32460.675393246238;12206.389680515938;12381;12400.75198496025;12414.75170496585;12423.378831058411;9971.80056398868;10053.849192262122;10059.295849290625;10072.143867771176;10092.243081768896;7676.462647614613;7737.497062690907;7797.8303254512275;7805.453618246668;7808.7657370278985;3015.3969206158854;3044.4367791958557;3054.4349295380425;3073.707997740211;3081.7380522655826;795.2842441802425;825.6490991328661;880.704963837109;918.9586468608928;931.3201363005044;24042.63936040961;25975.102077489362;26360.60459093115;26410.86794566015;26472.8676356617;932.7854593443546;960.6685693435753;976.3946353260882;989.1394486796389;1026.2912251101982;13443.731125377437;13921.651958700912;14256.35846386915;14359.425622974964;14381.856181438261;369156;425955;436059;436760;634946;47552;48133.29867221298;48465;48480.5151948483;48498.5150148494;1184.1888306510068;1202.5670758526924;1204.7590481903653;1215.416600031972;1218.932958687263;26510.469790603693;27518.174454766387;27651;28163.57754633723;28173;45233.32150017686;46844.7657761709;46886.531134688215;50629.74685126551;50658.74670626623;338491;342069;342709;343007;343049;35133.472997904544;35674.8216258917;35993.64006359903;36027.45958810672;36454.08864778402;39123;39831.2033759329;40045.79977100096;40171.39742903801;40175.59824401719;33815.32369352649;33905;33909.321813563096;34060;34652.13369665779;33564.160895977795;33765.155871103416;34508.65491345055;34542.30915381729;35354.64645353513;29003.709962900102;29660.40679186361;33363.83318083394;33850.83074584611;34355.65644343525;29064.709352907044;30985;31589;31986;31989.84005080053;24623;24725.876370618753;24772.38069048288;24774.38064048413;25025.624615631143 02:32:32 INFO - PROCESS | 5520 | |2;jquery.html;350.38507419478844;358.7094453492673;359.62419271860904;362.9110867837379;370.19297930511493;12562.748745025094;13708.520201792939;15326.616834579127;16626;16775.077370744602;14191.858081419183;14285.357158927847;14289.71420571588;14371.856281437182;15968.840311596881;3822.44574536692;4771.7614119293985;4985.551300382965;4999.275105109757;5011.498850114996;4855.490173531782;4940.827071052514;4942.604591632678;4944.752762361885;4948.8267910623135;4698.201305778009;4898.216285394337;4919.827806026789;4923.384576927884;4929.433115191763;4921.384826896638;4961.18140506816;4963.230699241605;4971.776270067856;4972.229304457815;4476.865694029184;4477.417935668343;4480.932786008212;4550.613197878184;4807.951920480786;10646.467676616216;10811.135109191246;10813.297135686154;10815.729606759814;10820.945895270552;1797.7752780902388;1858.9535261618432;1959.9314024009234;2059.8867062311565;2357.550106684394;8709.216170544618;8808.955955220246;8831.381803273773;9186.219171370441;9386.920504142043;1659.2533359988054;1672.0720000399774;1672.4898905833716;1702.353105819793;1739.9826001740073;62577;64688;65429.672851635914;65494.345056549304;67982.66008669925;9799.657012004545;9816.116549510578;9849.910405446544;10096.091351778376;10273.434961077062;13607.795883061763;13638.454461821417;13652;13655.931720341334;13668.316584170752;7167.605781681953;7327.157376901618;7393.223711510214;7509.7371591994015;7562.735304264324;7053.0830991970715;7055.1886533049355;7214.747483838146;7217.639118044077;7235.204127545966;4280.764557949343;4312.525622181557;4359.651227901761;4383.057642606855;4479.059397526556;1750.9474715758547;1774.9645007099787;1791.2297711983972;1800.261892624018;1808.4303444414968;749.932506074445;776.6388629287295;810.2059981218321;812.2973627812019;890.9331800114887;15906.76139857903;16260;16646.58383540397;16731.247093880804;17348.913255433894;828.5153185386616;836.197250639393;838.496901858892;842.7977285451448;846.9026062002825;8672.913270867337;9095.272378209727;10020.398776073313;10040.64857729976;10424.739381515372;284457;291917;382514;383262;386064;76547;78538;79019;79310;83996;904.1817155474306;941.6562954521687;942.4769253064615;944.8535477001076;944.9858252126223;15172.620684482976;15175.468858589897;15503.767443488132;15686.450974215848;16137.75793363124;35003.47494787529;35794;36290.63709362873;36650.8167459161;36706.4494032595;46205.30692039689;47326.29010564913;48242.75878620584;48405.75797120992;49211.50788492069;6946.5484743493535;7038;7291.197968223597;7425.59159246225;7501.962490187514;11051;11153;11441.939176745938;11583.942080289544;11898.643040708792;9299.581518831534;9535.666251681158;9577.569009394734;9809.068138526829;9923.206143508358;9630;9643.228541716786;9643.662471813454;9813.26400519978;9979.750506237402;9342.486163261086;9403.670871519464;10056.446895420822;10057.798844022933;10058.14505767018;7219.494635375473;7401.962990185015;7485.101787785283;7610.429217808797;7790.844183116193;9650.324477286804;9796.559154837907;9830.164436022733;10080.193584513368;10115.49422528856 02:32:32 INFO - PROCESS | 5520 | |3;mootools.html;1180.055955235811;1267.575362253645;1301.4794082367052;1315.099157077402;1587.4285257307374;5614.438556144389;5968.224130862987;6217.751289948408;6218.751249950003;6219.160413344197;6058;6159.260888693352;6170.290416602092;6170.382961703838;6210.9068363974575;1920.836728878047;1965.5675751334754;1966.8131527504863;1967.3999430173792;1970.4778233768063;1862.571608530039;1889.6126294109674;1895.7819850717137;1926.0273561851245;1926.7784204816485;1944.3389247655793;1965.2433812981963;1965.59705260422;1968.3602829080535;1969.625771103493;1893.498222970907;1945.4260993006956;1949.2690241159564;1949.4638974282045;1950.6781381072105;1912.0822005437328;1931.6233334499639;1959.7452331196996;1969.3501144622383;1980.1188471130208;6108.908366374508;6308.558400911938;6339.58792678479;6342.904856427157;6371.553991220617;3706.629337066299;3887.708421868343;3893.06566424059;3895.8831235062994;3897.0452239201577;2536.6829146356704;2542.427953710419;2578.3038579583595;2580.8580528070947;2582.302778249862;771.4908160613968;781.562325097947;818.3085292927467;837.1586555511672;838.2497664590219;7888.1323054463965;8106.432549721522;8121.837563248702;8126.228008339198;8150.959245203795;3510.6497893610067;3577.266660334625;3593.2813437312643;3668.871589494355;3671.210689701727;7079.469039822034;7080.893786593205;7085.397741192057;7091.1490621125795;7098.929010709827;3905.6680182184264;3935.842566297373;3936.940945885814;3937.310970580137;3940.4680368149934;3263.494158405451;3363.899083027513;3656.6708996189936;3760.7367484276383;3761.360568703327;2951.896683616063;3026.7136467001437;3060.296131889678;3125.890593829205;3180.236743181666;1019.9133073688671;1036.5180191211123;1044.99477502612;1049.2602715085845;1055.1611468882256;731.1883808972037;743.7991742229676;788.5702292250737;789.7512283630638;815.0748899998426;4360.4767427908855;4478.596926276651;4560.270356742905;4703.506131856174;4764.309175169581;796.7928338631882;816.2205094135087;816.3510009542427;869.4348673362239;870.303756994402;3161.762867784925;3243.61076670801;3245.9675403246138;3325.251818340854;3428.0915557377316;7204.207537170907;7573.091229052549;7573.810654733676;7579.204183560757;7584.582847943306;7521.887171692429;7522.736704215326;7524.209957954446;7524.247575242432;7537.660805263777;5838.562107841929;5864.09106588471;5891.428259607807;5930.822075337746;5980.820575382745;4319.805608747551;4478.171538265431;4544.727316361029;4635.443746750411;4666.836660716858;6743;6934.306569343025;6962.1993470749485;6985.126859142607;6988.965055174692;6803.115594972622;7002.929970700227;7044.084269044992;7069.893951590628;7081.858362832818;5384.623076384615;5426.891462170655;5484.588655850747;5537.8061767837935;5549.250851135045;5363.410024897336;5518.696471693935;5836.824895253149;6101.237345331833;6162.476189523941;5379.515843574097;5417.187421886749;5425.755840987244;5427.050266203478;5511.614187007031;5353.919691204713;5362.356517217959;5378.784848606012;5397.190421436816;5474.562035037267;5276.34045744282;5365.812196573102;5369.382521009978;5369.48989845964;5373.032854086146;3989.1024519482885;4015.0966032642423;4122.186238055246;4138.937915931324;4180.101278225196;4066.5323487799283;4111.444954931046;4146.212219678251;4165.354370072643;4167.8958026049595 02:32:32 INFO - PROCESS | 5520 | |4;prototype.html;288.11979402924067;295.095532193826;298.69682272493407;301.2033172259374;304.2318146679635;4641.164590373732;4719.905601887965;4759.167145749493;4793.760311984395;4804.567588916997;4700.286773448971;4717.198076327024;4726.85819425417;4732.982408782111;4733.148033354004;3510.6313837047123;3599.6040435552068;3627.2020155565733;3710.684591809686;3715.6841668458214;3679.5952445231005;3688.151725103228;3700.908232071545;3704.7221458390595;3707.9073023174365;3658.2866341063504;3659.14010207601;3667.2482141161;3671.7980511071883;3686.705063594906;3548.627394123606;3638.7816730996224;3652.3243200008083;3677.6463063639294;3697.5562932448142;3241.3469130743256;3247.5778148840736;3248.902532924016;3254.479283314682;3279.96720032799;4586.793594288231;4591.540845915415;4597.517260687647;4597.862064138081;4601.217792975202;4166.500059978405;4177;4184.497860256758;4193.448424083109;4205.537390887;4670.299455081731;4904.730239836807;4916.115099282128;4917.606591472673;4939.333190019373;3542.4332106863035;3545.7517973741847;3554.413521768905;3555.8044307563073;3569.7501174917766;5175.974120129413;5194.766235519411;5195;5197.97401013;5199.428062913114;3535.752497325214;3586.372384832644;3600.3159399714496;3628.909277268089;3662.8717994870053;3643.3259846928404;3650.3064417760543;3650.813485617185;3657.738080362271;3662.7619204751604;4173.144505376391;4193.916121677549;4205.474315710536;4206.390073439396;4219.915601687949;4812.278158276286;5020.2720605511995;5025.82409615669;5028.723420211851;5028.79884804611;1219.8719134490927;1225.5587988324196;1228.9815652765217;1231.8829711177423;1238.7055526974334;819.512390127873;849.562475325208;854.619694236059;862.2239984014437;866.1641515937151;4209.24233637942;4287.3140297552245;4293.8711838644895;4336.934945975813;4384.956150438518;5102.158143906288;5127.282180494733;5131.7434128293435;5160.122779127557;5165.845024649267;4336.913261734748;4378.482372635747;4399.274119770202;4426.852976306489;4441.933370999438;2560.2959186223566;2577.7422257774074;2601.570740827742;2613.3858543242322;2631.6184153297663;4562.361269422284;4609.953900460952;4625.629949604024;4639.489656137822;4639.605633521189;5037.219231019198;5050.520200580939;5052.595792336604;5052.823151189691;5065.480355893291;4402.669799764966;4610.423697037937;4633.72197668141;4636.5131661175765;4638.536146385334;4892.217245240744;4915.7542122893;4938.283948827472;4947.653664243612;4949.430815456269;4841.273808928548;4843.2564276861;4864.3189953405845;4876.487968763229;4882.950165714388;4466.285394336891;4588.17412865674;4617.215073437591;4635.837745678885;4644.5123262056995;3592.479090531806;3623.963760362363;3624.1879060469764;3635.5092062571216;3653.953785879916;4900.186930835614;4903.8528844134735;4924;4938.530839570235;4941.456439791548;4625.583697467244;4762.333273341805;4786.425628924551;4796.088743138793;4805.327254184347;4728.361671174347;4741.715497070187;4756.667033307635;4764.285357196448;4785.832495862628;4658.138244424792;4659.20793465105;4687.624990000723;4696.765161741968;4717.575418212377;4727.62179025684;4771.880702982453;4780.354652121919;4803.207470767285;5026.52248036436;4923.409190897115;4924.138275801792;4926.975365123151;4929.556339929423;4946.431160416598 02:32:32 INFO - PROCESS | 5520 | |5;yui.html;612.9509639228862;623.6195920488504;640.9780115811944;673.3468535520547;675.8445557521771;11236.719082022943;11772.941135294323;11871.406429678515;11882.405879706002;11885.821712674317;11295.717607059827;11402.144839137056;11453.14101442393;11461.59884404046;11466.942665286662;617.1575799034308;747.2975403121062;761.4137114421892;762.5539059650112;763.6563546404112;629.6379581740495;743.137959966439;761.0790942959027;766.5132640773094;766.9271419215165;808.0707186735243;810.7243537197352;811.059171361221;811.0632219786127;811.2860682599304;632.4023797511354;798.0343784021312;798.1459837973371;799.2646764976236;799.9600019999006;480.44748539179875;565.1522715926111;579.5884921705594;580.5181699189662;580.7938181945433;11802.763944721057;11832.881671183264;11844.407779610985;11857.110716696196;11868.406579671067;11353.148513861412;11354.48904799286;11598.360451622892;11776.470058847372;11966.34185119818;9197.862032069525;9230.400023998418;10208.387496750218;10397.220208484317;10533;3962.405639154121;4023.436718859362;4063.309237429644;4141.668666506672;4231.555686652888;42368.57631423677;44501.554984450064;44509;50041.499585004414;50646.24030639543;9331.626734930662;9660;9728.659496917573;9869.111779939696;9970.800583988279;16771.580710482336;16904.830951690572;16939.915300423418;17061.48815535536;17079.146042697816;6472.449841763503;6521.08704781331;6570.342965703487;6591.967040164865;6770.086038384755;3445.7415693823064;3484.2508860594585;3488;3507.35114003905;3745.981270093687;2609.4520150768553;2686.140435060801;2697.163879197455;2699.8650067496546;2701.9459610807676;450.05263919449743;457.47162027857877;462.4774005373906;464.00934005896977;478.93294938708607;575.1803679756331;607.2511167836602;609.2354095609982;610.1092405088532;615.5537235504223;7667.233276672288;7714.305712485903;7865.213478652089;7877.086103228618;8416.537090460084;489.7967343552457;587.8265911556101;588.0913987888722;591.2166379547032;595.8599729063667;3758.1732018955786;3788.1855401088897;3834.559025712023;3924.117073658404;4075.857344992911;72025;72459.63770181221;72502;74285;74592;45419.772901135286;63041.68479157666;64363.67818160879;65801.67099164473;66754;55440.722796387374;55491.44508554863;55924.72037639867;56284.718576406856;56616.71691641598;7251.124147583505;7697.268759467842;7730;7851.646675899712;7853.568053757098;40524.79737601293;40573;41294.793526033376;41744.1651166981;41980.79009604932;31509.36981260316;32198.83900580482;32551.837240813646;32712.639656077194;33634.15914602154;10535.683929482127;10576;10653;10892.727681808019;11258.21192516516;11661.941690291495;11771.23486973344;12001;12457.937710311391;12752.234865908074;10953;11099.611513596985;11445.542178312775;11690.824637630612;12039.277643341427;11118.722031949266;11745.29528228309;11930.164888458072;11944.104192185447;11945.880541194478;10982.560697572007;11221.276447557675;11573.652790416301;12144.878551214375;12166.209196402206;9065.501397423204;9409.341346105706;9473.621055157717;9627.711168664951;10077.14344280715;8902.332325075517;9940.652077177265;10021.949890250502;10080.899191007997;10084.54619542137 02:32:32 INFO - PROCESS | 5520 | __end_tp_report 02:32:32 INFO - PROCESS | 5520 | __start_cc_report 02:32:32 INFO - PROCESS | 5520 | _x_x_mozilla_cycle_collect,1334 02:32:32 INFO - PROCESS | 5520 | __end_cc_report 02:32:32 INFO - PROCESS | 5520 | __startTimestamp1479205952964__endTimestamp 02:32:32 INFO - PROCESS | 5520 | 02:32:32 INFO - PROCESS | 5520 | ------- Summary: start ------- 02:32:32 INFO - PROCESS | 5520 | Number of tests: 6 02:32:32 INFO - PROCESS | 5520 | 02:32:32 INFO - PROCESS | 5520 | [#0] dojo.html Cycles:165 Average:4599.23 Median:4694.86 stddev:469.00 (10.0%) stddev-sans-first:443.14 02:32:32 INFO - PROCESS | 5520 | Values: 2589.1 2618.1 2642.0 2655.4 2668.5 4512.2 4596.2 4664.1 4691.0 4693.2 4620.3 4630.6 4633.9 4640.4 4640.6 4274.3 4284.8 4303.5 4325.1 4341.0 4364.2 4374.9 4384.1 4399.4 4402.5 4328.8 4342.7 4363.3 4376.5 4403.8 4406.0 4442.6 4442.9 4444.0 4485.8 4224.4 4231.9 4251.5 4340.2 4344.2 4628.3 4629.3 4633.6 4638.9 4707.0 4965.9 5009.9 5015.7 5020.6 5038.2 4815.1 4845.7 4846.4 5011.8 5066.5 4626.3 4668.2 4669.6 4694.5 4720.9 5092.1 5111.5 5113.6 5136.3 5216.2 4739.3 4959.7 4963.9 4969.3 5021.7 4842.9 4920.6 4921.3 4924.1 4926.9 4790.0 4809.7 4830.3 4862.9 4884.9 4843.5 4848.3 4876.8 4898.1 4898.3 4168.9 4201.9 4202.7 4241.6 4244.4 3623.2 3666.3 3682.9 3683.8 3718.4 4225.5 4262.1 4264.4 4269.9 4322.3 4991.7 4997.7 5001.4 5001.9 5048.1 4267.5 4277.9 4279.5 4280.7 4318.1 4443.5 4445.9 4493.3 4496.0 4524.8 4685.4 4687.0 4687.4 4709.8 4731.3 4940.0 4992.7 5000.2 5001.0 5031.3 4493.2 4530.3 4573.3 4657.6 4694.9 4862.1 4945.1 4946.8 4988.5 4996.3 5011.8 5012.6 5013.9 5017.0 5065.1 4687.7 4740.3 4884.0 4891.3 4937.0 4773.6 4809.2 4816.7 4868.6 4894.2 4729.5 4733.1 4735.7 4753.5 4772.3 4757.7 4856.8 4872.6 4879.1 4906.5 4641.5 4712.8 4715.4 4734.4 4816.3 02:32:32 INFO - PROCESS | 5520 | 02:32:32 INFO - PROCESS | 5520 | [#1] ext.html Cycles:180 Average:47869.36 Median:19334.15 stddev:95971.99 (496.4%) stddev-sans-first:96175.45 02:32:32 INFO - PROCESS | 5520 | Values: 546.2 556.2 566.4 569.5 587.8 27475.6 37532.0 38800.6 38869.2 41249.4 38527.8 38883.2 38938.4 38969.4 39041.6 7487.9 7620.8 7627.0 7628.0 7631.0 7573.4 7663.4 7669.2 7671.7 7675.1 7654.2 7686.8 7693.6 7698.5 7700.8 7637.6 7671.7 7679.3 7680.0 7681.6 7500.8 7568.9 7575.8 7575.9 7583.9 35889.6 36102.0 36146.6 36172.0 36221.5 2910.8 2948.9 2980.4 3221.2 3534.8 26430.0 27159.6 27203.0 27264.3 28271.9 3051.5 3165.4 3166.3 3168.1 3188.2 227258.0 228087.0 228528.0 228826.0 230853.0 26641.9 47598.8 47944.0 47953.5 47966.0 32135.8 32234.5 32306.7 32407.5 32460.7 12206.4 12381.0 12400.8 12414.8 12423.4 9971.8 10053.8 10059.3 10072.1 10092.2 7676.5 7737.5 7797.8 7805.5 7808.8 3015.4 3044.4 3054.4 3073.7 3081.7 795.3 825.6 880.7 919.0 931.3 24042.6 25975.1 26360.6 26410.9 26472.9 932.8 960.7 976.4 989.1 1026.3 13443.7 13921.7 14256.4 14359.4 14381.9 369156.0 425955.0 436059.0 436760.0 634946.0 47552.0 48133.3 48465.0 48480.5 48498.5 1184.2 1202.6 1204.8 1215.4 1218.9 26510.5 27518.2 27651.0 28163.6 28173.0 45233.3 46844.8 46886.5 50629.7 50658.7 338491.0 342069.0 342709.0 343007.0 343049.0 35133.5 35674.8 35993.6 36027.5 36454.1 39123.0 39831.2 40045.8 40171.4 40175.6 33815.3 33905.0 33909.3 34060.0 34652.1 33564.2 33765.2 34508.7 34542.3 35354.6 29003.7 29660.4 33363.8 33850.8 34355.7 29064.7 30985.0 31589.0 31986.0 31989.8 24623.0 24725.9 24772.4 24774.4 25025.6 02:32:32 INFO - PROCESS | 5520 | 02:32:32 INFO - PROCESS | 5520 | [#2] jquery.html Cycles:180 Average:22379.90 Median:48324.26 stddev:57952.17 (119.9%) stddev-sans-first:58091.14 02:32:32 INFO - PROCESS | 5520 | Values: 350.4 358.7 359.6 362.9 370.2 12562.7 13708.5 15326.6 16626.0 16775.1 14191.9 14285.4 14289.7 14371.9 15968.8 3822.4 4771.8 4985.6 4999.3 5011.5 4855.5 4940.8 4942.6 4944.8 4948.8 4698.2 4898.2 4919.8 4923.4 4929.4 4921.4 4961.2 4963.2 4971.8 4972.2 4476.9 4477.4 4480.9 4550.6 4808.0 10646.5 10811.1 10813.3 10815.7 10820.9 1797.8 1859.0 1959.9 2059.9 2357.6 8709.2 8809.0 8831.4 9186.2 9386.9 1659.3 1672.1 1672.5 1702.4 1740.0 62577.0 64688.0 65429.7 65494.3 67982.7 9799.7 9816.1 9849.9 10096.1 10273.4 13607.8 13638.5 13652.0 13655.9 13668.3 7167.6 7327.2 7393.2 7509.7 7562.7 7053.1 7055.2 7214.7 7217.6 7235.2 4280.8 4312.5 4359.7 4383.1 4479.1 1750.9 1775.0 1791.2 1800.3 1808.4 749.9 776.6 810.2 812.3 890.9 15906.8 16260.0 16646.6 16731.2 17348.9 828.5 836.2 838.5 842.8 846.9 8672.9 9095.3 10020.4 10040.6 10424.7 284457.0 291917.0 382514.0 383262.0 386064.0 76547.0 78538.0 79019.0 79310.0 83996.0 904.2 941.7 942.5 944.9 945.0 15172.6 15175.5 15503.8 15686.5 16137.8 35003.5 35794.0 36290.6 36650.8 36706.4 46205.3 47326.3 48242.8 48405.8 49211.5 6946.5 7038.0 7291.2 7425.6 7502.0 11051.0 11153.0 11441.9 11583.9 11898.6 9299.6 9535.7 9577.6 9809.1 9923.2 9630.0 9643.2 9643.7 9813.3 9979.8 9342.5 9403.7 10056.4 10057.8 10058.1 7219.5 7402.0 7485.1 7610.4 7790.8 9650.3 9796.6 9830.2 10080.2 10115.5 02:32:32 INFO - PROCESS | 5520 | 02:32:32 INFO - PROCESS | 5520 | [#3] mootools.html Cycles:180 Average:4212.56 Median:5315.13 stddev:2167.69 (40.8%) stddev-sans-first:2161.79 02:32:32 INFO - PROCESS | 5520 | Values: 1180.1 1267.6 1301.5 1315.1 1587.4 5614.4 5968.2 6217.8 6218.8 6219.2 6058.0 6159.3 6170.3 6170.4 6210.9 1920.8 1965.6 1966.8 1967.4 1970.5 1862.6 1889.6 1895.8 1926.0 1926.8 1944.3 1965.2 1965.6 1968.4 1969.6 1893.5 1945.4 1949.3 1949.5 1950.7 1912.1 1931.6 1959.7 1969.4 1980.1 6108.9 6308.6 6339.6 6342.9 6371.6 3706.6 3887.7 3893.1 3895.9 3897.0 2536.7 2542.4 2578.3 2580.9 2582.3 771.5 781.6 818.3 837.2 838.2 7888.1 8106.4 8121.8 8126.2 8151.0 3510.6 3577.3 3593.3 3668.9 3671.2 7079.5 7080.9 7085.4 7091.1 7098.9 3905.7 3935.8 3936.9 3937.3 3940.5 3263.5 3363.9 3656.7 3760.7 3761.4 2951.9 3026.7 3060.3 3125.9 3180.2 1019.9 1036.5 1045.0 1049.3 1055.2 731.2 743.8 788.6 789.8 815.1 4360.5 4478.6 4560.3 4703.5 4764.3 796.8 816.2 816.4 869.4 870.3 3161.8 3243.6 3246.0 3325.3 3428.1 7204.2 7573.1 7573.8 7579.2 7584.6 7521.9 7522.7 7524.2 7524.2 7537.7 5838.6 5864.1 5891.4 5930.8 5980.8 4319.8 4478.2 4544.7 4635.4 4666.8 6743.0 6934.3 6962.2 6985.1 6989.0 6803.1 7002.9 7044.1 7069.9 7081.9 5384.6 5426.9 5484.6 5537.8 5549.3 5363.4 5518.7 5836.8 6101.2 6162.5 5379.5 5417.2 5425.8 5427.1 5511.6 5353.9 5362.4 5378.8 5397.2 5474.6 5276.3 5365.8 5369.4 5369.5 5373.0 3989.1 4015.1 4122.2 4138.9 4180.1 4066.5 4111.4 4146.2 4165.4 4167.9 02:32:32 INFO - PROCESS | 5520 | 02:32:32 INFO - PROCESS | 5520 | [#4] prototype.html Cycles:180 Average:4059.24 Median:4613.82 stddev:1167.84 (25.3%) stddev-sans-first:1136.30 02:32:32 INFO - PROCESS | 5520 | Values: 288.1 295.1 298.7 301.2 304.2 4641.2 4719.9 4759.2 4793.8 4804.6 4700.3 4717.2 4726.9 4733.0 4733.1 3510.6 3599.6 3627.2 3710.7 3715.7 3679.6 3688.2 3700.9 3704.7 3707.9 3658.3 3659.1 3667.2 3671.8 3686.7 3548.6 3638.8 3652.3 3677.6 3697.6 3241.3 3247.6 3248.9 3254.5 3280.0 4586.8 4591.5 4597.5 4597.9 4601.2 4166.5 4177.0 4184.5 4193.4 4205.5 4670.3 4904.7 4916.1 4917.6 4939.3 3542.4 3545.8 3554.4 3555.8 3569.8 5176.0 5194.8 5195.0 5198.0 5199.4 3535.8 3586.4 3600.3 3628.9 3662.9 3643.3 3650.3 3650.8 3657.7 3662.8 4173.1 4193.9 4205.5 4206.4 4219.9 4812.3 5020.3 5025.8 5028.7 5028.8 1219.9 1225.6 1229.0 1231.9 1238.7 819.5 849.6 854.6 862.2 866.2 4209.2 4287.3 4293.9 4336.9 4385.0 5102.2 5127.3 5131.7 5160.1 5165.8 4336.9 4378.5 4399.3 4426.9 4441.9 2560.3 2577.7 2601.6 2613.4 2631.6 4562.4 4610.0 4625.6 4639.5 4639.6 5037.2 5050.5 5052.6 5052.8 5065.5 4402.7 4610.4 4633.7 4636.5 4638.5 4892.2 4915.8 4938.3 4947.7 4949.4 4841.3 4843.3 4864.3 4876.5 4883.0 4466.3 4588.2 4617.2 4635.8 4644.5 3592.5 3624.0 3624.2 3635.5 3654.0 4900.2 4903.9 4924.0 4938.5 4941.5 4625.6 4762.3 4786.4 4796.1 4805.3 4728.4 4741.7 4756.7 4764.3 4785.8 4658.1 4659.2 4687.6 4696.8 4717.6 4727.6 4771.9 4780.4 4803.2 5026.5 4923.4 4924.1 4927.0 4929.6 4946.4 02:32:32 INFO - PROCESS | 5520 | 02:32:32 INFO - PROCESS | 5520 | [#5] yui.html Cycles:180 Average:14244.56 Median:22934.91 stddev:18305.68 (79.8%) stddev-sans-first:18328.42 02:32:32 INFO - PROCESS | 5520 | Values: 613.0 623.6 641.0 673.3 675.8 11236.7 11772.9 11871.4 11882.4 11885.8 11295.7 11402.1 11453.1 11461.6 11466.9 617.2 747.3 761.4 762.6 763.7 629.6 743.1 761.1 766.5 766.9 808.1 810.7 811.1 811.1 811.3 632.4 798.0 798.1 799.3 800.0 480.4 565.2 579.6 580.5 580.8 11802.8 11832.9 11844.4 11857.1 11868.4 11353.1 11354.5 11598.4 11776.5 11966.3 9197.9 9230.4 10208.4 10397.2 10533.0 3962.4 4023.4 4063.3 4141.7 4231.6 42368.6 44501.6 44509.0 50041.5 50646.2 9331.6 9660.0 9728.7 9869.1 9970.8 16771.6 16904.8 16939.9 17061.5 17079.1 6472.4 6521.1 6570.3 6592.0 6770.1 3445.7 3484.3 3488.0 3507.4 3746.0 2609.5 2686.1 2697.2 2699.9 2701.9 450.1 457.5 462.5 464.0 478.9 575.2 607.3 609.2 610.1 615.6 7667.2 7714.3 7865.2 7877.1 8416.5 489.8 587.8 588.1 591.2 595.9 3758.2 3788.2 3834.6 3924.1 4075.9 72025.0 72459.6 72502.0 74285.0 74592.0 45419.8 63041.7 64363.7 65801.7 66754.0 55440.7 55491.4 55924.7 56284.7 56616.7 7251.1 7697.3 7730.0 7851.6 7853.6 40524.8 40573.0 41294.8 41744.2 41980.8 31509.4 32198.8 32551.8 32712.6 33634.2 10535.7 10576.0 10653.0 10892.7 11258.2 11661.9 11771.2 12001.0 12457.9 12752.2 10953.0 11099.6 11445.5 11690.8 12039.3 11118.7 11745.3 11930.2 11944.1 11945.9 10982.6 11221.3 11573.7 12144.9 12166.2 9065.5 9409.3 9473.6 9627.7 10077.1 8902.3 9940.7 10021.9 10080.9 10084.5 02:32:32 INFO - PROCESS | 5520 | -------- Summary: end -------- 02:32:32 INFO - PROCESS | 5520 | 02:32:34 INFO - TEST-INFO | 5520: exit 0 02:32:34 INFO - TEST-OK | dromaeo_css | took 1123518ms 02:32:34 INFO - TEST-START | kraken 02:32:34 INFO - operating with platform_type : linux_ 02:32:34 INFO - Initialising browser for kraken test... 02:32:34 INFO - TEST-INFO | started process 5831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpahjhYx/profile http://localhost:50463/getInfo.html) 02:32:38 INFO - PROCESS | 5831 | __metrics Screen width/height:1600/1200 02:32:38 INFO - PROCESS | 5831 | colorDepth:24 02:32:38 INFO - PROCESS | 5831 | Browser inner width/height: 1024/697 02:32:38 INFO - PROCESS | 5831 | __metrics 02:32:39 INFO - PROCESS | 5831 | 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" 02:32:39 INFO - PROCESS | 5831 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:32:39 INFO - PROCESS | 5831 | console.error: PushService: 02:32:39 INFO - PROCESS | 5831 | stateChangeProcessEnqueue: Error transitioning state 02:32:39 INFO - PROCESS | 5831 | UnknownError 02:32:40 INFO - TEST-INFO | 5831: exit 0 02:32:40 INFO - Browser initialized. 02:32:40 INFO - Running cycle 1/1 for kraken test... 02:32:40 INFO - TEST-INFO | started process 5913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpahjhYx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:32:52 INFO - PROCESS | 5913 | RSS: Main: 175689728 02:32:52 INFO - PROCESS | 5913 | 02:32:55 INFO - PROCESS | 5913 | Cycle 1(1): loaded http://localhost:50463/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50463/tests/kraken/driver.html?testName=audio-beat-detection) 02:32:56 INFO - PROCESS | 5913 | RSS: Main: 231415808 02:32:56 INFO - PROCESS | 5913 | 02:32:59 INFO - PROCESS | 5913 | Cycle 1(1): loaded http://localhost:50463/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50463/tests/kraken/driver.html?testName=audio-dft) 02:33:00 INFO - PROCESS | 5913 | RSS: Main: 218447872 02:33:00 INFO - PROCESS | 5913 | 02:33:03 INFO - PROCESS | 5913 | Cycle 1(1): loaded http://localhost:50463/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50463/tests/kraken/driver.html?testName=audio-fft) 02:33:03 INFO - PROCESS | 5913 | RSS: Main: 299671552 02:33:03 INFO - PROCESS | 5913 | 02:33:06 INFO - PROCESS | 5913 | Cycle 1(1): loaded http://localhost:50463/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50463/tests/kraken/driver.html?testName=audio-oscillator) 02:33:06 INFO - PROCESS | 5913 | RSS: Main: 210964480 02:33:06 INFO - PROCESS | 5913 | 02:33:08 INFO - PROCESS | 5913 | Cycle 1(1): loaded http://localhost:50463/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50463/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:33:09 INFO - PROCESS | 5913 | RSS: Main: 213860352 02:33:09 INFO - PROCESS | 5913 | 02:33:12 INFO - PROCESS | 5913 | Cycle 1(1): loaded http://localhost:50463/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50463/tests/kraken/driver.html?testName=imaging-darkroom) 02:33:13 INFO - PROCESS | 5913 | RSS: Main: 253620224 02:33:13 INFO - PROCESS | 5913 | 02:33:16 INFO - PROCESS | 5913 | Cycle 1(1): loaded http://localhost:50463/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50463/tests/kraken/driver.html?testName=imaging-desaturate) 02:33:17 INFO - PROCESS | 5913 | RSS: Main: 253431808 02:33:17 INFO - PROCESS | 5913 | 02:33:20 INFO - PROCESS | 5913 | Cycle 1(1): loaded http://localhost:50463/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50463/tests/kraken/driver.html?testName=json-parse-financial) 02:33:20 INFO - PROCESS | 5913 | RSS: Main: 252219392 02:33:20 INFO - PROCESS | 5913 | 02:33:22 INFO - PROCESS | 5913 | Cycle 1(1): loaded http://localhost:50463/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50463/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:33:23 INFO - PROCESS | 5913 | RSS: Main: 214786048 02:33:23 INFO - PROCESS | 5913 | 02:33:24 INFO - PROCESS | 5913 | Cycle 1(1): loaded http://localhost:50463/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50463/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:33:25 INFO - PROCESS | 5913 | RSS: Main: 222564352 02:33:25 INFO - PROCESS | 5913 | 02:33:27 INFO - PROCESS | 5913 | Cycle 1(1): loaded http://localhost:50463/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50463/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:33:28 INFO - PROCESS | 5913 | RSS: Main: 230965248 02:33:28 INFO - PROCESS | 5913 | 02:33:31 INFO - PROCESS | 5913 | Cycle 1(1): loaded http://localhost:50463/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50463/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:33:32 INFO - PROCESS | 5913 | RSS: Main: 238456832 02:33:32 INFO - PROCESS | 5913 | 02:33:35 INFO - PROCESS | 5913 | Cycle 1(1): loaded http://localhost:50463/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50463/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:33:35 INFO - PROCESS | 5913 | RSS: Main: 235794432 02:33:35 INFO - PROCESS | 5913 | 02:33:37 INFO - PROCESS | 5913 | Cycle 1(1): loaded http://localhost:50463/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50463/tests/kraken/driver.html?testName=ai-astar) 02:33:37 INFO - PROCESS | 5913 | RSS: Main: 285597696 02:33:37 INFO - PROCESS | 5913 | 02:33:37 INFO - PROCESS | 5913 | __start_tp_report 02:33:37 INFO - PROCESS | 5913 | _x_x_mozilla_page_load 02:33:37 INFO - PROCESS | 5913 | _x_x_mozilla_page_load_details 02:33:37 INFO - PROCESS | 5913 | |i|pagename|runs| 02:33:37 INFO - PROCESS | 5913 | |0;ai-astar;107;117;117;119;115;117;115;116;116;115 02:33:37 INFO - PROCESS | 5913 | |1;audio-beat-detection;151;132;135;178;133;136;134;128;162;128 02:33:37 INFO - PROCESS | 5913 | |2;audio-dft;163;163;163;162;160;163;163;161;162;160 02:33:37 INFO - PROCESS | 5913 | |3;audio-fft;77;78;76;111;77;77;78;77;99;77 02:33:37 INFO - PROCESS | 5913 | |4;audio-oscillator;86;84;122;83;85;84;115;84;83;120 02:33:37 INFO - PROCESS | 5913 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;117;118 02:33:37 INFO - PROCESS | 5913 | |6;imaging-darkroom;146;147;146;146;147;146;147;147;146;146 02:33:37 INFO - PROCESS | 5913 | |7;imaging-desaturate;85;85;85;85;84;84;84;85;84;84 02:33:37 INFO - PROCESS | 5913 | |8;json-parse-financial;64;63;64;63;63;66;68;65;64;65 02:33:37 INFO - PROCESS | 5913 | |9;json-stringify-tinderbox;66;67;67;67;66;66;68;66;67;67 02:33:37 INFO - PROCESS | 5913 | |10;stanford-crypto-aes;100;93;86;85;90;84;94;84;85;86 02:33:37 INFO - PROCESS | 5913 | |11;stanford-crypto-ccm;144;142;140;142;141;142;144;144;193;141 02:33:37 INFO - PROCESS | 5913 | |12;stanford-crypto-pbkdf2;187;182;184;183;189;189;186;186;181;181 02:33:37 INFO - PROCESS | 5913 | |13;stanford-crypto-sha256-iterative;73;73;71;70;69;70;68;69;69;68 02:33:37 INFO - PROCESS | 5913 | __end_tp_report 02:33:37 INFO - PROCESS | 5913 | __start_cc_report 02:33:37 INFO - PROCESS | 5913 | _x_x_mozilla_cycle_collect,1972 02:33:37 INFO - PROCESS | 5913 | __end_cc_report 02:33:37 INFO - PROCESS | 5913 | __startTimestamp1479206017873__endTimestamp 02:33:37 INFO - PROCESS | 5913 | 02:33:37 INFO - PROCESS | 5913 | ------- Summary: start ------- 02:33:37 INFO - PROCESS | 5913 | Number of tests: 14 02:33:37 INFO - PROCESS | 5913 | 02:33:37 INFO - PROCESS | 5913 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.50 stddev:3.20 (2.8%) stddev-sans-first:1.32 02:33:37 INFO - PROCESS | 5913 | Values: 107.0 117.0 117.0 119.0 115.0 117.0 115.0 116.0 116.0 115.0 02:33:37 INFO - PROCESS | 5913 | 02:33:37 INFO - PROCESS | 5913 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:135.50 stddev:16.66 (12.3%) stddev-sans-first:17.33 02:33:37 INFO - PROCESS | 5913 | Values: 151.0 132.0 135.0 178.0 133.0 136.0 134.0 128.0 162.0 128.0 02:33:37 INFO - PROCESS | 5913 | 02:33:37 INFO - PROCESS | 5913 | [#2] audio-dft Cycles:10 Average:162.00 Median:163.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 02:33:37 INFO - PROCESS | 5913 | Values: 163.0 163.0 163.0 162.0 160.0 163.0 163.0 161.0 162.0 160.0 02:33:37 INFO - PROCESS | 5913 | 02:33:37 INFO - PROCESS | 5913 | [#3] audio-fft Cycles:10 Average:82.70 Median:77.00 stddev:12.10 (15.7%) stddev-sans-first:12.66 02:33:37 INFO - PROCESS | 5913 | Values: 77.0 78.0 76.0 111.0 77.0 77.0 78.0 77.0 99.0 77.0 02:33:37 INFO - PROCESS | 5913 | 02:33:37 INFO - PROCESS | 5913 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:84.00 stddev:16.95 (20.2%) stddev-sans-first:17.69 02:33:37 INFO - PROCESS | 5913 | Values: 86.0 84.0 122.0 83.0 85.0 84.0 115.0 84.0 83.0 120.0 02:33:37 INFO - PROCESS | 5913 | 02:33:37 INFO - PROCESS | 5913 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:33:37 INFO - PROCESS | 5913 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 02:33:37 INFO - PROCESS | 5913 | 02:33:37 INFO - PROCESS | 5913 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:33:37 INFO - PROCESS | 5913 | Values: 146.0 147.0 146.0 146.0 147.0 146.0 147.0 147.0 146.0 146.0 02:33:37 INFO - PROCESS | 5913 | 02:33:37 INFO - PROCESS | 5913 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 02:33:37 INFO - PROCESS | 5913 | Values: 85.0 85.0 85.0 85.0 84.0 84.0 84.0 85.0 84.0 84.0 02:33:37 INFO - PROCESS | 5913 | 02:33:37 INFO - PROCESS | 5913 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.50 stddev:1.58 (2.5%) stddev-sans-first:1.67 02:33:37 INFO - PROCESS | 5913 | Values: 64.0 63.0 64.0 63.0 63.0 66.0 68.0 65.0 64.0 65.0 02:33:37 INFO - PROCESS | 5913 | 02:33:37 INFO - PROCESS | 5913 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 02:33:37 INFO - PROCESS | 5913 | Values: 66.0 67.0 67.0 67.0 66.0 66.0 68.0 66.0 67.0 67.0 02:33:37 INFO - PROCESS | 5913 | 02:33:37 INFO - PROCESS | 5913 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:86.00 stddev:5.40 (6.3%) stddev-sans-first:3.88 02:33:37 INFO - PROCESS | 5913 | Values: 100.0 93.0 86.0 85.0 90.0 84.0 94.0 84.0 85.0 86.0 02:33:37 INFO - PROCESS | 5913 | 02:33:37 INFO - PROCESS | 5913 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:143.00 stddev:16.12 (11.3%) stddev-sans-first:17.05 02:33:37 INFO - PROCESS | 5913 | Values: 144.0 142.0 140.0 142.0 141.0 142.0 144.0 144.0 193.0 141.0 02:33:37 INFO - PROCESS | 5913 | 02:33:37 INFO - PROCESS | 5913 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.80 Median:186.00 stddev:3.05 (1.6%) stddev-sans-first:3.13 02:33:37 INFO - PROCESS | 5913 | Values: 187.0 182.0 184.0 183.0 189.0 189.0 186.0 186.0 181.0 181.0 02:33:37 INFO - PROCESS | 5913 | 02:33:37 INFO - PROCESS | 5913 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.83 (2.6%) stddev-sans-first:1.58 02:33:37 INFO - PROCESS | 5913 | Values: 73.0 73.0 71.0 70.0 69.0 70.0 68.0 69.0 69.0 68.0 02:33:37 INFO - PROCESS | 5913 | -------- Summary: end -------- 02:33:37 INFO - PROCESS | 5913 | 02:33:39 INFO - TEST-INFO | 5913: exit 0 02:33:39 INFO - TEST-OK | kraken | took 65095ms 02:33:39 INFO - SUITE-END | took 1188s 02:33:39 INFO - Completed test suite (00:19:48) 02:33:39 INFO - javascript benchmark 02:33:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2589.1326405654104, 2618.0967566189656, 2642.048862409533, 2655.442357105008, 2668.506326329628, 4512.16524942885, 4596.218642830719, 4664.137134630096, 4690.976545117274, 4693.155232058232, 4620.260758278676, 4630.62954963603, 4633.930491042637, 4640.443146822386, 4640.6055485283705, 4274.252005898971, 4284.828606855722, 4303.462067241595, 4325.091730736549, 4341.044970106572, 4364.236258654739, 4374.912501749963, 4384.079343337903, 4399.362092496602, 4402.471703395581, 4328.826846926119, 4342.652587792969, 4363.280058790296, 4376.474823021242, 4403.757793321366, 4406.030673251879, 4442.555744425547, 4442.911141777178, 4444.044530425974, 4485.798139083749, 4224.366345048236, 4231.915361692749, 4251.511076226243, 4340.153670034345, 4344.218040752663, 4628.25947848346, 4629.328747331618, 4633.559811817872, 4638.8608341749805, 4706.952930470686, 4965.875853103666, 5009.924851127236, 5015.673981191211, 5020.648554601179, 5038.193888977746, 4815.109204797123, 4845.660803743739, 4846.39420072491, 5011.84964451067, 5066.518680725325, 4626.259798432235, 4668.206404911173, 4669.649776266793, 4694.460137084279, 4720.905581888343, 5092.057969275622, 5111.539961403491, 5113.642045056885, 5136.255242989746, 5216.165413533817, 4739.336492890998, 4959.70241785494, 4963.875903102379, 4969.279454479152, 5021.748912554358, 4842.927356089662, 4920.6309526785635, 4921.311016457699, 4924.064427758786, 4926.9014619707405, 4789.95210047902, 4809.711417314972, 4830.3479030331155, 4862.927056094161, 4884.877878053077, 4843.491433399513, 4848.272759086165, 4876.804927802919, 4898.118338698997, 4898.338724272177, 4168.854090106832, 4201.915961680749, 4202.663786897041, 4241.597048280409, 4244.427002354704, 3623.221007483404, 3666.2944202927515, 3682.889513314551, 3683.834227459771, 3718.3678774608384, 4225.535191128974, 4262.083652014831, 4264.445622069111, 4269.935950960738, 4322.286822674224, 4991.650584459126, 4997.675151115166, 5001.424836143818, 5001.874953126128, 5048.0913435581215, 4267.530571637118, 4277.871663850089, 4279.529251782302, 4280.67894907877, 4318.114786468766, 4443.488998765119, 4445.911081778347, 4493.326001099861, 4495.955040449554, 4524.773761311922, 4685.437747470325, 4686.953130468652, 4687.3906392170165, 4709.81160753566, 4731.29030645406, 4939.950600493949, 4992.650514463952, 5000.224965130411, 5000.974995125001, 5031.270465782514, 4493.236149854467, 4530.275155975029, 4573.291139873325, 4657.580817726421, 4694.859154225379, 4862.07620552094, 4945.060438516671, 4946.777395017161, 4988.5260900214425, 4996.325496057985, 5011.824586139468, 5012.598992080698, 5013.899722005613, 5016.974915125401, 5065.088284108896, 4687.695299805502, 4740.336352910526, 4883.974365383309, 4891.29076283944, 4936.975315123402, 4773.570378665937, 4809.158397280532, 4816.686915350491, 4868.634852386014, 4894.19245824435, 4729.456112547101, 4733.053389322218, 4735.692180008288, 4753.453352864327, 4772.284157376283, 4757.738324392191, 4856.8300109495995, 4872.561469467765, 4879.146149423766, 4906.484819093944, 4641.535846415331, 4712.81148754046, 4715.363425937592, 4734.4081989751285, 4816.301636262652], "value": 4570.127652750636, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.1534621336928, 556.2157358125045, 566.422249305708, 569.4504802865234, 587.7854583077178, 27475.587866182, 37532.0, 38800.61199388009, 38869.22261554774, 41249.38125928106, 38527.80736096323, 38883.22233555327, 38938.41592376117, 38969.41545876807, 39041.60958390415, 7487.887681684765, 7620.847583048336, 7626.961865190667, 7628.0, 7631.0, 7573.447443274144, 7663.425243106762, 7669.156392796788, 7671.731489397872, 7675.078990521145, 7654.196309387517, 7686.769396918102, 7693.576853273068, 7698.461107722462, 7700.807479812994, 7637.579933103677, 7671.7314893979, 7679.308862202401, 7680.0, 7681.615919204018, 7500.8124796879965, 7568.886466703004, 7575.848483030309, 7575.886361704579, 7583.924160758377, 35889.64110358889, 36102.0, 36146.63853361459, 36172.0, 36221.45667814985, 2910.83990380529, 2948.8673009714616, 2980.389020250865, 3221.2430078931434, 3534.8232588370734, 26430.0, 27159.592606110924, 27203.0, 27264.318392040357, 28271.869125234967, 3051.4659934511374, 3165.398574270881, 3166.255929856482, 3168.065420700899, 3188.2029492626843, 227258.0, 228087.0, 228528.0, 228826.0, 230853.0, 26641.86679066592, 47598.76200618975, 47944.0, 47953.520464795605, 47966.0, 32135.839320803247, 32234.516482252784, 32306.676933230836, 32407.51388729171, 32460.675393246238, 12206.389680515938, 12381.0, 12400.75198496025, 12414.75170496585, 12423.378831058411, 9971.80056398868, 10053.849192262122, 10059.295849290625, 10072.143867771176, 10092.243081768896, 7676.462647614613, 7737.497062690907, 7797.8303254512275, 7805.453618246668, 7808.7657370278985, 3015.3969206158854, 3044.4367791958557, 3054.4349295380425, 3073.707997740211, 3081.7380522655826, 795.2842441802425, 825.6490991328661, 880.704963837109, 918.9586468608928, 931.3201363005044, 24042.63936040961, 25975.102077489362, 26360.60459093115, 26410.86794566015, 26472.8676356617, 932.7854593443546, 960.6685693435753, 976.3946353260882, 989.1394486796389, 1026.2912251101982, 13443.731125377437, 13921.651958700912, 14256.35846386915, 14359.425622974964, 14381.856181438261, 369156.0, 425955.0, 436059.0, 436760.0, 634946.0, 47552.0, 48133.29867221298, 48465.0, 48480.5151948483, 48498.5150148494, 1184.1888306510068, 1202.5670758526924, 1204.7590481903653, 1215.416600031972, 1218.932958687263, 26510.469790603693, 27518.174454766387, 27651.0, 28163.57754633723, 28173.0, 45233.32150017686, 46844.7657761709, 46886.531134688215, 50629.74685126551, 50658.74670626623, 338491.0, 342069.0, 342709.0, 343007.0, 343049.0, 35133.472997904544, 35674.8216258917, 35993.64006359903, 36027.45958810672, 36454.08864778402, 39123.0, 39831.2033759329, 40045.79977100096, 40171.39742903801, 40175.59824401719, 33815.32369352649, 33905.0, 33909.321813563096, 34060.0, 34652.13369665779, 33564.160895977795, 33765.155871103416, 34508.65491345055, 34542.30915381729, 35354.64645353513, 29003.709962900102, 29660.40679186361, 33363.83318083394, 33850.83074584611, 34355.65644343525, 29064.709352907044, 30985.0, 31589.0, 31986.0, 31989.84005080053, 24623.0, 24725.876370618753, 24772.38069048288, 24774.38064048413, 25025.624615631143], "value": 16132.615941455415, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.38507419478844, 358.7094453492673, 359.62419271860904, 362.9110867837379, 370.19297930511493, 12562.748745025094, 13708.520201792939, 15326.616834579127, 16626.0, 16775.077370744602, 14191.858081419183, 14285.357158927847, 14289.71420571588, 14371.856281437182, 15968.840311596881, 3822.44574536692, 4771.7614119293985, 4985.551300382965, 4999.275105109757, 5011.498850114996, 4855.490173531782, 4940.827071052514, 4942.604591632678, 4944.752762361885, 4948.8267910623135, 4698.201305778009, 4898.216285394337, 4919.827806026789, 4923.384576927884, 4929.433115191763, 4921.384826896638, 4961.18140506816, 4963.230699241605, 4971.776270067856, 4972.229304457815, 4476.865694029184, 4477.417935668343, 4480.932786008212, 4550.613197878184, 4807.951920480786, 10646.467676616216, 10811.135109191246, 10813.297135686154, 10815.729606759814, 10820.945895270552, 1797.7752780902388, 1858.9535261618432, 1959.9314024009234, 2059.8867062311565, 2357.550106684394, 8709.216170544618, 8808.955955220246, 8831.381803273773, 9186.219171370441, 9386.920504142043, 1659.2533359988054, 1672.0720000399774, 1672.4898905833716, 1702.353105819793, 1739.9826001740073, 62577.0, 64688.0, 65429.672851635914, 65494.345056549304, 67982.66008669925, 9799.657012004545, 9816.116549510578, 9849.910405446544, 10096.091351778376, 10273.434961077062, 13607.795883061763, 13638.454461821417, 13652.0, 13655.931720341334, 13668.316584170752, 7167.605781681953, 7327.157376901618, 7393.223711510214, 7509.7371591994015, 7562.735304264324, 7053.0830991970715, 7055.1886533049355, 7214.747483838146, 7217.639118044077, 7235.204127545966, 4280.764557949343, 4312.525622181557, 4359.651227901761, 4383.057642606855, 4479.059397526556, 1750.9474715758547, 1774.9645007099787, 1791.2297711983972, 1800.261892624018, 1808.4303444414968, 749.932506074445, 776.6388629287295, 810.2059981218321, 812.2973627812019, 890.9331800114887, 15906.76139857903, 16260.0, 16646.58383540397, 16731.247093880804, 17348.913255433894, 828.5153185386616, 836.197250639393, 838.496901858892, 842.7977285451448, 846.9026062002825, 8672.913270867337, 9095.272378209727, 10020.398776073313, 10040.64857729976, 10424.739381515372, 284457.0, 291917.0, 382514.0, 383262.0, 386064.0, 76547.0, 78538.0, 79019.0, 79310.0, 83996.0, 904.1817155474306, 941.6562954521687, 942.4769253064615, 944.8535477001076, 944.9858252126223, 15172.620684482976, 15175.468858589897, 15503.767443488132, 15686.450974215848, 16137.75793363124, 35003.47494787529, 35794.0, 36290.63709362873, 36650.8167459161, 36706.4494032595, 46205.30692039689, 47326.29010564913, 48242.75878620584, 48405.75797120992, 49211.50788492069, 6946.5484743493535, 7038.0, 7291.197968223597, 7425.59159246225, 7501.962490187514, 11051.0, 11153.0, 11441.939176745938, 11583.942080289544, 11898.643040708792, 9299.581518831534, 9535.666251681158, 9577.569009394734, 9809.068138526829, 9923.206143508358, 9630.0, 9643.228541716786, 9643.662471813454, 9813.26400519978, 9979.750506237402, 9342.486163261086, 9403.670871519464, 10056.446895420822, 10057.798844022933, 10058.14505767018, 7219.494635375473, 7401.962990185015, 7485.101787785283, 7610.429217808797, 7790.844183116193, 9650.324477286804, 9796.559154837907, 9830.164436022733, 10080.193584513368, 10115.49422528856], "value": 7749.076652497446, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1180.055955235811, 1267.575362253645, 1301.4794082367052, 1315.099157077402, 1587.4285257307374, 5614.438556144389, 5968.224130862987, 6217.751289948408, 6218.751249950003, 6219.160413344197, 6058.0, 6159.260888693352, 6170.290416602092, 6170.382961703838, 6210.9068363974575, 1920.836728878047, 1965.5675751334754, 1966.8131527504863, 1967.3999430173792, 1970.4778233768063, 1862.571608530039, 1889.6126294109674, 1895.7819850717137, 1926.0273561851245, 1926.7784204816485, 1944.3389247655793, 1965.2433812981963, 1965.59705260422, 1968.3602829080535, 1969.625771103493, 1893.498222970907, 1945.4260993006956, 1949.2690241159564, 1949.4638974282045, 1950.6781381072105, 1912.0822005437328, 1931.6233334499639, 1959.7452331196996, 1969.3501144622383, 1980.1188471130208, 6108.908366374508, 6308.558400911938, 6339.58792678479, 6342.904856427157, 6371.553991220617, 3706.629337066299, 3887.708421868343, 3893.06566424059, 3895.8831235062994, 3897.0452239201577, 2536.6829146356704, 2542.427953710419, 2578.3038579583595, 2580.8580528070947, 2582.302778249862, 771.4908160613968, 781.562325097947, 818.3085292927467, 837.1586555511672, 838.2497664590219, 7888.1323054463965, 8106.432549721522, 8121.837563248702, 8126.228008339198, 8150.959245203795, 3510.6497893610067, 3577.266660334625, 3593.2813437312643, 3668.871589494355, 3671.210689701727, 7079.469039822034, 7080.893786593205, 7085.397741192057, 7091.1490621125795, 7098.929010709827, 3905.6680182184264, 3935.842566297373, 3936.940945885814, 3937.310970580137, 3940.4680368149934, 3263.494158405451, 3363.899083027513, 3656.6708996189936, 3760.7367484276383, 3761.360568703327, 2951.896683616063, 3026.7136467001437, 3060.296131889678, 3125.890593829205, 3180.236743181666, 1019.9133073688671, 1036.5180191211123, 1044.99477502612, 1049.2602715085845, 1055.1611468882256, 731.1883808972037, 743.7991742229676, 788.5702292250737, 789.7512283630638, 815.0748899998426, 4360.4767427908855, 4478.596926276651, 4560.270356742905, 4703.506131856174, 4764.309175169581, 796.7928338631882, 816.2205094135087, 816.3510009542427, 869.4348673362239, 870.303756994402, 3161.762867784925, 3243.61076670801, 3245.9675403246138, 3325.251818340854, 3428.0915557377316, 7204.207537170907, 7573.091229052549, 7573.810654733676, 7579.204183560757, 7584.582847943306, 7521.887171692429, 7522.736704215326, 7524.209957954446, 7524.247575242432, 7537.660805263777, 5838.562107841929, 5864.09106588471, 5891.428259607807, 5930.822075337746, 5980.820575382745, 4319.805608747551, 4478.171538265431, 4544.727316361029, 4635.443746750411, 4666.836660716858, 6743.0, 6934.306569343025, 6962.1993470749485, 6985.126859142607, 6988.965055174692, 6803.115594972622, 7002.929970700227, 7044.084269044992, 7069.893951590628, 7081.858362832818, 5384.623076384615, 5426.891462170655, 5484.588655850747, 5537.8061767837935, 5549.250851135045, 5363.410024897336, 5518.696471693935, 5836.824895253149, 6101.237345331833, 6162.476189523941, 5379.515843574097, 5417.187421886749, 5425.755840987244, 5427.050266203478, 5511.614187007031, 5353.919691204713, 5362.356517217959, 5378.784848606012, 5397.190421436816, 5474.562035037267, 5276.34045744282, 5365.812196573102, 5369.382521009978, 5369.48989845964, 5373.032854086146, 3989.1024519482885, 4015.0966032642423, 4122.186238055246, 4138.937915931324, 4180.101278225196, 4066.5323487799283, 4111.444954931046, 4146.212219678251, 4165.354370072643, 4167.8958026049595], "value": 3498.3580858574114, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.11979402924067, 295.095532193826, 298.69682272493407, 301.2033172259374, 304.2318146679635, 4641.164590373732, 4719.905601887965, 4759.167145749493, 4793.760311984395, 4804.567588916997, 4700.286773448971, 4717.198076327024, 4726.85819425417, 4732.982408782111, 4733.148033354004, 3510.6313837047123, 3599.6040435552068, 3627.2020155565733, 3710.684591809686, 3715.6841668458214, 3679.5952445231005, 3688.151725103228, 3700.908232071545, 3704.7221458390595, 3707.9073023174365, 3658.2866341063504, 3659.14010207601, 3667.2482141161, 3671.7980511071883, 3686.705063594906, 3548.627394123606, 3638.7816730996224, 3652.3243200008083, 3677.6463063639294, 3697.5562932448142, 3241.3469130743256, 3247.5778148840736, 3248.902532924016, 3254.479283314682, 3279.96720032799, 4586.793594288231, 4591.540845915415, 4597.517260687647, 4597.862064138081, 4601.217792975202, 4166.500059978405, 4177.0, 4184.497860256758, 4193.448424083109, 4205.537390887, 4670.299455081731, 4904.730239836807, 4916.115099282128, 4917.606591472673, 4939.333190019373, 3542.4332106863035, 3545.7517973741847, 3554.413521768905, 3555.8044307563073, 3569.7501174917766, 5175.974120129413, 5194.766235519411, 5195.0, 5197.97401013, 5199.428062913114, 3535.752497325214, 3586.372384832644, 3600.3159399714496, 3628.909277268089, 3662.8717994870053, 3643.3259846928404, 3650.3064417760543, 3650.813485617185, 3657.738080362271, 3662.7619204751604, 4173.144505376391, 4193.916121677549, 4205.474315710536, 4206.390073439396, 4219.915601687949, 4812.278158276286, 5020.2720605511995, 5025.82409615669, 5028.723420211851, 5028.79884804611, 1219.8719134490927, 1225.5587988324196, 1228.9815652765217, 1231.8829711177423, 1238.7055526974334, 819.512390127873, 849.562475325208, 854.619694236059, 862.2239984014437, 866.1641515937151, 4209.24233637942, 4287.3140297552245, 4293.8711838644895, 4336.934945975813, 4384.956150438518, 5102.158143906288, 5127.282180494733, 5131.7434128293435, 5160.122779127557, 5165.845024649267, 4336.913261734748, 4378.482372635747, 4399.274119770202, 4426.852976306489, 4441.933370999438, 2560.2959186223566, 2577.7422257774074, 2601.570740827742, 2613.3858543242322, 2631.6184153297663, 4562.361269422284, 4609.953900460952, 4625.629949604024, 4639.489656137822, 4639.605633521189, 5037.219231019198, 5050.520200580939, 5052.595792336604, 5052.823151189691, 5065.480355893291, 4402.669799764966, 4610.423697037937, 4633.72197668141, 4636.5131661175765, 4638.536146385334, 4892.217245240744, 4915.7542122893, 4938.283948827472, 4947.653664243612, 4949.430815456269, 4841.273808928548, 4843.2564276861, 4864.3189953405845, 4876.487968763229, 4882.950165714388, 4466.285394336891, 4588.17412865674, 4617.215073437591, 4635.837745678885, 4644.5123262056995, 3592.479090531806, 3623.963760362363, 3624.1879060469764, 3635.5092062571216, 3653.953785879916, 4900.186930835614, 4903.8528844134735, 4924.0, 4938.530839570235, 4941.456439791548, 4625.583697467244, 4762.333273341805, 4786.425628924551, 4796.088743138793, 4805.327254184347, 4728.361671174347, 4741.715497070187, 4756.667033307635, 4764.285357196448, 4785.832495862628, 4658.138244424792, 4659.20793465105, 4687.624990000723, 4696.765161741968, 4717.575418212377, 4727.62179025684, 4771.880702982453, 4780.354652121919, 4803.207470767285, 5026.52248036436, 4923.409190897115, 4924.138275801792, 4926.975365123151, 4929.556339929423, 4946.431160416598], "value": 3690.079791167253, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.9509639228862, 623.6195920488504, 640.9780115811944, 673.3468535520547, 675.8445557521771, 11236.719082022943, 11772.941135294323, 11871.406429678515, 11882.405879706002, 11885.821712674317, 11295.717607059827, 11402.144839137056, 11453.14101442393, 11461.59884404046, 11466.942665286662, 617.1575799034308, 747.2975403121062, 761.4137114421892, 762.5539059650112, 763.6563546404112, 629.6379581740495, 743.137959966439, 761.0790942959027, 766.5132640773094, 766.9271419215165, 808.0707186735243, 810.7243537197352, 811.059171361221, 811.0632219786127, 811.2860682599304, 632.4023797511354, 798.0343784021312, 798.1459837973371, 799.2646764976236, 799.9600019999006, 480.44748539179875, 565.1522715926111, 579.5884921705594, 580.5181699189662, 580.7938181945433, 11802.763944721057, 11832.881671183264, 11844.407779610985, 11857.110716696196, 11868.406579671067, 11353.148513861412, 11354.48904799286, 11598.360451622892, 11776.470058847372, 11966.34185119818, 9197.862032069525, 9230.400023998418, 10208.387496750218, 10397.220208484317, 10533.0, 3962.405639154121, 4023.436718859362, 4063.309237429644, 4141.668666506672, 4231.555686652888, 42368.57631423677, 44501.554984450064, 44509.0, 50041.499585004414, 50646.24030639543, 9331.626734930662, 9660.0, 9728.659496917573, 9869.111779939696, 9970.800583988279, 16771.580710482336, 16904.830951690572, 16939.915300423418, 17061.48815535536, 17079.146042697816, 6472.449841763503, 6521.08704781331, 6570.342965703487, 6591.967040164865, 6770.086038384755, 3445.7415693823064, 3484.2508860594585, 3488.0, 3507.35114003905, 3745.981270093687, 2609.4520150768553, 2686.140435060801, 2697.163879197455, 2699.8650067496546, 2701.9459610807676, 450.05263919449743, 457.47162027857877, 462.4774005373906, 464.00934005896977, 478.93294938708607, 575.1803679756331, 607.2511167836602, 609.2354095609982, 610.1092405088532, 615.5537235504223, 7667.233276672288, 7714.305712485903, 7865.213478652089, 7877.086103228618, 8416.537090460084, 489.7967343552457, 587.8265911556101, 588.0913987888722, 591.2166379547032, 595.8599729063667, 3758.1732018955786, 3788.1855401088897, 3834.559025712023, 3924.117073658404, 4075.857344992911, 72025.0, 72459.63770181221, 72502.0, 74285.0, 74592.0, 45419.772901135286, 63041.68479157666, 64363.67818160879, 65801.67099164473, 66754.0, 55440.722796387374, 55491.44508554863, 55924.72037639867, 56284.718576406856, 56616.71691641598, 7251.124147583505, 7697.268759467842, 7730.0, 7851.646675899712, 7853.568053757098, 40524.79737601293, 40573.0, 41294.793526033376, 41744.1651166981, 41980.79009604932, 31509.36981260316, 32198.83900580482, 32551.837240813646, 32712.639656077194, 33634.15914602154, 10535.683929482127, 10576.0, 10653.0, 10892.727681808019, 11258.21192516516, 11661.941690291495, 11771.23486973344, 12001.0, 12457.937710311391, 12752.234865908074, 10953.0, 11099.611513596985, 11445.542178312775, 11690.824637630612, 12039.277643341427, 11118.722031949266, 11745.29528228309, 11930.164888458072, 11944.104192185447, 11945.880541194478, 10982.560697572007, 11221.276447557675, 11573.652790416301, 12144.878551214375, 12166.209196402206, 9065.501397423204, 9409.341346105706, 9473.621055157717, 9627.711168664951, 10077.14344280715, 8902.332325075517, 9940.652077177265, 10021.949890250502, 10080.899191007997, 10084.54619542137], "value": 5999.584046110984, "unit": "score"}], "name": "dromaeo_css", "value": 5947.389532053356, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 117.0, 119.0, 115.0, 117.0, 115.0, 116.0, 116.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 132.0, 135.0, 178.0, 133.0, 136.0, 134.0, 128.0, 162.0, 128.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 160.0, 163.0, 163.0, 161.0, 162.0, 160.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 111.0, 77.0, 77.0, 78.0, 77.0, 99.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 122.0, 83.0, 85.0, 84.0, 115.0, 84.0, 83.0, 120.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 63.0, 66.0, 68.0, 65.0, 64.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 66.0, 66.0, 68.0, 66.0, 67.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 93.0, 86.0, 85.0, 90.0, 84.0, 94.0, 84.0, 85.0, 86.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 142.0, 140.0, 142.0, 141.0, 142.0, 144.0, 144.0, 193.0, 141.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 182.0, 184.0, 183.0, 189.0, 189.0, 186.0, 186.0, 181.0, 181.0], "value": 184.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 71.0, 70.0, 69.0, 70.0, 68.0, 69.0, 69.0, 68.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1566.5, "alertThreshold": 2.0}]} 02:33:39 INFO - Return code: 0 02:33:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:33:39 INFO - # TBPL SUCCESS # 02:33:39 INFO - Running post-action listener: _resource_record_post_action 02:33:39 INFO - [mozharness: 2016-11-15 10:33:39.663897Z] Finished run-tests step (success) 02:33:39 INFO - Running post-run listener: _resource_record_post_run 02:33:39 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 8192; Write bytes: 389959680; Read time: 228; Write time: 399024 02:33:39 INFO - TinderboxPrint: CPU usage
13.1% 02:33:39 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 228 02:33:39 INFO - TinderboxPrint: I/O write bytes / time
389,959,680 / 399,024 02:33:39 INFO - TinderboxPrint: CPU idle
8,352.7 (86.9%) 02:33:39 INFO - TinderboxPrint: CPU user
1,211.5 (12.6%) 02:33:39 INFO - TinderboxPrint: Swap in / out
0 / 0 02:33:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99647488; Read time: 0; Write time: 122756 02:33:39 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290312192; Read time: 216; Write time: 276268 02:33:40 INFO - Running post-run listener: _upload_blobber_files 02:33:40 INFO - Blob upload gear active. 02:33:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:33:40 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 02:33:40 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'] 02:33:40 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 02:33:40 INFO - (blobuploader) - INFO - Open directory for files ... 02:33:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:33:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:33:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:44 INFO - (blobuploader) - INFO - Done attempting. 02:33:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:33:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:33:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:45 INFO - (blobuploader) - INFO - Done attempting. 02:33:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:33:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:33:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:45 INFO - (blobuploader) - INFO - Done attempting. 02:33:45 INFO - (blobuploader) - INFO - Iteration through files over. 02:33:45 INFO - Return code: 0 02:33:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:33:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:33:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9192cb78a60598c5d8e87fea0105f97747cd2cc08abaccfa34eb13ad9f37ab85e6dcd5355fdf089814fec20fa8ce50cc21928fa25806623a108e870187438337", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c22dd00c64faa2e0c07e19f59001665be1548f6fb562ea46dd1e54c031d333a7ff81f0a00b402e1f22f78deaaf41cb26f5f592e4ecb08cff0da536ded0994755", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48808f98a32356eaae53acab27c40d4dc67414861ed73daad3ca0aa12041cea5615bf2240c1e516c80d41737d190027496a3dad3429eb0d4225d18a33c6608bc"} 02:33:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:33:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:33:45 INFO - Contents: 02:33:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9192cb78a60598c5d8e87fea0105f97747cd2cc08abaccfa34eb13ad9f37ab85e6dcd5355fdf089814fec20fa8ce50cc21928fa25806623a108e870187438337", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c22dd00c64faa2e0c07e19f59001665be1548f6fb562ea46dd1e54c031d333a7ff81f0a00b402e1f22f78deaaf41cb26f5f592e4ecb08cff0da536ded0994755", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48808f98a32356eaae53acab27c40d4dc67414861ed73daad3ca0aa12041cea5615bf2240c1e516c80d41737d190027496a3dad3429eb0d4225d18a33c6608bc"} 02:33:45 INFO - Running post-run listener: copy_logs_to_upload_dir 02:33:45 INFO - Copying logs to upload dir... 02:33:45 INFO - mkdir: /builds/slave/test/build/upload/logs 02:33:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.135516 ========= master_lag: 0.56 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-11-15 02:33:46.193667) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 02:33:46.200793) ========= 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=fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218 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/9192cb78a60598c5d8e87fea0105f97747cd2cc08abaccfa34eb13ad9f37ab85e6dcd5355fdf089814fec20fa8ce50cc21928fa25806623a108e870187438337", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c22dd00c64faa2e0c07e19f59001665be1548f6fb562ea46dd1e54c031d333a7ff81f0a00b402e1f22f78deaaf41cb26f5f592e4ecb08cff0da536ded0994755", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48808f98a32356eaae53acab27c40d4dc67414861ed73daad3ca0aa12041cea5615bf2240c1e516c80d41737d190027496a3dad3429eb0d4225d18a33c6608bc"} build_url:https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/C8ClPuXGSWWq4eqambusIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9192cb78a60598c5d8e87fea0105f97747cd2cc08abaccfa34eb13ad9f37ab85e6dcd5355fdf089814fec20fa8ce50cc21928fa25806623a108e870187438337", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c22dd00c64faa2e0c07e19f59001665be1548f6fb562ea46dd1e54c031d333a7ff81f0a00b402e1f22f78deaaf41cb26f5f592e4ecb08cff0da536ded0994755", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48808f98a32356eaae53acab27c40d4dc67414861ed73daad3ca0aa12041cea5615bf2240c1e516c80d41737d190027496a3dad3429eb0d4225d18a33c6608bc"}' ========= master_lag: 0.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 02:33:46.280764) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 02:33:46.281161) ========= 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=fa44defc139c4ba8574fe040000001db-1479202533.544496-656841218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.30 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 02:33:46.586345) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 02:33:46.586677) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 02:33:46.591604) ========= ========= Total master_lag: 1.03 =========