builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1479341894.95 results: success (0) buildid: 20161116150023 builduid: 1c49fd6fcdb14dab90bd0eb11ad44e8e revision: 044f8226032fd9084d5fe617ac3b0b0ec6ac783d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 16:18:14.946324) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 16:18:14.946972) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 16:18:14.947475) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 16:18:14.982511) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:18:14.982783) ========= 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=20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-16 16:18:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.6M=0s 2016-11-16 16:18:15 (50.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113689 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:18:15.110179) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:18:15.110510) ========= 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=20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021772 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:18:15.160631) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:18:15.160945) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 044f8226032fd9084d5fe617ac3b0b0ec6ac783d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 044f8226032fd9084d5fe617ac3b0b0ec6ac783d --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=20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-16 16:18:15,293 truncating revision to first 12 chars 2016-11-16 16:18:15,293 Setting DEBUG logging. 2016-11-16 16:18:15,294 attempt 1/10 2016-11-16 16:18:15,294 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/044f8226032f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-16 16:18:15,595 unpacking tar archive at: graphics-044f8226032f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600892 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:18:15.774614) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 16:18:15.774919) ========= script_repo_revision: 044f8226032fd9084d5fe617ac3b0b0ec6ac783d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 16:18:15.775319) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 16:18:15.775583) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 16:18:15.783562) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-11-16 16:18:15.783903) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:18:16 INFO - MultiFileLogger online at 20161116 16:18:16 in /builds/slave/test 16:18:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 16:18:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:18:16 INFO - {'append_to_log': False, 16:18:16 INFO - 'base_work_dir': '/builds/slave/test', 16:18:16 INFO - 'blob_upload_branch': 'Graphics', 16:18:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:18:16 INFO - 'branch': 'Graphics', 16:18:16 INFO - 'buildbot_json_path': 'buildprops.json', 16:18:16 INFO - 'config_files': ('talos/linux_config.py',), 16:18:16 INFO - 'default_actions': ('clobber', 16:18:16 INFO - 'read-buildbot-config', 16:18:16 INFO - 'download-and-extract', 16:18:16 INFO - 'populate-webroot', 16:18:16 INFO - 'create-virtualenv', 16:18:16 INFO - 'install', 16:18:16 INFO - 'run-tests'), 16:18:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:18:16 INFO - 'download_minidump_stackwalk': True, 16:18:16 INFO - 'download_symbols': 'ondemand', 16:18:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:18:16 INFO - 'tooltool.py': '/tools/tooltool.py', 16:18:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:18:16 INFO - '/tools/misc-python/virtualenv.py')}, 16:18:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:18:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:18:16 INFO - 'installer_path': 'installer.exe', 16:18:16 INFO - 'log_level': 'info', 16:18:16 INFO - 'log_name': 'talos', 16:18:16 INFO - 'log_to_console': True, 16:18:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:18:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:18:16 INFO - 'opt_config_files': (), 16:18:16 INFO - 'pip_index': False, 16:18:16 INFO - 'sps_profile': False, 16:18:16 INFO - 'sps_profile_interval': 0, 16:18:16 INFO - 'suite': 'dromaeojs-e10s', 16:18:16 INFO - 'system_bits': '32', 16:18:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:18:16 INFO - 'title': 'talos-linux64-ix-015', 16:18:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:18:16 INFO - 'use_talos_json': True, 16:18:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:18:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:18:16 INFO - 'work_dir': 'build'} 16:18:16 INFO - [mozharness: 2016-11-17 00:18:16.009148Z] Running clobber step. 16:18:16 INFO - Running pre-action listener: _resource_record_pre_action 16:18:16 INFO - Running main action method: clobber 16:18:16 INFO - rmtree: /builds/slave/test/build 16:18:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:18:16 INFO - Running post-action listener: _resource_record_post_action 16:18:16 INFO - [mozharness: 2016-11-17 00:18:16.460255Z] Finished clobber step (success) 16:18:16 INFO - [mozharness: 2016-11-17 00:18:16.460353Z] Running read-buildbot-config step. 16:18:16 INFO - Running pre-action listener: _resource_record_pre_action 16:18:16 INFO - Running main action method: read_buildbot_config 16:18:16 INFO - Using buildbot properties: 16:18:16 INFO - { 16:18:16 INFO - "project": "", 16:18:16 INFO - "product": "firefox", 16:18:16 INFO - "script_repo_revision": "default", 16:18:16 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 16:18:16 INFO - "repository": "", 16:18:16 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 16:18:16 INFO - "buildid": "20161116150023", 16:18:16 INFO - "pgo_build": "False", 16:18:16 INFO - "basedir": "/builds/slave/test", 16:18:16 INFO - "buildnumber": 2, 16:18:16 INFO - "slavename": "talos-linux64-ix-015", 16:18:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:18:16 INFO - "platform": "ubuntu64_hw", 16:18:16 INFO - "scheduler": "tests-graphics-linux64-talos", 16:18:16 INFO - "branch": "graphics", 16:18:16 INFO - "repo_path": "projects/graphics", 16:18:16 INFO - "revision": "044f8226032fd9084d5fe617ac3b0b0ec6ac783d", 16:18:16 INFO - "stage_platform": "linux64", 16:18:16 INFO - "builduid": "1c49fd6fcdb14dab90bd0eb11ad44e8e", 16:18:16 INFO - "slavebuilddir": "test" 16:18:16 INFO - } 16:18:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 16:18:16 INFO - Running post-action listener: _resource_record_post_action 16:18:16 INFO - [mozharness: 2016-11-17 00:18:16.462788Z] Finished read-buildbot-config step (success) 16:18:16 INFO - [mozharness: 2016-11-17 00:18:16.462876Z] Running download-and-extract step. 16:18:16 INFO - Running pre-action listener: _resource_record_pre_action 16:18:16 INFO - Running main action method: download_and_extract 16:18:16 INFO - mkdir: /builds/slave/test/build/tests 16:18:16 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')]} 16:18:16 INFO - trying https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 16:18:16 INFO - Downloading https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 16:18:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:18:17 INFO - Downloaded 1361 bytes. 16:18:17 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 16:18:17 INFO - Using the following test package requirements: 16:18:17 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 16:18:17 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:17 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:18:17 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:17 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:18:17 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:17 INFO - u'jsshell-linux-x86_64.zip'], 16:18:17 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:17 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:18:17 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 16:18:17 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:17 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:18:17 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:17 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:18:17 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:17 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:18:17 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:17 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:18:17 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:18:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 16:18:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:18:17 INFO - Fetch https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:18:17 INFO - Http code: 200 16:18:17 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 16:18:17 INFO - x-amz-cf-id: LizTe8Ug_taBSEE3kYPmBObASp9DDNlpkOkrvjSG-qe70_8ZWRfrcg== 16:18:17 INFO - x-amz-version-id: RGTLBZJCISRP9fJneoA_oFvVaw1FPDtN 16:18:17 INFO - Expected file size: 20353917 16:18:17 INFO - Obtained file size: 20353917 16:18:21 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:18:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 16:18:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:18:21 INFO - Fetch https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:18:22 INFO - Http code: 200 16:18:22 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 16:18:22 INFO - x-amz-cf-id: wz2_JRO4To41mOC4eqvXazb8RjlQUV_hjM9q5Zl9qODOcI-L5lrTFw== 16:18:22 INFO - x-amz-version-id: RGTLBZJCISRP9fJneoA_oFvVaw1FPDtN 16:18:22 INFO - Expected file size: 20353917 16:18:22 INFO - Obtained file size: 20353917 16:18:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 16:18:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:18:27 INFO - Fetch https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:18:27 INFO - Http code: 200 16:18:27 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 16:18:27 INFO - x-amz-cf-id: wyrC7wyEL-SwE1QDUNI8lJphTNXVJVyQXiJxJ10nYelVw1-dCTEfWw== 16:18:27 INFO - x-amz-version-id: UJlF7NvrZNqXqeVBEJzRhXg9yqi.hOI4 16:18:27 INFO - Expected file size: 14409366 16:18:27 INFO - Obtained file size: 14409366 16:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:28 INFO - trying https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 16:18:28 INFO - Downloading https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 16:18:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:18:29 INFO - Downloaded 55754889 bytes. 16:18:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 16:18:29 INFO - mkdir: /builds/slave/test/properties 16:18:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:18:29 INFO - Writing to file /builds/slave/test/properties/build_url 16:18:29 INFO - Contents: 16:18:29 INFO - build_url:https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 16:18:29 INFO - Running post-action listener: _resource_record_post_action 16:18:29 INFO - Running post-action listener: set_extra_try_arguments 16:18:29 INFO - [mozharness: 2016-11-17 00:18:29.913787Z] Finished download-and-extract step (success) 16:18:29 INFO - [mozharness: 2016-11-17 00:18:29.914013Z] Running populate-webroot step. 16:18:29 INFO - Running pre-action listener: _resource_record_pre_action 16:18:29 INFO - Running main action method: populate_webroot 16:18:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:18:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:18:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:18:29 INFO - '--tppagecycles', 16:18:29 INFO - '7'], 16:18:29 INFO - 'tests': ['tsvgm']}}, 16:18:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:18:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:18:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:18:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:18:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:18:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:18:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:18:29 INFO - 'talos_options': ['--disable-e10s'], 16:18:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:18:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:18:29 INFO - 'talos_options': ['--disable-e10s'], 16:18:29 INFO - 'tests': ['damp', 'tps']}, 16:18:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:18:29 INFO - 'tests': ['damp', 'tps']}, 16:18:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:18:29 INFO - 'tests': ['dromaeo_dom']}, 16:18:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:18:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:18:29 INFO - 'tests': ['basic_compositor_video']}, 16:18:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:18:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:18:29 INFO - 'tests': ['a11yr', 16:18:29 INFO - 'ts_paint', 16:18:29 INFO - 'tpaint', 16:18:29 INFO - 'sessionrestore', 16:18:29 INFO - 'sessionrestore_no_auto_restore', 16:18:29 INFO - 'tabpaint']}, 16:18:29 INFO - 'other-e10s': {'tests': ['a11yr', 16:18:29 INFO - 'ts_paint', 16:18:29 INFO - 'tpaint', 16:18:29 INFO - 'sessionrestore', 16:18:29 INFO - 'sessionrestore_no_auto_restore', 16:18:29 INFO - 'tabpaint']}, 16:18:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:18:29 INFO - 'ts_paint', 16:18:29 INFO - 'tpaint', 16:18:29 INFO - 'sessionrestore', 16:18:29 INFO - 'sessionrestore_no_auto_restore', 16:18:29 INFO - 'tabpaint']}, 16:18:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:18:29 INFO - 'ts_paint', 16:18:29 INFO - 'tpaint', 16:18:29 INFO - 'sessionrestore', 16:18:29 INFO - 'sessionrestore_no_auto_restore', 16:18:29 INFO - 'tabpaint']}, 16:18:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:18:29 INFO - 'tests': ['a11yr', 16:18:29 INFO - 'ts_paint', 16:18:29 INFO - 'tpaint', 16:18:29 INFO - 'sessionrestore', 16:18:29 INFO - 'sessionrestore_no_auto_restore', 16:18:29 INFO - 'tabpaint']}, 16:18:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:18:29 INFO - 'tests': ['a11yr', 16:18:29 INFO - 'ts_paint', 16:18:29 INFO - 'tpaint', 16:18:29 INFO - 'sessionrestore', 16:18:29 INFO - 'sessionrestore_no_auto_restore', 16:18:29 INFO - 'tabpaint']}, 16:18:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:18:29 INFO - 'tests': ['tsvgx', 16:18:29 INFO - 'tsvgr_opacity', 16:18:29 INFO - 'tart', 16:18:29 INFO - 'tscrollx', 16:18:29 INFO - 'cart']}, 16:18:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:18:29 INFO - 'tsvgr_opacity', 16:18:29 INFO - 'tart', 16:18:29 INFO - 'tscrollx', 16:18:29 INFO - 'cart']}, 16:18:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:18:29 INFO - 'talos_options': ['--disable-e10s'], 16:18:29 INFO - 'tests': ['tp5o']}, 16:18:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:18:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:18:29 INFO - 'talos_options': ['--disable-e10s', 16:18:29 INFO - '--xperf_path', 16:18:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:29 INFO - 'tests': ['tp5n']}, 16:18:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:18:29 INFO - 'talos_options': ['--xperf_path', 16:18:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:29 INFO - 'tests': ['tp5n']}}, 16:18:29 INFO - 'talos.zip': {'path': '', 16:18:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:18:29 INFO - Running post-action listener: _resource_record_post_action 16:18:29 INFO - [mozharness: 2016-11-17 00:18:29.933859Z] Finished populate-webroot step (success) 16:18:29 INFO - [mozharness: 2016-11-17 00:18:29.933947Z] Running create-virtualenv step. 16:18:29 INFO - Running pre-action listener: _resource_record_pre_action 16:18:29 INFO - Running main action method: create_virtualenv 16:18:29 INFO - Creating virtualenv /builds/slave/test/build/venv 16:18:29 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 16:18:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:18:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:18:30 INFO - Using real prefix '/usr' 16:18:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:18:30 INFO - Installing distribute.............................................................................................................................................................................................done. 16:18:32 INFO - Installing pip.................done. 16:18:32 INFO - Return code: 0 16:18:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:18:32 INFO - Reading from file tmpfile_stdout 16:18:32 INFO - Output received: 16:18:32 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) 16:18:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:18:32 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')]} 16:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:32 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')]} 16:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:32 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 0x7f9a1d2d0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5fc0>, '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 0x1ee6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee7350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', '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 16:18:32 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 16:18:32 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 16:18:32 INFO - Using env: {'DISPLAY': ':0', 16:18:32 INFO - 'HOME': '/home/cltbld', 16:18:32 INFO - 'LANG': 'en_US.UTF-8', 16:18:32 INFO - 'LANGUAGE': 'en_US:en', 16:18:32 INFO - 'LOGNAME': 'cltbld', 16:18:32 INFO - 'MAIL': '/var/mail/cltbld', 16:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:32 INFO - 'MOZ_NO_REMOTE': '1', 16:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:32 INFO - 'NO_EM_RESTART': '1', 16:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:32 INFO - 'PWD': '/builds/slave/test', 16:18:32 INFO - 'SHELL': '/bin/bash', 16:18:32 INFO - 'SHLVL': '1', 16:18:32 INFO - 'TERM': 'linux', 16:18:32 INFO - 'TMOUT': '86400', 16:18:32 INFO - 'USER': 'cltbld', 16:18:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', 16:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:32 INFO - '_': '/tools/buildbot/bin/python'} 16:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:32 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 16:18:32 INFO - Cleaning up... 16:18:32 INFO - Return code: 0 16:18:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:18:32 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')]} 16:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:32 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')]} 16:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:32 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 0x7f9a1d2d0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5fc0>, '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 0x1ee6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee7350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', '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 16:18:32 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 16:18:32 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 16:18:32 INFO - Using env: {'DISPLAY': ':0', 16:18:32 INFO - 'HOME': '/home/cltbld', 16:18:32 INFO - 'LANG': 'en_US.UTF-8', 16:18:32 INFO - 'LANGUAGE': 'en_US:en', 16:18:32 INFO - 'LOGNAME': 'cltbld', 16:18:32 INFO - 'MAIL': '/var/mail/cltbld', 16:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:32 INFO - 'MOZ_NO_REMOTE': '1', 16:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:32 INFO - 'NO_EM_RESTART': '1', 16:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:32 INFO - 'PWD': '/builds/slave/test', 16:18:32 INFO - 'SHELL': '/bin/bash', 16:18:32 INFO - 'SHLVL': '1', 16:18:32 INFO - 'TERM': 'linux', 16:18:32 INFO - 'TMOUT': '86400', 16:18:32 INFO - 'USER': 'cltbld', 16:18:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', 16:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:32 INFO - '_': '/tools/buildbot/bin/python'} 16:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:33 INFO - Downloading/unpacking psutil>=3.1.1 16:18:33 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 16:18:33 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 16:18:33 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 16:18:33 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 16:18:33 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 16:18:33 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 16:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:18:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:18:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:18:35 INFO - Installing collected packages: psutil 16:18:35 INFO - Running setup.py install for psutil 16:18:35 INFO - building 'psutil._psutil_linux' extension 16:18:35 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 16:18:35 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 16:18:35 INFO - building 'psutil._psutil_posix' extension 16:18:35 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 16:18:35 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 16:18:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:18:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:18:35 INFO - Successfully installed psutil 16:18:35 INFO - Cleaning up... 16:18:35 INFO - Return code: 0 16:18:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:18:35 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')]} 16:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:35 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')]} 16:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:35 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 0x7f9a1d2d0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5fc0>, '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 0x1ee6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee7350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', '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 16:18:35 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 16:18:35 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 16:18:35 INFO - Using env: {'DISPLAY': ':0', 16:18:35 INFO - 'HOME': '/home/cltbld', 16:18:35 INFO - 'LANG': 'en_US.UTF-8', 16:18:35 INFO - 'LANGUAGE': 'en_US:en', 16:18:35 INFO - 'LOGNAME': 'cltbld', 16:18:35 INFO - 'MAIL': '/var/mail/cltbld', 16:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:35 INFO - 'MOZ_NO_REMOTE': '1', 16:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:35 INFO - 'NO_EM_RESTART': '1', 16:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:35 INFO - 'PWD': '/builds/slave/test', 16:18:35 INFO - 'SHELL': '/bin/bash', 16:18:35 INFO - 'SHLVL': '1', 16:18:35 INFO - 'TERM': 'linux', 16:18:35 INFO - 'TMOUT': '86400', 16:18:35 INFO - 'USER': 'cltbld', 16:18:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', 16:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:35 INFO - '_': '/tools/buildbot/bin/python'} 16:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:18:35 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 16:18:35 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 16:18:35 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 16:18:35 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 16:18:35 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 16:18:35 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 16:18:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:18:37 INFO - Installing collected packages: mozsystemmonitor 16:18:37 INFO - Running setup.py install for mozsystemmonitor 16:18:38 INFO - Successfully installed mozsystemmonitor 16:18:38 INFO - Cleaning up... 16:18:38 INFO - Return code: 0 16:18:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:18:38 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')]} 16:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:38 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')]} 16:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:38 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 0x7f9a1d2d0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5fc0>, '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 0x1ee6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee7350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', '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 16:18:38 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 16:18:38 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 16:18:38 INFO - Using env: {'DISPLAY': ':0', 16:18:38 INFO - 'HOME': '/home/cltbld', 16:18:38 INFO - 'LANG': 'en_US.UTF-8', 16:18:38 INFO - 'LANGUAGE': 'en_US:en', 16:18:38 INFO - 'LOGNAME': 'cltbld', 16:18:38 INFO - 'MAIL': '/var/mail/cltbld', 16:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:38 INFO - 'MOZ_NO_REMOTE': '1', 16:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:38 INFO - 'NO_EM_RESTART': '1', 16:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:38 INFO - 'PWD': '/builds/slave/test', 16:18:38 INFO - 'SHELL': '/bin/bash', 16:18:38 INFO - 'SHLVL': '1', 16:18:38 INFO - 'TERM': 'linux', 16:18:38 INFO - 'TMOUT': '86400', 16:18:38 INFO - 'USER': 'cltbld', 16:18:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', 16:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:38 INFO - '_': '/tools/buildbot/bin/python'} 16:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:38 INFO - Downloading/unpacking jsonschema==2.5.1 16:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:18:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:40 INFO - Downloading functools32-3.2.3-2.tar.gz 16:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:18:40 INFO - warning: no files found matching '*.txt' 16:18:40 INFO - no previously-included directories found matching 'build' 16:18:40 INFO - no previously-included directories found matching 'dist' 16:18:40 INFO - no previously-included directories found matching '.git*' 16:18:40 INFO - Installing collected packages: jsonschema, functools32 16:18:40 INFO - Running setup.py install for functools32 16:18:40 INFO - warning: no files found matching '*.txt' 16:18:40 INFO - no previously-included directories found matching 'build' 16:18:40 INFO - no previously-included directories found matching 'dist' 16:18:40 INFO - no previously-included directories found matching '.git*' 16:18:40 INFO - Successfully installed jsonschema functools32 16:18:40 INFO - Cleaning up... 16:18:40 INFO - Return code: 0 16:18:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9a1d2d0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5fc0>, '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 0x1ee6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee7350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', '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 16:18:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:18:40 INFO - Using env: {'DISPLAY': ':0', 16:18:40 INFO - 'HOME': '/home/cltbld', 16:18:40 INFO - 'LANG': 'en_US.UTF-8', 16:18:40 INFO - 'LANGUAGE': 'en_US:en', 16:18:40 INFO - 'LOGNAME': 'cltbld', 16:18:40 INFO - 'MAIL': '/var/mail/cltbld', 16:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:40 INFO - 'MOZ_NO_REMOTE': '1', 16:18:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:40 INFO - 'NO_EM_RESTART': '1', 16:18:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:40 INFO - 'PWD': '/builds/slave/test', 16:18:40 INFO - 'SHELL': '/bin/bash', 16:18:40 INFO - 'SHLVL': '1', 16:18:40 INFO - 'TERM': 'linux', 16:18:40 INFO - 'TMOUT': '86400', 16:18:40 INFO - 'USER': 'cltbld', 16:18:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', 16:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:40 INFO - '_': '/tools/buildbot/bin/python'} 16:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:18:40 INFO - Cleaning up... 16:18:40 INFO - Return code: 0 16:18:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9a1d2d0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5fc0>, '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 0x1ee6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee7350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', '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 16:18:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:18:40 INFO - Using env: {'DISPLAY': ':0', 16:18:40 INFO - 'HOME': '/home/cltbld', 16:18:40 INFO - 'LANG': 'en_US.UTF-8', 16:18:40 INFO - 'LANGUAGE': 'en_US:en', 16:18:40 INFO - 'LOGNAME': 'cltbld', 16:18:40 INFO - 'MAIL': '/var/mail/cltbld', 16:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:40 INFO - 'MOZ_NO_REMOTE': '1', 16:18:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:40 INFO - 'NO_EM_RESTART': '1', 16:18:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:40 INFO - 'PWD': '/builds/slave/test', 16:18:40 INFO - 'SHELL': '/bin/bash', 16:18:40 INFO - 'SHLVL': '1', 16:18:40 INFO - 'TERM': 'linux', 16:18:40 INFO - 'TMOUT': '86400', 16:18:40 INFO - 'USER': 'cltbld', 16:18:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', 16:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:40 INFO - '_': '/tools/buildbot/bin/python'} 16:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:41 INFO - Downloading/unpacking blobuploader==1.2.4 16:18:41 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 16:18:41 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 16:18:41 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 16:18:41 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 16:18:41 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 16:18:41 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 16:18:43 INFO - Downloading blobuploader-1.2.4.tar.gz 16:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:18:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:18:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:43 INFO - Downloading docopt-0.6.1.tar.gz 16:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:18:43 INFO - Installing collected packages: blobuploader, requests, docopt 16:18:43 INFO - Running setup.py install for blobuploader 16:18:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:18:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:18:43 INFO - Running setup.py install for requests 16:18:44 INFO - Running setup.py install for docopt 16:18:44 INFO - Successfully installed blobuploader requests docopt 16:18:44 INFO - Cleaning up... 16:18:44 INFO - Return code: 0 16:18:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:44 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 0x7f9a1d2d0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5fc0>, '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 0x1ee6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee7350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', '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 16:18:44 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 16:18:44 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 16:18:44 INFO - Using env: {'DISPLAY': ':0', 16:18:44 INFO - 'HOME': '/home/cltbld', 16:18:44 INFO - 'LANG': 'en_US.UTF-8', 16:18:44 INFO - 'LANGUAGE': 'en_US:en', 16:18:44 INFO - 'LOGNAME': 'cltbld', 16:18:44 INFO - 'MAIL': '/var/mail/cltbld', 16:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:44 INFO - 'MOZ_NO_REMOTE': '1', 16:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:44 INFO - 'NO_EM_RESTART': '1', 16:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:44 INFO - 'PWD': '/builds/slave/test', 16:18:44 INFO - 'SHELL': '/bin/bash', 16:18:44 INFO - 'SHLVL': '1', 16:18:44 INFO - 'TERM': 'linux', 16:18:44 INFO - 'TMOUT': '86400', 16:18:44 INFO - 'USER': 'cltbld', 16:18:44 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', 16:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:44 INFO - '_': '/tools/buildbot/bin/python'} 16:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:18:44 INFO - Running setup.py (path:/tmp/pip-2u5Fby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:18:44 INFO - Running setup.py (path:/tmp/pip-yHJM0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:18:44 INFO - Running setup.py (path:/tmp/pip-a0v7WN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:18:44 INFO - Running setup.py (path:/tmp/pip-5LbaEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:18:45 INFO - Running setup.py (path:/tmp/pip-I_6tlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:18:45 INFO - Running setup.py (path:/tmp/pip-FRqjzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:18:45 INFO - Running setup.py (path:/tmp/pip-rRtbWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:18:45 INFO - Running setup.py (path:/tmp/pip-tJu6Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:18:45 INFO - Running setup.py (path:/tmp/pip-xVJYK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:18:45 INFO - Running setup.py (path:/tmp/pip-w8S9Ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:18:45 INFO - Running setup.py (path:/tmp/pip-qSCHfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:18:45 INFO - Running setup.py (path:/tmp/pip-245fXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:18:45 INFO - Running setup.py (path:/tmp/pip-UFqORR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:18:45 INFO - Running setup.py (path:/tmp/pip-E_LO6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:45 INFO - Running setup.py (path:/tmp/pip-dPDK05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:18:45 INFO - Running setup.py (path:/tmp/pip-nQdl0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:18:45 INFO - Running setup.py (path:/tmp/pip-CXggLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:18:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:18:45 INFO - Running setup.py install for manifestparser 16:18:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:18:46 INFO - Running setup.py install for mozcrash 16:18:46 INFO - Running setup.py install for mozdebug 16:18:46 INFO - Running setup.py install for mozdevice 16:18:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:18:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:18:46 INFO - Running setup.py install for mozfile 16:18:46 INFO - Running setup.py install for mozhttpd 16:18:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:18:46 INFO - Running setup.py install for mozinfo 16:18:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:18:46 INFO - Running setup.py install for mozInstall 16:18:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:18:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:18:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:18:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:18:46 INFO - Running setup.py install for mozleak 16:18:46 INFO - Running setup.py install for mozlog 16:18:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:18:46 INFO - Running setup.py install for moznetwork 16:18:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:18:47 INFO - Running setup.py install for mozprocess 16:18:47 INFO - Running setup.py install for mozprofile 16:18:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:18:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:18:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:18:47 INFO - Running setup.py install for mozrunner 16:18:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:18:47 INFO - Running setup.py install for mozscreenshot 16:18:47 INFO - Running setup.py install for moztest 16:18:47 INFO - Running setup.py install for mozversion 16:18:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:18:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:18:47 INFO - Cleaning up... 16:18:47 INFO - Return code: 0 16:18:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:47 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 0x7f9a1d2d0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5fc0>, '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 0x1ee6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee7350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', '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 16:18:47 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 16:18:47 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 16:18:47 INFO - Using env: {'DISPLAY': ':0', 16:18:47 INFO - 'HOME': '/home/cltbld', 16:18:47 INFO - 'LANG': 'en_US.UTF-8', 16:18:47 INFO - 'LANGUAGE': 'en_US:en', 16:18:47 INFO - 'LOGNAME': 'cltbld', 16:18:47 INFO - 'MAIL': '/var/mail/cltbld', 16:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:47 INFO - 'MOZ_NO_REMOTE': '1', 16:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:47 INFO - 'NO_EM_RESTART': '1', 16:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:47 INFO - 'PWD': '/builds/slave/test', 16:18:47 INFO - 'SHELL': '/bin/bash', 16:18:47 INFO - 'SHLVL': '1', 16:18:47 INFO - 'TERM': 'linux', 16:18:47 INFO - 'TMOUT': '86400', 16:18:47 INFO - 'USER': 'cltbld', 16:18:47 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', 16:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:47 INFO - '_': '/tools/buildbot/bin/python'} 16:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:18:47 INFO - Running setup.py (path:/tmp/pip-rXXSmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:18:48 INFO - Running setup.py (path:/tmp/pip-JBaqmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:18:48 INFO - Running setup.py (path:/tmp/pip-6G577_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:18:48 INFO - Running setup.py (path:/tmp/pip-kZ4ZA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:18:48 INFO - Running setup.py (path:/tmp/pip-u1gQq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:18:48 INFO - Running setup.py (path:/tmp/pip-DW8Bys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:18:48 INFO - Running setup.py (path:/tmp/pip-oZDBlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:18:48 INFO - Running setup.py (path:/tmp/pip-oK4KhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:18:48 INFO - Running setup.py (path:/tmp/pip-qU5zW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:18:48 INFO - Running setup.py (path:/tmp/pip-jhVGbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:18:48 INFO - Running setup.py (path:/tmp/pip-7Xq7e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:18:48 INFO - Running setup.py (path:/tmp/pip-8LxDGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:18:48 INFO - Running setup.py (path:/tmp/pip-z7k2PH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:18:48 INFO - Running setup.py (path:/tmp/pip-jg0H_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:48 INFO - Running setup.py (path:/tmp/pip-LYTSd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:49 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)) 16:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:18:49 INFO - Running setup.py (path:/tmp/pip-7rqG1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:18:49 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)) 16:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:18:49 INFO - Running setup.py (path:/tmp/pip-wo2XAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:18:49 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)) 16:18:49 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)) 16:18:49 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)) 16:18:49 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)) 16:18:49 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)) 16:18:49 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)) 16:18:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:18:49 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 16:18:49 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 16:18:49 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 16:18:49 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 16:18:49 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 16:18:49 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 16:18:51 INFO - Downloading blessings-1.6.tar.gz 16:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:18:51 INFO - Installing collected packages: blessings 16:18:51 INFO - Running setup.py install for blessings 16:18:51 INFO - Successfully installed blessings 16:18:51 INFO - Cleaning up... 16:18:51 INFO - Return code: 0 16:18:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:18:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:18:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:18:51 INFO - Reading from file tmpfile_stdout 16:18:51 INFO - Current package versions: 16:18:51 INFO - argparse == 1.2.1 16:18:51 INFO - blessings == 1.6 16:18:51 INFO - blobuploader == 1.2.4 16:18:51 INFO - docopt == 0.6.1 16:18:51 INFO - functools32 == 3.2.3-2 16:18:51 INFO - jsonschema == 2.5.1 16:18:51 INFO - manifestparser == 1.1 16:18:51 INFO - mozInstall == 1.12 16:18:51 INFO - mozcrash == 1.0 16:18:51 INFO - mozdebug == 0.1 16:18:51 INFO - mozdevice == 0.48 16:18:51 INFO - mozfile == 1.2 16:18:51 INFO - mozhttpd == 0.7 16:18:51 INFO - mozinfo == 0.9 16:18:51 INFO - mozleak == 0.1 16:18:51 INFO - mozlog == 3.4 16:18:51 INFO - moznetwork == 0.27 16:18:51 INFO - mozprocess == 0.23 16:18:51 INFO - mozprofile == 0.28 16:18:51 INFO - mozrunner == 6.13 16:18:51 INFO - mozscreenshot == 0.1 16:18:51 INFO - mozsystemmonitor == 0.3 16:18:51 INFO - moztest == 0.7 16:18:51 INFO - mozversion == 1.4 16:18:51 INFO - psutil == 3.1.1 16:18:51 INFO - requests == 1.2.3 16:18:51 INFO - wsgiref == 0.1.2 16:18:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:18:51 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')]} 16:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:51 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')]} 16:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:51 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 0x7f9a1d2d0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5fc0>, '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 0x1ee6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee7350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', '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 16:18:51 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 16:18:51 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 16:18:51 INFO - Using env: {'DISPLAY': ':0', 16:18:51 INFO - 'HOME': '/home/cltbld', 16:18:51 INFO - 'LANG': 'en_US.UTF-8', 16:18:51 INFO - 'LANGUAGE': 'en_US:en', 16:18:51 INFO - 'LOGNAME': 'cltbld', 16:18:51 INFO - 'MAIL': '/var/mail/cltbld', 16:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:51 INFO - 'MOZ_NO_REMOTE': '1', 16:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:51 INFO - 'NO_EM_RESTART': '1', 16:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:51 INFO - 'PWD': '/builds/slave/test', 16:18:51 INFO - 'SHELL': '/bin/bash', 16:18:51 INFO - 'SHLVL': '1', 16:18:51 INFO - 'TERM': 'linux', 16:18:51 INFO - 'TMOUT': '86400', 16:18:51 INFO - 'USER': 'cltbld', 16:18:51 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', 16:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:51 INFO - '_': '/tools/buildbot/bin/python'} 16:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:51 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)) 16:18:51 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)) 16:18:51 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)) 16:18:51 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)) 16:18:51 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)) 16:18:51 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)) 16:18:51 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)) 16:18:51 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)) 16:18:51 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)) 16:18:51 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)) 16:18:51 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)) 16:18:51 INFO - Cleaning up... 16:18:51 INFO - Return code: 0 16:18:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:18:51 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')]} 16:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:51 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')]} 16:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:51 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 0x7f9a1d2d0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e57130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5fc0>, '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 0x1ee6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee7350>, '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': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', '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 16:18:51 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 16:18:51 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 16:18:51 INFO - Using env: {'DISPLAY': ':0', 16:18:51 INFO - 'HOME': '/home/cltbld', 16:18:51 INFO - 'LANG': 'en_US.UTF-8', 16:18:51 INFO - 'LANGUAGE': 'en_US:en', 16:18:51 INFO - 'LOGNAME': 'cltbld', 16:18:51 INFO - 'MAIL': '/var/mail/cltbld', 16:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:51 INFO - 'MOZ_NO_REMOTE': '1', 16:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:51 INFO - 'NO_EM_RESTART': '1', 16:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:51 INFO - 'PWD': '/builds/slave/test', 16:18:51 INFO - 'SHELL': '/bin/bash', 16:18:51 INFO - 'SHLVL': '1', 16:18:51 INFO - 'TERM': 'linux', 16:18:51 INFO - 'TMOUT': '86400', 16:18:51 INFO - 'USER': 'cltbld', 16:18:51 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', 16:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:51 INFO - '_': '/tools/buildbot/bin/python'} 16:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:18:52 INFO - Cleaning up... 16:18:52 INFO - Return code: 0 16:18:52 INFO - Running post-action listener: _resource_record_post_action 16:18:52 INFO - Running post-action listener: _start_resource_monitoring 16:18:52 INFO - Starting resource monitoring. 16:18:52 INFO - [mozharness: 2016-11-17 00:18:52.078317Z] Finished create-virtualenv step (success) 16:18:52 INFO - [mozharness: 2016-11-17 00:18:52.078825Z] Running install step. 16:18:52 INFO - Running pre-action listener: _resource_record_pre_action 16:18:52 INFO - Running main action method: install 16:18:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:18:52 INFO - Reading from file tmpfile_stdout 16:18:52 INFO - Detecting whether we're running mozinstall >=1.0... 16:18:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:18:52 INFO - Reading from file tmpfile_stdout 16:18:52 INFO - Output received: 16:18:52 INFO - Usage: mozinstall [options] installer 16:18:52 INFO - Options: 16:18:52 INFO - -h, --help show this help message and exit 16:18:52 INFO - -d DEST, --destination=DEST 16:18:52 INFO - Directory to install application into. [default: 16:18:52 INFO - "/builds/slave/test"] 16:18:52 INFO - --app=APP Application being installed. [default: firefox] 16:18:52 INFO - mkdir: /builds/slave/test/build/application 16:18:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:19:08 INFO - Reading from file tmpfile_stdout 16:19:08 INFO - Output received: 16:19:08 INFO - /builds/slave/test/build/application/firefox/firefox 16:19:08 INFO - Running post-action listener: _resource_record_post_action 16:19:08 INFO - [mozharness: 2016-11-17 00:19:08.430228Z] Finished install step (success) 16:19:08 INFO - [mozharness: 2016-11-17 00:19:08.430481Z] Running run-tests step. 16:19:08 INFO - Running pre-action listener: _resource_record_pre_action 16:19:08 INFO - Running main action method: run_tests 16:19:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:19:08 INFO - Python 2.7.3 16:19:08 INFO - Return code: 0 16:19:08 INFO - grabbing minidump binary from tooltool 16:19:08 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')]} 16:19:08 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 0x1ee5fc0>, '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 0x1ee6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee7350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:19:08 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 16:19:08 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 16:19:08 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 16:19:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:19:08 INFO - Return code: 0 16:19:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:19:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:19:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:19:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:19:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:19:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:19:08 INFO - Using env: {'DISPLAY': ':0', 16:19:08 INFO - 'HOME': '/home/cltbld', 16:19:08 INFO - 'LANG': 'en_US.UTF-8', 16:19:08 INFO - 'LANGUAGE': 'en_US:en', 16:19:08 INFO - 'LOGNAME': 'cltbld', 16:19:08 INFO - 'MAIL': '/var/mail/cltbld', 16:19:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:19:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:08 INFO - 'MOZ_NO_REMOTE': '1', 16:19:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:08 INFO - 'NO_EM_RESTART': '1', 16:19:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:08 INFO - 'PWD': '/builds/slave/test', 16:19:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:19:08 INFO - 'SHELL': '/bin/bash', 16:19:08 INFO - 'SHLVL': '1', 16:19:08 INFO - 'TERM': 'linux', 16:19:08 INFO - 'TMOUT': '86400', 16:19:08 INFO - 'USER': 'cltbld', 16:19:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371', 16:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:08 INFO - '_': '/tools/buildbot/bin/python'} 16:19:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:19:08 INFO - mozversion application_buildid: 20161116150023 16:19:08 INFO - mozversion application_changeset: 044f8226032fd9084d5fe617ac3b0b0ec6ac783d 16:19:08 INFO - mozversion application_display_name: Nightly 16:19:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:19:08 INFO - mozversion application_name: Firefox 16:19:08 INFO - mozversion application_remotingname: firefox 16:19:08 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 16:19:08 INFO - mozversion application_vendor: Mozilla 16:19:08 INFO - mozversion application_version: 53.0a1 16:19:08 INFO - mozversion platform_buildid: 20161116150023 16:19:08 INFO - mozversion platform_changeset: 044f8226032fd9084d5fe617ac3b0b0ec6ac783d 16:19:08 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 16:19:08 INFO - mozversion platform_version: 53.0a1 16:19:08 INFO - using testdate: 1479341948 16:19:08 INFO - actual date: 1479341948 16:19:08 INFO - starting webserver on 'localhost:43959' 16:19:08 INFO - SUITE-START | Running 2 tests 16:19:08 INFO - TEST-START | dromaeo_css 16:19:08 INFO - operating with platform_type : linux_ 16:19:08 INFO - Initialising browser for dromaeo_css test... 16:19:08 INFO - TEST-INFO | started process 11925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_MVMoT/profile http://localhost:43959/getInfo.html) 16:19:13 INFO - PROCESS | 11925 | __metrics Screen width/height:1600/1200 16:19:13 INFO - PROCESS | 11925 | colorDepth:24 16:19:13 INFO - PROCESS | 11925 | Browser inner width/height: 1024/697 16:19:13 INFO - PROCESS | 11925 | __metrics 16:19:13 ERROR - PROCESS | 11925 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 16:19:14 INFO - TEST-INFO | 11925: exit 0 16:19:14 INFO - Browser initialized. 16:19:14 INFO - Running cycle 1/1 for dromaeo_css test... 16:19:14 INFO - TEST-INFO | started process 12050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_MVMoT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:19:27 INFO - PROCESS | 12050 | RSS: Main: 187293696 16:19:27 INFO - PROCESS | 12050 | 16:20:16 INFO - PROCESS | 12050 | 1479342016646 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] 16:22:31 INFO - PROCESS | 12050 | Cycle 1(1): loaded http://localhost:43959/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43959/tests/dromaeo/cssquery-ext.html) 16:22:33 INFO - PROCESS | 12050 | RSS: Main: 196685824 16:22:33 INFO - PROCESS | 12050 | 16:25:35 INFO - PROCESS | 12050 | Cycle 1(1): loaded http://localhost:43959/tests/dromaeo/cssquery-ext.html (next: http://localhost:43959/tests/dromaeo/cssquery-jquery.html) 16:25:36 INFO - PROCESS | 12050 | RSS: Main: 197459968 16:25:36 INFO - PROCESS | 12050 | 16:28:38 INFO - PROCESS | 12050 | Cycle 1(1): loaded http://localhost:43959/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43959/tests/dromaeo/cssquery-mootools.html) 16:28:39 INFO - PROCESS | 12050 | RSS: Main: 198823936 16:28:39 INFO - PROCESS | 12050 | 16:31:41 INFO - PROCESS | 12050 | Cycle 1(1): loaded http://localhost:43959/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43959/tests/dromaeo/cssquery-prototype.html) 16:31:41 INFO - PROCESS | 12050 | RSS: Main: 195846144 16:31:41 INFO - PROCESS | 12050 | 16:34:44 INFO - PROCESS | 12050 | Cycle 1(1): loaded http://localhost:43959/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43959/tests/dromaeo/cssquery-yui.html) 16:34:45 INFO - PROCESS | 12050 | RSS: Main: 198635520 16:34:45 INFO - PROCESS | 12050 | 16:37:48 INFO - PROCESS | 12050 | Cycle 1(1): loaded http://localhost:43959/tests/dromaeo/cssquery-yui.html (next: http://localhost:43959/tests/dromaeo/cssquery-dojo.html) 16:37:48 INFO - PROCESS | 12050 | RSS: Main: 198610944 16:37:48 INFO - PROCESS | 12050 | 16:37:48 INFO - PROCESS | 12050 | __start_tp_report 16:37:48 INFO - PROCESS | 12050 | _x_x_mozilla_page_load 16:37:48 INFO - PROCESS | 12050 | _x_x_mozilla_page_load_details 16:37:48 INFO - PROCESS | 12050 | |i|pagename|runs| 16:37:48 INFO - PROCESS | 12050 | |0;dojo.html;2609.3476630842288;2620.7510286522784;2623.449075694104;2660.5610074337737;2662.5606774882144;4634.096351211515;4735.437305689123;4737;4804.087223427547;4805.111054454928;4673.672842900998;4754.9762251188695;4801.303810947411;4824.7587620618915;4887.437944636368;4365.301551751721;4418.403515525411;4450.57719516647;4502.842400515982;4561.1105834362315;4067.3492241241406;4508.481524624661;4510.391097201868;4527.773611319437;4529.388532548113;4248.107897341562;4463.308187230952;4466.70966387187;4508.323751437294;4567.840125595605;4292.227399068166;4332.9566704332865;4349.782510874444;4380.408644832939;4398.912021759547;4309.439772829513;4310.202612516695;4373.125374924996;4388.868333949987;4420.160169567804;4771.761411929424;4784;4785.68893021956;4818.156822556074;4868.610511159099;5086.211637196204;5128.666636668605;5168.578640873752;5171.689698618057;5178.896422071537;5190.039842629126;5201.401838788512;5207.557357624606;5207.843764687065;5224.242484839715;4582.083583283356;4620.607248383925;4848.200046992207;4857.417109946794;4862.80548778052;5109.131447653834;5116.590672746172;5122.743862806845;5123.538881500683;5139.640225184276;4905.607551395879;4907.1657818171;4922.089413458521;4929.75351232437;5004.574611158019;4892.975535122373;5105.7191854448365;5126.846194614168;5165.974170129125;5173.456787037382;4931.9753401232765;4994.625403094782;5001.749912504433;5008.874778130503;5009.148444764399;5085.338905942203;5105.463926287761;5143.099957507421;5148.382194136728;5200.141976573898;4367.62875155609;4377.233984052778;4378.890527736832;4380.474343078851;4405.581469760367;3662.029562166028;3703.518542589446;3761.8495260189834;3772.603876592973;3868.535775706877;4481.3726078349055;4484.05834774701;4512.187806194916;4516.1419330327135;4532.6827122101795;5250.684958902401;5254.92117618236;5255.553277971415;5259.552938000236;5269.604779641542;4211.515675697273;4255.616994470451;4278.7860606969525;4311.935320970125;4494.887627809266;4514.864554063383;4527.683062185682;4545.795439205243;4582.5417458253905;4590.839320623762;4788.066327066328;4803.855884323476;4817.614590832655;4841.1285968526;4874.463808981081;5132.5124113209185;5153.3558305211845;5190.844274671766;5193.636445448782;5201.453847345974;4702.506236845082;4711.034237981137;4741.146593613044;4824.34871292371;4871.561559459524;5026.095302845523;5042.697438153723;5076.137056700443;5079.187330027178;5082.059818933509;5150.510701483353;5167.095758242217;5167.22491626259;5216.165413533817;5248.186531087687;5005.924911126409;5026;5040.798368065236;5050.77271522775;5089.618278629192;4861.076395484846;4866.148424025852;4880.097182021195;4999.850004499871;5058.114829904678;4751.358566593604;4854.75726213695;4882.048000639841;4925.433575138905;4973.030259099441;5051.722155281494;5092.287079808756;5112.258722485293;5112.590992720499;5125.051865404912;4688.249880019181;4947.554720075211;4955.752212389438;4991.261796574595;5014.774335154853 16:37:48 INFO - PROCESS | 12050 | |1;ext.html;543.5325619966828;543.9020976224278;552.5579536370902;552.8009916430085;564.4750382144606;37880;39712.60287397125;39958;44267.55732442674;44428.11143777122;39828;40041.59958400415;40379.59620403795;40504.39243411344;40506.79746601263;7632.771016869489;7670.1562828089145;7713.8071548211465;7727.111382191036;7731.922680773205;7584.734534291301;7686.385089192879;7687.807804804868;7690.500117492345;7704.8844267336035;7670.463067585271;7688.461807673465;7722.536647801122;7735.767926962172;7797.532148071105;7696.345810606105;7747.690092396298;7748.845023099563;7753.302202801775;7754.340881025091;7601.3538849197885;7637.465377423582;7639.618019099023;7646.617669116522;7695.038120234971;37584;37777.81111094427;37842.24315513702;37847.62152378496;37863.24273514514;3006.5941097951713;3055.618047744032;3126.421612001787;3201.2477067889026;3315.1049216711594;27146.728532714616;27698.307542311402;27723.722762772315;27823.721762782316;27941.720582794114;3420.2133509292753;3443.3974054540604;3625.3836847735683;3637.9818100909324;3667.908302292464;255213;257641;258304;258713;260024.6998765013;52100.739496302274;52128.47871521312;52227.47772522226;52305;52371;53929.46070539323;54060.16127661467;54478.182827257624;54499.45500545023;54521.1821822673;14410.495632652806;14576.489822856149;14667.926660366844;14705.705885882222;14706.264686765619;11306.265092768943;11393.886061139448;11429.771404571862;11432;11441.199116061962;13754.793678094837;15457.304421301069;15548.611284717972;15780.210989450481;15806.36774529029;3005.669376368641;5968.253968253968;6344.714487848058;6389.3291204423795;6403.519736019817;724.7823656257433;825.2943733108106;827.9254867061993;832.6710949175042;862.1895418306772;27490;27759.167224983285;27905.16284511427;28192.577111343347;28349;868.1708967935606;887.6671248281895;945.3807755919884;1016.4511163971521;1034.9546957572907;13299.335033248299;14371.694145734758;14508.347124379428;14527.418903243752;14777.704445911022;409450;619460;635018;637443;638263;48183;48797.26804097941;48893;48933;48946.75526622344;1179.1627944159743;1187.7921363761307;1197.2816310213975;1199.9820002699967;1224.9816252756216;27007.1897843065;27777;28714;28934.42131157407;29032.12903612895;41382.172356552095;41630.37554436747;41734.58265417307;41785.37321940234;41820.372694409;342073;344263;344978;347033;347139;25037.248882533553;25168.24495265145;25420;25420.110296139548;25431.74568254368;39991.60008399879;40019.599804002755;40669;40760.79619601883;40981.1803763929;32688.2278651612;33096.83451582823;33982.83008584941;35497.46753798747;35928.46107308445;34644.82677586596;34959.475607865395;35408.46887296641;35613;36467.27065458729;34029.82985085059;34202.48696269608;34392.65607343894;34715.47926781151;35112.47331290084;28968.130956071353;31195.688043119277;31640.208994775316;31747.682523175397;31931;24174.637380438955;24784.876075619508;24799.256022319358;24865.254042378758;25128.49743005093 16:37:48 INFO - PROCESS | 12050 | |2;jquery.html;328.8027183689785;342.69671340863334;347.5586005772669;349.74643383546925;364.95804478214677;15702.97930634508;17036.744448833262;17485.213165407557;17601;17668.64662706745;16602.25289861956;16743.330266789344;16860.83139168608;17231.22459489323;17518.824811751878;4885.706857588547;5073.213651883964;5091.872703182432;5115.616328775338;5117.1556693145585;3641.563012438511;5006.54941055305;5044.520770526812;5071.98560287942;5077.847664570068;5217.947820521803;5858.150568167634;5895.528357731371;5989.790357337494;6000.2199714037115;5780.433382751553;5932.228810254683;5961.612495187799;5977.850553736148;5990.400959904018;5162.741862906877;5170.095233334151;5173.224016397533;5182.481751824825;5186.0665080285535;19540.804591954042;20295.5940881183;20349.796502034937;20395;20489.590208195754;1816.527702797269;1889.9055047247582;1989.6020795840745;2023.423324352567;2468.605023196298;12754.681132971657;12952.676183095404;13118.278494682789;13154.079214454992;13689.589312320646;1668.6329007618303;1690.3069741405964;1700.1669182100804;1734.6010417604023;1792.3436190172163;64254.35745642531;64761.67619161874;65101;65104.3489565103;65166.348336516974;8872.822543549222;9137.451752894714;9443.480608566457;9480.620775169054;9524.666636667684;12448.190867593577;12448.75102497963;12473.313967731681;12487.438065287084;12502.187357821895;7105.786826395217;7275.636218189069;7306.671199796022;7464.440166987498;7468.775936721907;6924.099867017256;7070.540414873017;7078.787636370917;7298.70805167798;7312.818923768178;5821.417858214229;5833.154192642128;5855.853603659943;5907.586468947133;5954.285485741739;1668.1409074326732;1691.6024734187456;1695.779039091852;1696.575856035991;1724.3275122702157;664.577992974455;792.0574516325554;825.7729124490693;830.1822704635929;832.1137988042836;15861.286242119133;16019.359225630844;16070.839291607168;16204.75692864608;16578.6684266314;838.1827717974926;878.8681697745261;880.8942926848691;886.0209468537303;902.9142680408278;9322.48726320059;9501.714948551555;9643.517824108767;9875.358101723365;10006.349587276804;347230;348135;353841;357997;358561;65319.34680653133;65348.34651653517;65987.67006164939;66673;67182;899.9865002025106;939.8214339275515;950.3347656640241;964.1081999150757;964.1611797735875;13963.930180349033;14861.479848205261;14889.255537223313;15058.623534411727;15416.306266217824;37656.2468750618;38286.61713382942;38444;38644.420333694456;39164.80417597894;49308.75345623249;49835;50104.248436272755;50246.246306306166;50402.747986259834;7003.789886303419;7124;7131.2512186221775;7443.776686699408;7475.289847464483;9637.903620963982;11302.773944521228;11455.369954652575;11754.647360579196;11859;9671.226301895691;9830;9870.457124858201;10273.74315642115;10597.417142056953;9146.63413463454;9650.662226822027;9748.02519748048;10030.29787914839;10318.277720559488;9861.506924653882;10110.292279540656;10229.386236825814;10256.435896025492;10581.259311848406;7314.597697126496;7331.670074846538;7334.339909408179;7639.847203055797;7785.299323060952;8057.798555036171;9747.463889486145;10027.097561219525;10125.088742013255;10574.544945813337 16:37:48 INFO - PROCESS | 12050 | |3;mootools.html;1299.9285039322833;1342.449595665777;1366.1598117157944;1567.169400217885;1571.948607067776;5807.245058142446;5984.820455386345;6152.538559608025;6560.606363618181;6624.403803657676;6031.517478601712;6276.623402595847;6278.748850045993;6323.715432805523;6473.741050357992;1965.1844484538935;2016.1935225909606;2026.9695954560693;2030.9390718278476;2054.1885955047824;2012.4968757810548;2044.1414605865573;2054.753429588444;2058.4853786553363;2062.288510463895;1985.9503512412234;1990.3033938121687;1997.7902320256383;2010.2260629657615;2021.9797802021938;1946.2312386607352;1953.238237087537;1967.8228959393723;1968.8326492248177;1972.5265936175358;1962.3524237001754;1963.803619638039;1977.851661125407;1995.042379657758;2011.5675129847152;6351.4283714465455;6425.068365087036;6426.1003459515705;6429.260635026938;6451.1936007999;3963.2165525513346;3984.063745019947;4061.715679902408;4104.548499665035;4128.236276288896;2767.4603452326805;2859.170840456286;2862.942741145186;2871.0812539987214;2878.309205790616;835.7450977451874;917.1974522292994;940.7224868663692;942.1285311087217;949.6676163342844;8138.104808471064;8287.254147126727;8315.210055044701;8322.417430779848;8331.750047498585;3529.9190529389416;3590.856365745341;3628.8911332660064;3661.4324779659196;3672.8347224374966;7222.277772222736;7225.169105552824;7257.49197556166;7263.92736072643;7265.709371625181;4105.753654780723;4112.444819949268;4112.712110152261;4120.855770048034;4129.463169787909;3357.7145942595153;3464.2032332563654;3655.4882316475714;3668.0646435158865;3744.2698673758355;3073.8924137655076;3171.6669749675953;3220.4525230710838;3222.2910959588853;3266.510023496447;1054.7218009100307;1079.3146352066494;1091.683411810566;1093.3822390349428;1095.1950316517352;662.595816551903;801.0747586537558;804.5816175588661;831.1439217605875;832.3050253038781;4439.156560253541;4559.361689363492;4567.177907976529;4644.117617652635;4657.813687452532;776.3711393771064;802.7150361621657;830.3689196210803;839.5550358310105;878.4553576782436;3030.22729204056;3078.2766049978236;3147.6065491813524;3160.604924384452;3296.175956010997;7143.6428178591905;7546.773596792105;7554.508956917893;7566.092068951651;7569.810754731176;7460;7472;7514.812129696692;7539.246075392417;7551.697932082765;5993.730282137314;6042.728077236535;6125.540584456184;6132.141500189977;6141.109539116893;4391.253486907297;4399.208142534375;4406.294992801137;4498.662600305056;4501.482329532146;6922.06552115458;6984.428483805179;7061.752838650828;7079.752208672672;7128.572285662877;6619.271880093283;7068.11648543932;7089.929100708927;7127.643617818984;7128.893066603901;4848.0546293472435;5380.892382152257;5651.406602306699;5652.68910209926;5671;5359.598030147677;5817.825465236049;5823.242978412779;5908.615939963888;6002.309734380602;5449.782008719607;5471.781128754806;5491.203775452617;5512.724363781715;5518.310211223597;5349.732513374238;5373.408925018323;5382.838514844561;5417.729113544386;5450.2369668247275;5201.1678131498775;5253.369595648393;5257.369115706139;5272.314599102092;5276.683398996072;3981.601839816111;4043.353063509824;4065.2072845794787;4121.010957370149;4159.188958153252;3850.7304488685522;3924.2543916655745;3954.8615798446917;3989.740666856645;4002.0995276062654 16:37:48 INFO - PROCESS | 12050 | |4;prototype.html;268.97175796541353;280.8595702148925;284.124895322407;286.8967171818145;287.65912393813335;4836.775083461603;4895.2412376081675;4988.952320012797;5103.336566246392;5105.617078719097;4739.289106634006;4868.829590964317;4905.803767849282;4915.729634870081;4924.359833221685;3824.330742120118;3827.5215598050245;3833.731638785286;3853.206425341619;3858.151206734528;3586.852207293667;3835.539735231776;3858.84564617415;3859.421086836983;3863.4784304119007;3736.8602576214244;3752.5684546277253;3757.0795155187016;3757.3424650686156;3778.2997651057;3731.440283957401;3734.775913445202;3742.288965096623;3745.400735882246;3749.268892565951;3282.113829266085;3282.6224984126893;3284.5237440571223;3291.835408229579;3301.125201821519;4640.211164102077;4729.337892695025;4737.50256223095;4802.478698683184;4874.926876096826;4262.062346283813;4268.786560671954;4275;4285.46431696038;4300.8709738707885;5140.948590514085;5147.48525147486;5155.869909440094;5159.535641792219;5169.707573106723;3434.347473979961;3517.6658217469553;3530.541029666127;3536.929261414783;3565.8038807865555;5363.892722145574;5377.7580008899695;5389.730513474311;5401.351837779492;5402.702851343214;3605.7475976681903;3620.420732682758;3633.3823250047553;3640.635936406391;3658.4146536554554;3670.2292518570866;3681.1349332906743;3695.4456831475495;3719.4048952167523;3734.421164719473;4008.4187792769885;4211.347241177622;4254.723442976258;4289.6139347458875;4300.870973870727;5131.820386286462;5149.867029253558;5168.431472538018;5202.320804785539;5211.400688920747;1236.6104677026708;1262.3463263125336;1277.7061275906594;1285.6721536008258;1286.1961274203622;850.8851305073736;871.4030888841037;890.1765866573394;901.4320977784085;903.5527413930015;4302.591253830881;4319.416878721332;4341.34879768031;4378.321360189176;4404.823807047682;5131.974340128276;5138.97430512845;5142.61430392722;5145.099607568661;5153.561947234452;4315.942594064474;4323.718958267703;4325.199838029975;4361.825526978949;4392.934105988413;2585.75435333643;2696.21809675192;2698.6896506901567;2725.6047873058296;2729.9044533441233;4754.904901901942;4765.523447655276;4774.1883879739835;4789.544993225638;4809.9038019240115;5028.083711447425;5196.8960620787375;5201.687898726089;5225.681692125528;5278.5513231375;4785.880352991203;4816.975915120402;4820.758962051884;4825.563090639204;4846.636502262344;5043.87390315245;5097.311862898461;5104.958016793313;5105.625883963975;5117.724656220096;4790.688605240648;4893.6085113191575;4955.950440495549;4959.429665588359;5005.724685142352;4794.304825800309;4799.520047995173;4805.831795887128;4806.615470762401;4808.567228949411;3665.743397962117;3666.175110600094;3672.2288319453214;3675.4670572766263;3678.6505281998166;5103.106956282561;5112.182050871843;5140.4088529818055;5169.560587350117;5182.24857395683;4693.671442998957;5141.663167576532;5194.948050519598;5204.609654276021;5208.088584497774;5171.586273098068;5179.611529135254;5194.948050519446;5196.272521846869;5209.322788037683;4792.424909010941;4984.75076246179;5012.215777088275;5038.722870242025;5054;5190.065788158167;5201.479852014768;5202.245674377118;5218.608604354765;5219.76511057011;5067.277125777254;5075.644704870623;5116.897662046813;5127.435982042047;5129.9743501282255 16:37:48 INFO - PROCESS | 12050 | |5;yui.html;627.4165026525332;660.8171373241897;664.8138521214062;711.3313485323794;712.3944647050012;11823.881761182385;12454.81317780234;12778.744425111503;12783.872161278385;12804.807927881066;12049.397530123502;12245.32650704211;12277;12327.383630818467;12358.382080895964;614.6097228260064;628.0171531553104;742.3801126059733;760.5930827007552;761.9542827430372;737.1375490675895;751.3801114080878;753.8643044252033;757.7234309477029;759.6733404636004;798.9680412783482;801.6913488306985;802.5345299726174;802.7631848604676;804.5012092502627;795.9562224077703;796.1242633103569;796.9123396426388;797.3860127701637;806;582.1820342418908;582.7581553655228;582.8193260089386;585.4584509328896;586.7652938824505;11911.702207444796;12476.251424914533;12498.937505312506;12511.624651260478;12530.624081277485;12319.69200769979;12469.438875250635;12701.93649031749;12807.359632018362;13029.869701303056;9203.76990575241;9330.206932410752;9339.579718912666;9448.622055117787;9769.023097690246;3117.345357474933;3164.9683503164906;3178.2213357727505;3184.2994541200896;3220.9677903220904;49339.25991110136;49734.7513262435;50691;51108;52119.47880521184;9584.472853993097;9763.658271960447;9840.753981150385;9848.458334791512;10222.539985700512;16432.83567164313;16541;16597.41909033178;16611.335546578244;16612;6223.408776166257;6444.097826304321;6460.741570337228;6495.512836537278;6689.297623749533;3272.640009598942;3282.0482060202753;3311.3211791582667;3320.5849268841393;3430.091025878144;2616.4897844920056;2675.8126931114634;2693.259353677715;2695.784337253015;2702.7567518923393;501.0955225817362;512.9512696293921;518.1062666899568;522.1671434062664;523.0819911056072;563.9577031722637;585.5140233606097;596.5645079092287;597.2325561653255;604.3412680178626;7788.727394541163;7808;7844.843103137905;7944.815175826694;7978.760637180894;555.7138073891949;559.636236446305;574.6207503047968;575.7955925646419;577.789953428139;3660.4875317455576;3836.827342769582;3892.143728379752;3906.7851268180525;3906.8437262509183;67715.66142169356;69603;70610.29389706037;71034;71903.64048179725;61657.38342616606;62009.68995154995;62951.37048629547;63944.680276598316;65140.34859651438;55933.72033139808;56126.43873561294;57131;57366;59747.70126149429;7404.296591823768;7456.47804653669;7550.811229719081;7594.126675432396;7637.198094200029;37984.81007594944;38571.421428679154;39649.801750992214;40242.59757402389;40818;46673.766631166625;47244.527554724016;50529.49470505248;53582;54412.45587544232;8601.924759405074;8811.251043661361;9104.863427048733;9247.39891907024;9327.860082098638;9516.429014259167;10592.417417041828;11583.189176757545;11808.645740627795;11831.349275789915;10335;10877.619283325046;11071.225014248925;11220.382878941737;11344.20590558686;10675.412852293199;10693.679189624323;10870;11316.49075791575;12400.13199076056;9752.122308992224;9952.502374881082;10281.9485902573;10284.742881428025;10564.154867610727;9205.907940920504;9214.631414743335;9296.39573427725;9606.951965240129;9834.360766550151;8955.328350373878;9341.719748407559;9407.576659050223;9447.716568502956;9457.799438724243 16:37:48 INFO - PROCESS | 12050 | __end_tp_report 16:37:48 INFO - PROCESS | 12050 | __start_cc_report 16:37:48 INFO - PROCESS | 12050 | _x_x_mozilla_cycle_collect,353 16:37:48 INFO - PROCESS | 12050 | __end_cc_report 16:37:48 INFO - PROCESS | 12050 | __startTimestamp1479343068741__endTimestamp 16:37:48 INFO - PROCESS | 12050 | 16:37:48 INFO - PROCESS | 12050 | ------- Summary: start ------- 16:37:48 INFO - PROCESS | 12050 | Number of tests: 6 16:37:48 INFO - PROCESS | 12050 | 16:37:48 INFO - PROCESS | 12050 | [#0] dojo.html Cycles:165 Average:4729.06 Median:4857.42 stddev:509.03 (10.5%) stddev-sans-first:482.67 16:37:48 INFO - PROCESS | 12050 | Values: 2609.3 2620.8 2623.4 2660.6 2662.6 4634.1 4735.4 4737.0 4804.1 4805.1 4673.7 4755.0 4801.3 4824.8 4887.4 4365.3 4418.4 4450.6 4502.8 4561.1 4067.3 4508.5 4510.4 4527.8 4529.4 4248.1 4463.3 4466.7 4508.3 4567.8 4292.2 4333.0 4349.8 4380.4 4398.9 4309.4 4310.2 4373.1 4388.9 4420.2 4771.8 4784.0 4785.7 4818.2 4868.6 5086.2 5128.7 5168.6 5171.7 5178.9 5190.0 5201.4 5207.6 5207.8 5224.2 4582.1 4620.6 4848.2 4857.4 4862.8 5109.1 5116.6 5122.7 5123.5 5139.6 4905.6 4907.2 4922.1 4929.8 5004.6 4893.0 5105.7 5126.8 5166.0 5173.5 4932.0 4994.6 5001.7 5008.9 5009.1 5085.3 5105.5 5143.1 5148.4 5200.1 4367.6 4377.2 4378.9 4380.5 4405.6 3662.0 3703.5 3761.8 3772.6 3868.5 4481.4 4484.1 4512.2 4516.1 4532.7 5250.7 5254.9 5255.6 5259.6 5269.6 4211.5 4255.6 4278.8 4311.9 4494.9 4514.9 4527.7 4545.8 4582.5 4590.8 4788.1 4803.9 4817.6 4841.1 4874.5 5132.5 5153.4 5190.8 5193.6 5201.5 4702.5 4711.0 4741.1 4824.3 4871.6 5026.1 5042.7 5076.1 5079.2 5082.1 5150.5 5167.1 5167.2 5216.2 5248.2 5005.9 5026.0 5040.8 5050.8 5089.6 4861.1 4866.1 4880.1 4999.9 5058.1 4751.4 4854.8 4882.0 4925.4 4973.0 5051.7 5092.3 5112.3 5112.6 5125.1 4688.2 4947.6 4955.8 4991.3 5014.8 16:37:48 INFO - PROCESS | 12050 | 16:37:48 INFO - PROCESS | 12050 | [#1] ext.html Cycles:180 Average:53522.13 Median:20052.63 stddev:113563.62 (566.3%) stddev-sans-first:113812.53 16:37:48 INFO - PROCESS | 12050 | Values: 543.5 543.9 552.6 552.8 564.5 37880.0 39712.6 39958.0 44267.6 44428.1 39828.0 40041.6 40379.6 40504.4 40506.8 7632.8 7670.2 7713.8 7727.1 7731.9 7584.7 7686.4 7687.8 7690.5 7704.9 7670.5 7688.5 7722.5 7735.8 7797.5 7696.3 7747.7 7748.8 7753.3 7754.3 7601.4 7637.5 7639.6 7646.6 7695.0 37584.0 37777.8 37842.2 37847.6 37863.2 3006.6 3055.6 3126.4 3201.2 3315.1 27146.7 27698.3 27723.7 27823.7 27941.7 3420.2 3443.4 3625.4 3638.0 3667.9 255213.0 257641.0 258304.0 258713.0 260024.7 52100.7 52128.5 52227.5 52305.0 52371.0 53929.5 54060.2 54478.2 54499.5 54521.2 14410.5 14576.5 14667.9 14705.7 14706.3 11306.3 11393.9 11429.8 11432.0 11441.2 13754.8 15457.3 15548.6 15780.2 15806.4 3005.7 5968.3 6344.7 6389.3 6403.5 724.8 825.3 827.9 832.7 862.2 27490.0 27759.2 27905.2 28192.6 28349.0 868.2 887.7 945.4 1016.5 1035.0 13299.3 14371.7 14508.3 14527.4 14777.7 409450.0 619460.0 635018.0 637443.0 638263.0 48183.0 48797.3 48893.0 48933.0 48946.8 1179.2 1187.8 1197.3 1200.0 1225.0 27007.2 27777.0 28714.0 28934.4 29032.1 41382.2 41630.4 41734.6 41785.4 41820.4 342073.0 344263.0 344978.0 347033.0 347139.0 25037.2 25168.2 25420.0 25420.1 25431.7 39991.6 40019.6 40669.0 40760.8 40981.2 32688.2 33096.8 33982.8 35497.5 35928.5 34644.8 34959.5 35408.5 35613.0 36467.3 34029.8 34202.5 34392.7 34715.5 35112.5 28968.1 31195.7 31640.2 31747.7 31931.0 24174.6 24784.9 24799.3 24865.3 25128.5 16:37:48 INFO - PROCESS | 12050 | 16:37:48 INFO - PROCESS | 12050 | [#2] jquery.html Cycles:180 Average:22875.88 Median:5072.60 stddev:58223.67 (1147.8%) stddev-sans-first:58362.39 16:37:48 INFO - PROCESS | 12050 | Values: 328.8 342.7 347.6 349.7 365.0 15703.0 17036.7 17485.2 17601.0 17668.6 16602.3 16743.3 16860.8 17231.2 17518.8 4885.7 5073.2 5091.9 5115.6 5117.2 3641.6 5006.5 5044.5 5072.0 5077.8 5217.9 5858.2 5895.5 5989.8 6000.2 5780.4 5932.2 5961.6 5977.9 5990.4 5162.7 5170.1 5173.2 5182.5 5186.1 19540.8 20295.6 20349.8 20395.0 20489.6 1816.5 1889.9 1989.6 2023.4 2468.6 12754.7 12952.7 13118.3 13154.1 13689.6 1668.6 1690.3 1700.2 1734.6 1792.3 64254.4 64761.7 65101.0 65104.3 65166.3 8872.8 9137.5 9443.5 9480.6 9524.7 12448.2 12448.8 12473.3 12487.4 12502.2 7105.8 7275.6 7306.7 7464.4 7468.8 6924.1 7070.5 7078.8 7298.7 7312.8 5821.4 5833.2 5855.9 5907.6 5954.3 1668.1 1691.6 1695.8 1696.6 1724.3 664.6 792.1 825.8 830.2 832.1 15861.3 16019.4 16070.8 16204.8 16578.7 838.2 878.9 880.9 886.0 902.9 9322.5 9501.7 9643.5 9875.4 10006.3 347230.0 348135.0 353841.0 357997.0 358561.0 65319.3 65348.3 65987.7 66673.0 67182.0 900.0 939.8 950.3 964.1 964.2 13963.9 14861.5 14889.3 15058.6 15416.3 37656.2 38286.6 38444.0 38644.4 39164.8 49308.8 49835.0 50104.2 50246.2 50402.7 7003.8 7124.0 7131.3 7443.8 7475.3 9637.9 11302.8 11455.4 11754.6 11859.0 9671.2 9830.0 9870.5 10273.7 10597.4 9146.6 9650.7 9748.0 10030.3 10318.3 9861.5 10110.3 10229.4 10256.4 10581.3 7314.6 7331.7 7334.3 7639.8 7785.3 8057.8 9747.5 10027.1 10125.1 10574.5 16:37:48 INFO - PROCESS | 12050 | 16:37:48 INFO - PROCESS | 12050 | [#3] mootools.html Cycles:180 Average:4265.01 Median:5024.61 stddev:2174.61 (43.3%) stddev-sans-first:2169.29 16:37:48 INFO - PROCESS | 12050 | Values: 1299.9 1342.4 1366.2 1567.2 1571.9 5807.2 5984.8 6152.5 6560.6 6624.4 6031.5 6276.6 6278.7 6323.7 6473.7 1965.2 2016.2 2027.0 2030.9 2054.2 2012.5 2044.1 2054.8 2058.5 2062.3 1986.0 1990.3 1997.8 2010.2 2022.0 1946.2 1953.2 1967.8 1968.8 1972.5 1962.4 1963.8 1977.9 1995.0 2011.6 6351.4 6425.1 6426.1 6429.3 6451.2 3963.2 3984.1 4061.7 4104.5 4128.2 2767.5 2859.2 2862.9 2871.1 2878.3 835.7 917.2 940.7 942.1 949.7 8138.1 8287.3 8315.2 8322.4 8331.8 3529.9 3590.9 3628.9 3661.4 3672.8 7222.3 7225.2 7257.5 7263.9 7265.7 4105.8 4112.4 4112.7 4120.9 4129.5 3357.7 3464.2 3655.5 3668.1 3744.3 3073.9 3171.7 3220.5 3222.3 3266.5 1054.7 1079.3 1091.7 1093.4 1095.2 662.6 801.1 804.6 831.1 832.3 4439.2 4559.4 4567.2 4644.1 4657.8 776.4 802.7 830.4 839.6 878.5 3030.2 3078.3 3147.6 3160.6 3296.2 7143.6 7546.8 7554.5 7566.1 7569.8 7460.0 7472.0 7514.8 7539.2 7551.7 5993.7 6042.7 6125.5 6132.1 6141.1 4391.3 4399.2 4406.3 4498.7 4501.5 6922.1 6984.4 7061.8 7079.8 7128.6 6619.3 7068.1 7089.9 7127.6 7128.9 4848.1 5380.9 5651.4 5652.7 5671.0 5359.6 5817.8 5823.2 5908.6 6002.3 5449.8 5471.8 5491.2 5512.7 5518.3 5349.7 5373.4 5382.8 5417.7 5450.2 5201.2 5253.4 5257.4 5272.3 5276.7 3981.6 4043.4 4065.2 4121.0 4159.2 3850.7 3924.3 3954.9 3989.7 4002.1 16:37:48 INFO - PROCESS | 12050 | 16:37:48 INFO - PROCESS | 12050 | [#4] prototype.html Cycles:180 Average:4195.35 Median:4791.56 stddev:1230.87 (25.7%) stddev-sans-first:1198.52 16:37:48 INFO - PROCESS | 12050 | Values: 269.0 280.9 284.1 286.9 287.7 4836.8 4895.2 4989.0 5103.3 5105.6 4739.3 4868.8 4905.8 4915.7 4924.4 3824.3 3827.5 3833.7 3853.2 3858.2 3586.9 3835.5 3858.8 3859.4 3863.5 3736.9 3752.6 3757.1 3757.3 3778.3 3731.4 3734.8 3742.3 3745.4 3749.3 3282.1 3282.6 3284.5 3291.8 3301.1 4640.2 4729.3 4737.5 4802.5 4874.9 4262.1 4268.8 4275.0 4285.5 4300.9 5140.9 5147.5 5155.9 5159.5 5169.7 3434.3 3517.7 3530.5 3536.9 3565.8 5363.9 5377.8 5389.7 5401.4 5402.7 3605.7 3620.4 3633.4 3640.6 3658.4 3670.2 3681.1 3695.4 3719.4 3734.4 4008.4 4211.3 4254.7 4289.6 4300.9 5131.8 5149.9 5168.4 5202.3 5211.4 1236.6 1262.3 1277.7 1285.7 1286.2 850.9 871.4 890.2 901.4 903.6 4302.6 4319.4 4341.3 4378.3 4404.8 5132.0 5139.0 5142.6 5145.1 5153.6 4315.9 4323.7 4325.2 4361.8 4392.9 2585.8 2696.2 2698.7 2725.6 2729.9 4754.9 4765.5 4774.2 4789.5 4809.9 5028.1 5196.9 5201.7 5225.7 5278.6 4785.9 4817.0 4820.8 4825.6 4846.6 5043.9 5097.3 5105.0 5105.6 5117.7 4790.7 4893.6 4956.0 4959.4 5005.7 4794.3 4799.5 4805.8 4806.6 4808.6 3665.7 3666.2 3672.2 3675.5 3678.7 5103.1 5112.2 5140.4 5169.6 5182.2 4693.7 5141.7 5194.9 5204.6 5208.1 5171.6 5179.6 5194.9 5196.3 5209.3 4792.4 4984.8 5012.2 5038.7 5054.0 5190.1 5201.5 5202.2 5218.6 5219.8 5067.3 5075.6 5116.9 5127.4 5130.0 16:37:48 INFO - PROCESS | 12050 | 16:37:48 INFO - PROCESS | 12050 | [#5] yui.html Cycles:180 Average:14689.13 Median:575.21 stddev:19147.05 (3328.7%) stddev-sans-first:19171.65 16:37:48 INFO - PROCESS | 12050 | Values: 627.4 660.8 664.8 711.3 712.4 11823.9 12454.8 12778.7 12783.9 12804.8 12049.4 12245.3 12277.0 12327.4 12358.4 614.6 628.0 742.4 760.6 762.0 737.1 751.4 753.9 757.7 759.7 799.0 801.7 802.5 802.8 804.5 796.0 796.1 796.9 797.4 806.0 582.2 582.8 582.8 585.5 586.8 11911.7 12476.3 12498.9 12511.6 12530.6 12319.7 12469.4 12701.9 12807.4 13029.9 9203.8 9330.2 9339.6 9448.6 9769.0 3117.3 3165.0 3178.2 3184.3 3221.0 49339.3 49734.8 50691.0 51108.0 52119.5 9584.5 9763.7 9840.8 9848.5 10222.5 16432.8 16541.0 16597.4 16611.3 16612.0 6223.4 6444.1 6460.7 6495.5 6689.3 3272.6 3282.0 3311.3 3320.6 3430.1 2616.5 2675.8 2693.3 2695.8 2702.8 501.1 513.0 518.1 522.2 523.1 564.0 585.5 596.6 597.2 604.3 7788.7 7808.0 7844.8 7944.8 7978.8 555.7 559.6 574.6 575.8 577.8 3660.5 3836.8 3892.1 3906.8 3906.8 67715.7 69603.0 70610.3 71034.0 71903.6 61657.4 62009.7 62951.4 63944.7 65140.3 55933.7 56126.4 57131.0 57366.0 59747.7 7404.3 7456.5 7550.8 7594.1 7637.2 37984.8 38571.4 39649.8 40242.6 40818.0 46673.8 47244.5 50529.5 53582.0 54412.5 8601.9 8811.3 9104.9 9247.4 9327.9 9516.4 10592.4 11583.2 11808.6 11831.3 10335.0 10877.6 11071.2 11220.4 11344.2 10675.4 10693.7 10870.0 11316.5 12400.1 9752.1 9952.5 10281.9 10284.7 10564.2 9205.9 9214.6 9296.4 9607.0 9834.4 8955.3 9341.7 9407.6 9447.7 9457.8 16:37:48 INFO - PROCESS | 12050 | -------- Summary: end -------- 16:37:48 INFO - PROCESS | 12050 | 16:37:49 INFO - TEST-INFO | 12050: exit 0 16:37:49 INFO - TEST-OK | dromaeo_css | took 1121049ms 16:37:49 INFO - TEST-START | kraken 16:37:49 INFO - operating with platform_type : linux_ 16:37:49 INFO - Initialising browser for kraken test... 16:37:49 INFO - TEST-INFO | started process 12408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe59gO5/profile http://localhost:43959/getInfo.html) 16:37:54 INFO - PROCESS | 12408 | __metrics Screen width/height:1600/1200 16:37:54 INFO - PROCESS | 12408 | colorDepth:24 16:37:54 INFO - PROCESS | 12408 | Browser inner width/height: 1024/697 16:37:54 INFO - PROCESS | 12408 | __metrics 16:37:54 ERROR - PROCESS | 12408 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 16:37:55 INFO - TEST-INFO | 12408: exit 0 16:37:55 INFO - Browser initialized. 16:37:55 INFO - Running cycle 1/1 for kraken test... 16:37:55 INFO - TEST-INFO | started process 12531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe59gO5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:08 INFO - PROCESS | 12531 | RSS: Main: 187297792 16:38:08 INFO - PROCESS | 12531 | 16:38:11 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:43959/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43959/tests/kraken/driver.html?testName=audio-beat-detection) 16:38:12 INFO - PROCESS | 12531 | RSS: Main: 199667712 16:38:12 INFO - PROCESS | 12531 | 16:38:14 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:43959/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43959/tests/kraken/driver.html?testName=audio-dft) 16:38:15 INFO - PROCESS | 12531 | RSS: Main: 197738496 16:38:15 INFO - PROCESS | 12531 | 16:38:18 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:43959/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43959/tests/kraken/driver.html?testName=audio-fft) 16:38:19 INFO - PROCESS | 12531 | RSS: Main: 194215936 16:38:19 INFO - PROCESS | 12531 | 16:38:21 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:43959/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43959/tests/kraken/driver.html?testName=audio-oscillator) 16:38:21 INFO - PROCESS | 12531 | RSS: Main: 194478080 16:38:21 INFO - PROCESS | 12531 | 16:38:24 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:43959/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43959/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:38:24 INFO - PROCESS | 12531 | RSS: Main: 195055616 16:38:24 INFO - PROCESS | 12531 | 16:38:27 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:43959/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43959/tests/kraken/driver.html?testName=imaging-darkroom) 16:38:28 INFO - PROCESS | 12531 | RSS: Main: 200314880 16:38:28 INFO - PROCESS | 12531 | 16:38:32 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:43959/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43959/tests/kraken/driver.html?testName=imaging-desaturate) 16:38:32 INFO - PROCESS | 12531 | RSS: Main: 196612096 16:38:32 INFO - PROCESS | 12531 | 16:38:35 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:43959/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43959/tests/kraken/driver.html?testName=json-parse-financial) 16:38:36 INFO - PROCESS | 12531 | RSS: Main: 197763072 16:38:36 INFO - PROCESS | 12531 | 16:38:37 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:43959/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43959/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:38:38 INFO - PROCESS | 12531 | RSS: Main: 197996544 16:38:38 INFO - PROCESS | 12531 | 16:38:40 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:43959/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43959/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:38:41 INFO - PROCESS | 12531 | RSS: Main: 197689344 16:38:41 INFO - PROCESS | 12531 | 16:38:43 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:43959/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43959/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:38:43 INFO - PROCESS | 12531 | RSS: Main: 197730304 16:38:43 INFO - PROCESS | 12531 | 16:38:46 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:43959/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:38:47 INFO - PROCESS | 12531 | RSS: Main: 198139904 16:38:47 INFO - PROCESS | 12531 | 16:38:50 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:43959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:38:51 INFO - PROCESS | 12531 | RSS: Main: 202321920 16:38:51 INFO - PROCESS | 12531 | 16:38:53 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:43959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43959/tests/kraken/driver.html?testName=ai-astar) 16:38:53 INFO - PROCESS | 12531 | RSS: Main: 205008896 16:38:53 INFO - PROCESS | 12531 | 16:38:53 INFO - PROCESS | 12531 | __start_tp_report 16:38:53 INFO - PROCESS | 12531 | _x_x_mozilla_page_load 16:38:53 INFO - PROCESS | 12531 | _x_x_mozilla_page_load_details 16:38:53 INFO - PROCESS | 12531 | |i|pagename|runs| 16:38:53 INFO - PROCESS | 12531 | |0;ai-astar;109;118;116;118;117;115;116;115;115;116 16:38:53 INFO - PROCESS | 12531 | |1;audio-beat-detection;162;133;131;180;132;132;136;132;176;135 16:38:53 INFO - PROCESS | 12531 | |2;audio-dft;169;164;164;162;164;162;163;164;165;163 16:38:53 INFO - PROCESS | 12531 | |3;audio-fft;82;76;76;101;77;77;77;79;115;77 16:38:53 INFO - PROCESS | 12531 | |4;audio-oscillator;85;84;121;85;84;83;101;84;83;122 16:38:53 INFO - PROCESS | 12531 | |5;imaging-gaussian-blur;120;120;118;118;119;119;120;119;118;118 16:38:53 INFO - PROCESS | 12531 | |6;imaging-darkroom;148;148;149;150;148;148;148;150;149;148 16:38:53 INFO - PROCESS | 12531 | |7;imaging-desaturate;96;96;96;95;96;96;96;95;95;97 16:38:53 INFO - PROCESS | 12531 | |8;json-parse-financial;64;64;64;64;65;65;70;66;65;66 16:38:53 INFO - PROCESS | 12531 | |9;json-stringify-tinderbox;67;67;67;66;72;68;66;66;66;67 16:38:53 INFO - PROCESS | 12531 | |10;stanford-crypto-aes;86;85;94;85;85;85;94;83;85;91 16:38:53 INFO - PROCESS | 12531 | |11;stanford-crypto-ccm;162;156;140;141;151;145;147;147;197;152 16:38:53 INFO - PROCESS | 12531 | |12;stanford-crypto-pbkdf2;185;187;181;184;184;185;176;176;178;175 16:38:53 INFO - PROCESS | 12531 | |13;stanford-crypto-sha256-iterative;70;70;74;70;71;69;69;70;72;72 16:38:53 INFO - PROCESS | 12531 | __end_tp_report 16:38:53 INFO - PROCESS | 12531 | __start_cc_report 16:38:53 INFO - PROCESS | 12531 | _x_x_mozilla_cycle_collect,882 16:38:53 INFO - PROCESS | 12531 | __end_cc_report 16:38:53 INFO - PROCESS | 12531 | __startTimestamp1479343133432__endTimestamp 16:38:53 INFO - PROCESS | 12531 | 16:38:53 INFO - PROCESS | 12531 | ------- Summary: start ------- 16:38:53 INFO - PROCESS | 12531 | Number of tests: 14 16:38:53 INFO - PROCESS | 12531 | 16:38:53 INFO - PROCESS | 12531 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:2.55 (2.2%) stddev-sans-first:1.20 16:38:53 INFO - PROCESS | 12531 | Values: 109.0 118.0 116.0 118.0 117.0 115.0 116.0 115.0 115.0 116.0 16:38:53 INFO - PROCESS | 12531 | 16:38:53 INFO - PROCESS | 12531 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:135.50 stddev:19.73 (14.6%) stddev-sans-first:19.93 16:38:53 INFO - PROCESS | 12531 | Values: 162.0 133.0 131.0 180.0 132.0 132.0 136.0 132.0 176.0 135.0 16:38:53 INFO - PROCESS | 12531 | 16:38:53 INFO - PROCESS | 12531 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.00 (1.2%) stddev-sans-first:1.01 16:38:53 INFO - PROCESS | 12531 | Values: 169.0 164.0 164.0 162.0 164.0 162.0 163.0 164.0 165.0 163.0 16:38:53 INFO - PROCESS | 12531 | 16:38:53 INFO - PROCESS | 12531 | [#3] audio-fft Cycles:10 Average:83.70 Median:77.00 stddev:13.34 (17.3%) stddev-sans-first:14.14 16:38:53 INFO - PROCESS | 12531 | Values: 82.0 76.0 76.0 101.0 77.0 77.0 77.0 79.0 115.0 77.0 16:38:53 INFO - PROCESS | 12531 | 16:38:53 INFO - PROCESS | 12531 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:84.00 stddev:15.85 (18.9%) stddev-sans-first:16.53 16:38:53 INFO - PROCESS | 12531 | Values: 85.0 84.0 121.0 85.0 84.0 83.0 101.0 84.0 83.0 122.0 16:38:53 INFO - PROCESS | 12531 | 16:38:53 INFO - PROCESS | 12531 | [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:119.00 stddev:0.88 (0.7%) stddev-sans-first:0.83 16:38:53 INFO - PROCESS | 12531 | Values: 120.0 120.0 118.0 118.0 119.0 119.0 120.0 119.0 118.0 118.0 16:38:53 INFO - PROCESS | 12531 | 16:38:53 INFO - PROCESS | 12531 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 16:38:53 INFO - PROCESS | 12531 | Values: 148.0 148.0 149.0 150.0 148.0 148.0 148.0 150.0 149.0 148.0 16:38:53 INFO - PROCESS | 12531 | 16:38:53 INFO - PROCESS | 12531 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 16:38:53 INFO - PROCESS | 12531 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 97.0 16:38:53 INFO - PROCESS | 12531 | 16:38:53 INFO - PROCESS | 12531 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:1.83 (2.8%) stddev-sans-first:1.88 16:38:53 INFO - PROCESS | 12531 | Values: 64.0 64.0 64.0 64.0 65.0 65.0 70.0 66.0 65.0 66.0 16:38:53 INFO - PROCESS | 12531 | 16:38:53 INFO - PROCESS | 12531 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:1.81 (2.7%) stddev-sans-first:1.92 16:38:53 INFO - PROCESS | 12531 | Values: 67.0 67.0 67.0 66.0 72.0 68.0 66.0 66.0 66.0 67.0 16:38:53 INFO - PROCESS | 12531 | 16:38:53 INFO - PROCESS | 12531 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:85.50 stddev:4.08 (4.8%) stddev-sans-first:4.30 16:38:53 INFO - PROCESS | 12531 | Values: 86.0 85.0 94.0 85.0 85.0 85.0 94.0 83.0 85.0 91.0 16:38:53 INFO - PROCESS | 12531 | 16:38:53 INFO - PROCESS | 12531 | [#11] stanford-crypto-ccm Cycles:10 Average:153.80 Median:151.50 stddev:16.58 (10.9%) stddev-sans-first:17.32 16:38:53 INFO - PROCESS | 12531 | Values: 162.0 156.0 140.0 141.0 151.0 145.0 147.0 147.0 197.0 152.0 16:38:53 INFO - PROCESS | 12531 | 16:38:53 INFO - PROCESS | 12531 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.10 Median:184.00 stddev:4.48 (2.4%) stddev-sans-first:4.53 16:38:53 INFO - PROCESS | 12531 | Values: 185.0 187.0 181.0 184.0 184.0 185.0 176.0 176.0 178.0 175.0 16:38:53 INFO - PROCESS | 12531 | 16:38:53 INFO - PROCESS | 12531 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.50 stddev:1.57 (2.2%) stddev-sans-first:1.64 16:38:53 INFO - PROCESS | 12531 | Values: 70.0 70.0 74.0 70.0 71.0 69.0 69.0 70.0 72.0 72.0 16:38:53 INFO - PROCESS | 12531 | -------- Summary: end -------- 16:38:53 INFO - PROCESS | 12531 | 16:38:54 INFO - TEST-INFO | 12531: exit 0 16:38:54 INFO - TEST-OK | kraken | took 65025ms 16:38:54 INFO - SUITE-END | took 1186s 16:38:55 INFO - Completed test suite (00:19:46) 16:38:55 INFO - javascript benchmark 16:38:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6147.893279194823, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.3476630842288, 2620.7510286522784, 2623.449075694104, 2660.5610074337737, 2662.5606774882144, 4634.096351211515, 4735.437305689123, 4737.0, 4804.087223427547, 4805.111054454928, 4673.672842900998, 4754.9762251188695, 4801.303810947411, 4824.7587620618915, 4887.437944636368, 4365.301551751721, 4418.403515525411, 4450.57719516647, 4502.842400515982, 4561.1105834362315, 4067.3492241241406, 4508.481524624661, 4510.391097201868, 4527.773611319437, 4529.388532548113, 4248.107897341562, 4463.308187230952, 4466.70966387187, 4508.323751437294, 4567.840125595605, 4292.227399068166, 4332.9566704332865, 4349.782510874444, 4380.408644832939, 4398.912021759547, 4309.439772829513, 4310.202612516695, 4373.125374924996, 4388.868333949987, 4420.160169567804, 4771.761411929424, 4784.0, 4785.68893021956, 4818.156822556074, 4868.610511159099, 5086.211637196204, 5128.666636668605, 5168.578640873752, 5171.689698618057, 5178.896422071537, 5190.039842629126, 5201.401838788512, 5207.557357624606, 5207.843764687065, 5224.242484839715, 4582.083583283356, 4620.607248383925, 4848.200046992207, 4857.417109946794, 4862.80548778052, 5109.131447653834, 5116.590672746172, 5122.743862806845, 5123.538881500683, 5139.640225184276, 4905.607551395879, 4907.1657818171, 4922.089413458521, 4929.75351232437, 5004.574611158019, 4892.975535122373, 5105.7191854448365, 5126.846194614168, 5165.974170129125, 5173.456787037382, 4931.9753401232765, 4994.625403094782, 5001.749912504433, 5008.874778130503, 5009.148444764399, 5085.338905942203, 5105.463926287761, 5143.099957507421, 5148.382194136728, 5200.141976573898, 4367.62875155609, 4377.233984052778, 4378.890527736832, 4380.474343078851, 4405.581469760367, 3662.029562166028, 3703.518542589446, 3761.8495260189834, 3772.603876592973, 3868.535775706877, 4481.3726078349055, 4484.05834774701, 4512.187806194916, 4516.1419330327135, 4532.6827122101795, 5250.684958902401, 5254.92117618236, 5255.553277971415, 5259.552938000236, 5269.604779641542, 4211.515675697273, 4255.616994470451, 4278.7860606969525, 4311.935320970125, 4494.887627809266, 4514.864554063383, 4527.683062185682, 4545.795439205243, 4582.5417458253905, 4590.839320623762, 4788.066327066328, 4803.855884323476, 4817.614590832655, 4841.1285968526, 4874.463808981081, 5132.5124113209185, 5153.3558305211845, 5190.844274671766, 5193.636445448782, 5201.453847345974, 4702.506236845082, 4711.034237981137, 4741.146593613044, 4824.34871292371, 4871.561559459524, 5026.095302845523, 5042.697438153723, 5076.137056700443, 5079.187330027178, 5082.059818933509, 5150.510701483353, 5167.095758242217, 5167.22491626259, 5216.165413533817, 5248.186531087687, 5005.924911126409, 5026.0, 5040.798368065236, 5050.77271522775, 5089.618278629192, 4861.076395484846, 4866.148424025852, 4880.097182021195, 4999.850004499871, 5058.114829904678, 4751.358566593604, 4854.75726213695, 4882.048000639841, 4925.433575138905, 4973.030259099441, 5051.722155281494, 5092.287079808756, 5112.258722485293, 5112.590992720499, 5125.051865404912, 4688.249880019181, 4947.554720075211, 4955.752212389438, 4991.261796574595, 5014.774335154853], "value": 4695.841515878092, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.5325619966828, 543.9020976224278, 552.5579536370902, 552.8009916430085, 564.4750382144606, 37880.0, 39712.60287397125, 39958.0, 44267.55732442674, 44428.11143777122, 39828.0, 40041.59958400415, 40379.59620403795, 40504.39243411344, 40506.79746601263, 7632.771016869489, 7670.1562828089145, 7713.8071548211465, 7727.111382191036, 7731.922680773205, 7584.734534291301, 7686.385089192879, 7687.807804804868, 7690.500117492345, 7704.8844267336035, 7670.463067585271, 7688.461807673465, 7722.536647801122, 7735.767926962172, 7797.532148071105, 7696.345810606105, 7747.690092396298, 7748.845023099563, 7753.302202801775, 7754.340881025091, 7601.3538849197885, 7637.465377423582, 7639.618019099023, 7646.617669116522, 7695.038120234971, 37584.0, 37777.81111094427, 37842.24315513702, 37847.62152378496, 37863.24273514514, 3006.5941097951713, 3055.618047744032, 3126.421612001787, 3201.2477067889026, 3315.1049216711594, 27146.728532714616, 27698.307542311402, 27723.722762772315, 27823.721762782316, 27941.720582794114, 3420.2133509292753, 3443.3974054540604, 3625.3836847735683, 3637.9818100909324, 3667.908302292464, 255213.0, 257641.0, 258304.0, 258713.0, 260024.6998765013, 52100.739496302274, 52128.47871521312, 52227.47772522226, 52305.0, 52371.0, 53929.46070539323, 54060.16127661467, 54478.182827257624, 54499.45500545023, 54521.1821822673, 14410.495632652806, 14576.489822856149, 14667.926660366844, 14705.705885882222, 14706.264686765619, 11306.265092768943, 11393.886061139448, 11429.771404571862, 11432.0, 11441.199116061962, 13754.793678094837, 15457.304421301069, 15548.611284717972, 15780.210989450481, 15806.36774529029, 3005.669376368641, 5968.253968253968, 6344.714487848058, 6389.3291204423795, 6403.519736019817, 724.7823656257433, 825.2943733108106, 827.9254867061993, 832.6710949175042, 862.1895418306772, 27490.0, 27759.167224983285, 27905.16284511427, 28192.577111343347, 28349.0, 868.1708967935606, 887.6671248281895, 945.3807755919884, 1016.4511163971521, 1034.9546957572907, 13299.335033248299, 14371.694145734758, 14508.347124379428, 14527.418903243752, 14777.704445911022, 409450.0, 619460.0, 635018.0, 637443.0, 638263.0, 48183.0, 48797.26804097941, 48893.0, 48933.0, 48946.75526622344, 1179.1627944159743, 1187.7921363761307, 1197.2816310213975, 1199.9820002699967, 1224.9816252756216, 27007.1897843065, 27777.0, 28714.0, 28934.42131157407, 29032.12903612895, 41382.172356552095, 41630.37554436747, 41734.58265417307, 41785.37321940234, 41820.372694409, 342073.0, 344263.0, 344978.0, 347033.0, 347139.0, 25037.248882533553, 25168.24495265145, 25420.0, 25420.110296139548, 25431.74568254368, 39991.60008399879, 40019.599804002755, 40669.0, 40760.79619601883, 40981.1803763929, 32688.2278651612, 33096.83451582823, 33982.83008584941, 35497.46753798747, 35928.46107308445, 34644.82677586596, 34959.475607865395, 35408.46887296641, 35613.0, 36467.27065458729, 34029.82985085059, 34202.48696269608, 34392.65607343894, 34715.47926781151, 35112.47331290084, 28968.130956071353, 31195.688043119277, 31640.208994775316, 31747.682523175397, 31931.0, 24174.637380438955, 24784.876075619508, 24799.256022319358, 24865.254042378758, 25128.49743005093], "value": 17373.25975481383, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.8027183689785, 342.69671340863334, 347.5586005772669, 349.74643383546925, 364.95804478214677, 15702.97930634508, 17036.744448833262, 17485.213165407557, 17601.0, 17668.64662706745, 16602.25289861956, 16743.330266789344, 16860.83139168608, 17231.22459489323, 17518.824811751878, 4885.706857588547, 5073.213651883964, 5091.872703182432, 5115.616328775338, 5117.1556693145585, 3641.563012438511, 5006.54941055305, 5044.520770526812, 5071.98560287942, 5077.847664570068, 5217.947820521803, 5858.150568167634, 5895.528357731371, 5989.790357337494, 6000.2199714037115, 5780.433382751553, 5932.228810254683, 5961.612495187799, 5977.850553736148, 5990.400959904018, 5162.741862906877, 5170.095233334151, 5173.224016397533, 5182.481751824825, 5186.0665080285535, 19540.804591954042, 20295.5940881183, 20349.796502034937, 20395.0, 20489.590208195754, 1816.527702797269, 1889.9055047247582, 1989.6020795840745, 2023.423324352567, 2468.605023196298, 12754.681132971657, 12952.676183095404, 13118.278494682789, 13154.079214454992, 13689.589312320646, 1668.6329007618303, 1690.3069741405964, 1700.1669182100804, 1734.6010417604023, 1792.3436190172163, 64254.35745642531, 64761.67619161874, 65101.0, 65104.3489565103, 65166.348336516974, 8872.822543549222, 9137.451752894714, 9443.480608566457, 9480.620775169054, 9524.666636667684, 12448.190867593577, 12448.75102497963, 12473.313967731681, 12487.438065287084, 12502.187357821895, 7105.786826395217, 7275.636218189069, 7306.671199796022, 7464.440166987498, 7468.775936721907, 6924.099867017256, 7070.540414873017, 7078.787636370917, 7298.70805167798, 7312.818923768178, 5821.417858214229, 5833.154192642128, 5855.853603659943, 5907.586468947133, 5954.285485741739, 1668.1409074326732, 1691.6024734187456, 1695.779039091852, 1696.575856035991, 1724.3275122702157, 664.577992974455, 792.0574516325554, 825.7729124490693, 830.1822704635929, 832.1137988042836, 15861.286242119133, 16019.359225630844, 16070.839291607168, 16204.75692864608, 16578.6684266314, 838.1827717974926, 878.8681697745261, 880.8942926848691, 886.0209468537303, 902.9142680408278, 9322.48726320059, 9501.714948551555, 9643.517824108767, 9875.358101723365, 10006.349587276804, 347230.0, 348135.0, 353841.0, 357997.0, 358561.0, 65319.34680653133, 65348.34651653517, 65987.67006164939, 66673.0, 67182.0, 899.9865002025106, 939.8214339275515, 950.3347656640241, 964.1081999150757, 964.1611797735875, 13963.930180349033, 14861.479848205261, 14889.255537223313, 15058.623534411727, 15416.306266217824, 37656.2468750618, 38286.61713382942, 38444.0, 38644.420333694456, 39164.80417597894, 49308.75345623249, 49835.0, 50104.248436272755, 50246.246306306166, 50402.747986259834, 7003.789886303419, 7124.0, 7131.2512186221775, 7443.776686699408, 7475.289847464483, 9637.903620963982, 11302.773944521228, 11455.369954652575, 11754.647360579196, 11859.0, 9671.226301895691, 9830.0, 9870.457124858201, 10273.74315642115, 10597.417142056953, 9146.63413463454, 9650.662226822027, 9748.02519748048, 10030.29787914839, 10318.277720559488, 9861.506924653882, 10110.292279540656, 10229.386236825814, 10256.435896025492, 10581.259311848406, 7314.597697126496, 7331.670074846538, 7334.339909408179, 7639.847203055797, 7785.299323060952, 8057.798555036171, 9747.463889486145, 10027.097561219525, 10125.088742013255, 10574.544945813337], "value": 8149.8553636661645, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.9285039322833, 1342.449595665777, 1366.1598117157944, 1567.169400217885, 1571.948607067776, 5807.245058142446, 5984.820455386345, 6152.538559608025, 6560.606363618181, 6624.403803657676, 6031.517478601712, 6276.623402595847, 6278.748850045993, 6323.715432805523, 6473.741050357992, 1965.1844484538935, 2016.1935225909606, 2026.9695954560693, 2030.9390718278476, 2054.1885955047824, 2012.4968757810548, 2044.1414605865573, 2054.753429588444, 2058.4853786553363, 2062.288510463895, 1985.9503512412234, 1990.3033938121687, 1997.7902320256383, 2010.2260629657615, 2021.9797802021938, 1946.2312386607352, 1953.238237087537, 1967.8228959393723, 1968.8326492248177, 1972.5265936175358, 1962.3524237001754, 1963.803619638039, 1977.851661125407, 1995.042379657758, 2011.5675129847152, 6351.4283714465455, 6425.068365087036, 6426.1003459515705, 6429.260635026938, 6451.1936007999, 3963.2165525513346, 3984.063745019947, 4061.715679902408, 4104.548499665035, 4128.236276288896, 2767.4603452326805, 2859.170840456286, 2862.942741145186, 2871.0812539987214, 2878.309205790616, 835.7450977451874, 917.1974522292994, 940.7224868663692, 942.1285311087217, 949.6676163342844, 8138.104808471064, 8287.254147126727, 8315.210055044701, 8322.417430779848, 8331.750047498585, 3529.9190529389416, 3590.856365745341, 3628.8911332660064, 3661.4324779659196, 3672.8347224374966, 7222.277772222736, 7225.169105552824, 7257.49197556166, 7263.92736072643, 7265.709371625181, 4105.753654780723, 4112.444819949268, 4112.712110152261, 4120.855770048034, 4129.463169787909, 3357.7145942595153, 3464.2032332563654, 3655.4882316475714, 3668.0646435158865, 3744.2698673758355, 3073.8924137655076, 3171.6669749675953, 3220.4525230710838, 3222.2910959588853, 3266.510023496447, 1054.7218009100307, 1079.3146352066494, 1091.683411810566, 1093.3822390349428, 1095.1950316517352, 662.595816551903, 801.0747586537558, 804.5816175588661, 831.1439217605875, 832.3050253038781, 4439.156560253541, 4559.361689363492, 4567.177907976529, 4644.117617652635, 4657.813687452532, 776.3711393771064, 802.7150361621657, 830.3689196210803, 839.5550358310105, 878.4553576782436, 3030.22729204056, 3078.2766049978236, 3147.6065491813524, 3160.604924384452, 3296.175956010997, 7143.6428178591905, 7546.773596792105, 7554.508956917893, 7566.092068951651, 7569.810754731176, 7460.0, 7472.0, 7514.812129696692, 7539.246075392417, 7551.697932082765, 5993.730282137314, 6042.728077236535, 6125.540584456184, 6132.141500189977, 6141.109539116893, 4391.253486907297, 4399.208142534375, 4406.294992801137, 4498.662600305056, 4501.482329532146, 6922.06552115458, 6984.428483805179, 7061.752838650828, 7079.752208672672, 7128.572285662877, 6619.271880093283, 7068.11648543932, 7089.929100708927, 7127.643617818984, 7128.893066603901, 4848.0546293472435, 5380.892382152257, 5651.406602306699, 5652.68910209926, 5671.0, 5359.598030147677, 5817.825465236049, 5823.242978412779, 5908.615939963888, 6002.309734380602, 5449.782008719607, 5471.781128754806, 5491.203775452617, 5512.724363781715, 5518.310211223597, 5349.732513374238, 5373.408925018323, 5382.838514844561, 5417.729113544386, 5450.2369668247275, 5201.1678131498775, 5253.369595648393, 5257.369115706139, 5272.314599102092, 5276.683398996072, 3981.601839816111, 4043.353063509824, 4065.2072845794787, 4121.010957370149, 4159.188958153252, 3850.7304488685522, 3924.2543916655745, 3954.8615798446917, 3989.740666856645, 4002.0995276062654], "value": 3563.8874440031655, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.97175796541353, 280.8595702148925, 284.124895322407, 286.8967171818145, 287.65912393813335, 4836.775083461603, 4895.2412376081675, 4988.952320012797, 5103.336566246392, 5105.617078719097, 4739.289106634006, 4868.829590964317, 4905.803767849282, 4915.729634870081, 4924.359833221685, 3824.330742120118, 3827.5215598050245, 3833.731638785286, 3853.206425341619, 3858.151206734528, 3586.852207293667, 3835.539735231776, 3858.84564617415, 3859.421086836983, 3863.4784304119007, 3736.8602576214244, 3752.5684546277253, 3757.0795155187016, 3757.3424650686156, 3778.2997651057, 3731.440283957401, 3734.775913445202, 3742.288965096623, 3745.400735882246, 3749.268892565951, 3282.113829266085, 3282.6224984126893, 3284.5237440571223, 3291.835408229579, 3301.125201821519, 4640.211164102077, 4729.337892695025, 4737.50256223095, 4802.478698683184, 4874.926876096826, 4262.062346283813, 4268.786560671954, 4275.0, 4285.46431696038, 4300.8709738707885, 5140.948590514085, 5147.48525147486, 5155.869909440094, 5159.535641792219, 5169.707573106723, 3434.347473979961, 3517.6658217469553, 3530.541029666127, 3536.929261414783, 3565.8038807865555, 5363.892722145574, 5377.7580008899695, 5389.730513474311, 5401.351837779492, 5402.702851343214, 3605.7475976681903, 3620.420732682758, 3633.3823250047553, 3640.635936406391, 3658.4146536554554, 3670.2292518570866, 3681.1349332906743, 3695.4456831475495, 3719.4048952167523, 3734.421164719473, 4008.4187792769885, 4211.347241177622, 4254.723442976258, 4289.6139347458875, 4300.870973870727, 5131.820386286462, 5149.867029253558, 5168.431472538018, 5202.320804785539, 5211.400688920747, 1236.6104677026708, 1262.3463263125336, 1277.7061275906594, 1285.6721536008258, 1286.1961274203622, 850.8851305073736, 871.4030888841037, 890.1765866573394, 901.4320977784085, 903.5527413930015, 4302.591253830881, 4319.416878721332, 4341.34879768031, 4378.321360189176, 4404.823807047682, 5131.974340128276, 5138.97430512845, 5142.61430392722, 5145.099607568661, 5153.561947234452, 4315.942594064474, 4323.718958267703, 4325.199838029975, 4361.825526978949, 4392.934105988413, 2585.75435333643, 2696.21809675192, 2698.6896506901567, 2725.6047873058296, 2729.9044533441233, 4754.904901901942, 4765.523447655276, 4774.1883879739835, 4789.544993225638, 4809.9038019240115, 5028.083711447425, 5196.8960620787375, 5201.687898726089, 5225.681692125528, 5278.5513231375, 4785.880352991203, 4816.975915120402, 4820.758962051884, 4825.563090639204, 4846.636502262344, 5043.87390315245, 5097.311862898461, 5104.958016793313, 5105.625883963975, 5117.724656220096, 4790.688605240648, 4893.6085113191575, 4955.950440495549, 4959.429665588359, 5005.724685142352, 4794.304825800309, 4799.520047995173, 4805.831795887128, 4806.615470762401, 4808.567228949411, 3665.743397962117, 3666.175110600094, 3672.2288319453214, 3675.4670572766263, 3678.6505281998166, 5103.106956282561, 5112.182050871843, 5140.4088529818055, 5169.560587350117, 5182.24857395683, 4693.671442998957, 5141.663167576532, 5194.948050519598, 5204.609654276021, 5208.088584497774, 5171.586273098068, 5179.611529135254, 5194.948050519446, 5196.272521846869, 5209.322788037683, 4792.424909010941, 4984.75076246179, 5012.215777088275, 5038.722870242025, 5054.0, 5190.065788158167, 5201.479852014768, 5202.245674377118, 5218.608604354765, 5219.76511057011, 5067.277125777254, 5075.644704870623, 5116.897662046813, 5127.435982042047, 5129.9743501282255], "value": 3800.441036406809, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.4165026525332, 660.8171373241897, 664.8138521214062, 711.3313485323794, 712.3944647050012, 11823.881761182385, 12454.81317780234, 12778.744425111503, 12783.872161278385, 12804.807927881066, 12049.397530123502, 12245.32650704211, 12277.0, 12327.383630818467, 12358.382080895964, 614.6097228260064, 628.0171531553104, 742.3801126059733, 760.5930827007552, 761.9542827430372, 737.1375490675895, 751.3801114080878, 753.8643044252033, 757.7234309477029, 759.6733404636004, 798.9680412783482, 801.6913488306985, 802.5345299726174, 802.7631848604676, 804.5012092502627, 795.9562224077703, 796.1242633103569, 796.9123396426388, 797.3860127701637, 806.0, 582.1820342418908, 582.7581553655228, 582.8193260089386, 585.4584509328896, 586.7652938824505, 11911.702207444796, 12476.251424914533, 12498.937505312506, 12511.624651260478, 12530.624081277485, 12319.69200769979, 12469.438875250635, 12701.93649031749, 12807.359632018362, 13029.869701303056, 9203.76990575241, 9330.206932410752, 9339.579718912666, 9448.622055117787, 9769.023097690246, 3117.345357474933, 3164.9683503164906, 3178.2213357727505, 3184.2994541200896, 3220.9677903220904, 49339.25991110136, 49734.7513262435, 50691.0, 51108.0, 52119.47880521184, 9584.472853993097, 9763.658271960447, 9840.753981150385, 9848.458334791512, 10222.539985700512, 16432.83567164313, 16541.0, 16597.41909033178, 16611.335546578244, 16612.0, 6223.408776166257, 6444.097826304321, 6460.741570337228, 6495.512836537278, 6689.297623749533, 3272.640009598942, 3282.0482060202753, 3311.3211791582667, 3320.5849268841393, 3430.091025878144, 2616.4897844920056, 2675.8126931114634, 2693.259353677715, 2695.784337253015, 2702.7567518923393, 501.0955225817362, 512.9512696293921, 518.1062666899568, 522.1671434062664, 523.0819911056072, 563.9577031722637, 585.5140233606097, 596.5645079092287, 597.2325561653255, 604.3412680178626, 7788.727394541163, 7808.0, 7844.843103137905, 7944.815175826694, 7978.760637180894, 555.7138073891949, 559.636236446305, 574.6207503047968, 575.7955925646419, 577.789953428139, 3660.4875317455576, 3836.827342769582, 3892.143728379752, 3906.7851268180525, 3906.8437262509183, 67715.66142169356, 69603.0, 70610.29389706037, 71034.0, 71903.64048179725, 61657.38342616606, 62009.68995154995, 62951.37048629547, 63944.680276598316, 65140.34859651438, 55933.72033139808, 56126.43873561294, 57131.0, 57366.0, 59747.70126149429, 7404.296591823768, 7456.47804653669, 7550.811229719081, 7594.126675432396, 7637.198094200029, 37984.81007594944, 38571.421428679154, 39649.801750992214, 40242.59757402389, 40818.0, 46673.766631166625, 47244.527554724016, 50529.49470505248, 53582.0, 54412.45587544232, 8601.924759405074, 8811.251043661361, 9104.863427048733, 9247.39891907024, 9327.860082098638, 9516.429014259167, 10592.417417041828, 11583.189176757545, 11808.645740627795, 11831.349275789915, 10335.0, 10877.619283325046, 11071.225014248925, 11220.382878941737, 11344.20590558686, 10675.412852293199, 10693.679189624323, 10870.0, 11316.49075791575, 12400.13199076056, 9752.122308992224, 9952.502374881082, 10281.9485902573, 10284.742881428025, 10564.154867610727, 9205.907940920504, 9214.631414743335, 9296.39573427725, 9606.951965240129, 9834.360766550151, 8955.328350373878, 9341.719748407559, 9407.576659050223, 9447.716568502956, 9457.799438724243], "value": 5995.146689868753, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1589.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 118.0, 116.0, 118.0, 117.0, 115.0, 116.0, 115.0, 115.0, 116.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 133.0, 131.0, 180.0, 132.0, 132.0, 136.0, 132.0, 176.0, 135.0], "value": 144.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 164.0, 164.0, 162.0, 164.0, 162.0, 163.0, 164.0, 165.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 76.0, 101.0, 77.0, 77.0, 77.0, 79.0, 115.0, 77.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 121.0, 85.0, 84.0, 83.0, 101.0, 84.0, 83.0, 122.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 120.0, 118.0, 118.0, 119.0, 119.0, 120.0, 119.0, 118.0, 118.0], "value": 118.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 150.0, 148.0, 148.0, 148.0, 150.0, 149.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 97.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 70.0, 66.0, 65.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 72.0, 68.0, 66.0, 66.0, 66.0, 67.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 94.0, 85.0, 85.0, 85.0, 94.0, 83.0, 85.0, 91.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 156.0, 140.0, 141.0, 151.0, 145.0, 147.0, 147.0, 197.0, 152.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 181.0, 184.0, 184.0, 185.0, 176.0, 176.0, 178.0, 175.0], "value": 181.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 74.0, 70.0, 71.0, 69.0, 69.0, 70.0, 72.0, 72.0], "value": 70.7, "unit": "score"}]}]} 16:38:55 INFO - Return code: 0 16:38:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:38:55 ERROR - # TBPL SUCCESS # 16:38:55 INFO - Running post-action listener: _resource_record_post_action 16:38:55 INFO - [mozharness: 2016-11-17 00:38:55.224535Z] Finished run-tests step (success) 16:38:55 INFO - Running post-run listener: _resource_record_post_run 16:38:55 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 404586496; Read time: 36; Write time: 261796 16:38:55 INFO - TinderboxPrint: CPU usage
13.5% 16:38:55 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 36 16:38:55 INFO - TinderboxPrint: I/O write bytes / time
404,586,496 / 261,796 16:38:55 INFO - TinderboxPrint: CPU idle
8,299.5 (86.5%) 16:38:55 INFO - TinderboxPrint: CPU user
1,232.4 (12.8%) 16:38:55 INFO - TinderboxPrint: Swap in / out
0 / 0 16:38:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110395392; Read time: 0; Write time: 62620 16:38:55 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294191104; Read time: 16; Write time: 199176 16:38:55 INFO - Running post-run listener: _upload_blobber_files 16:38:55 INFO - Blob upload gear active. 16:38:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:38:55 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 16:38:55 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:38:55 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:38:56 INFO - (blobuploader) - INFO - Open directory for files ... 16:38:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:38:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:38:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:38:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:38:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:38:57 INFO - (blobuploader) - INFO - Done attempting. 16:38:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:38:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:38:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:39:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:00 INFO - (blobuploader) - INFO - Done attempting. 16:39:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:39:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:01 INFO - (blobuploader) - INFO - Done attempting. 16:39:01 INFO - (blobuploader) - INFO - Iteration through files over. 16:39:01 INFO - Return code: 0 16:39:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:39:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:39:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1857995b689ce3f6506ef77b84394fce4c1bf9499036d42b7e7dd4dd94fc713be02f70bd31ca12063a3a8e838d9769580bc67dd37f1418a2a32db9986ef09e8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6121b0827ee698dd3dc93734639b0773522d3fbd3343da78691cbe5c6bbf1c9368d2971d5456f7abd8b672cc7e4fb2f8bca493e4dd640504d263e329443c55a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/20096807f81dd4bbef26695fb6ad3f5a0601e55ea7ab4a574676b37ef098a01da486cd48118e869064de8c39b430d06edef713fa2e84cbb4e975b5770243cf2b"} 16:39:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:39:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:39:01 INFO - Contents: 16:39:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1857995b689ce3f6506ef77b84394fce4c1bf9499036d42b7e7dd4dd94fc713be02f70bd31ca12063a3a8e838d9769580bc67dd37f1418a2a32db9986ef09e8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6121b0827ee698dd3dc93734639b0773522d3fbd3343da78691cbe5c6bbf1c9368d2971d5456f7abd8b672cc7e4fb2f8bca493e4dd640504d263e329443c55a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/20096807f81dd4bbef26695fb6ad3f5a0601e55ea7ab4a574676b37ef098a01da486cd48118e869064de8c39b430d06edef713fa2e84cbb4e975b5770243cf2b"} 16:39:01 INFO - Running post-run listener: copy_logs_to_upload_dir 16:39:01 INFO - Copying logs to upload dir... 16:39:01 INFO - mkdir: /builds/slave/test/build/upload/logs 16:39:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.184123 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-11-16 16:39:00.987506) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 16:39:00.991572) ========= 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=20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1857995b689ce3f6506ef77b84394fce4c1bf9499036d42b7e7dd4dd94fc713be02f70bd31ca12063a3a8e838d9769580bc67dd37f1418a2a32db9986ef09e8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6121b0827ee698dd3dc93734639b0773522d3fbd3343da78691cbe5c6bbf1c9368d2971d5456f7abd8b672cc7e4fb2f8bca493e4dd640504d263e329443c55a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/20096807f81dd4bbef26695fb6ad3f5a0601e55ea7ab4a574676b37ef098a01da486cd48118e869064de8c39b430d06edef713fa2e84cbb4e975b5770243cf2b"} build_url:https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011864 build_url: 'https://queue.taskcluster.net/v1/task/E-FOc-eBSt2blbOIhTNEZQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1857995b689ce3f6506ef77b84394fce4c1bf9499036d42b7e7dd4dd94fc713be02f70bd31ca12063a3a8e838d9769580bc67dd37f1418a2a32db9986ef09e8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6121b0827ee698dd3dc93734639b0773522d3fbd3343da78691cbe5c6bbf1c9368d2971d5456f7abd8b672cc7e4fb2f8bca493e4dd640504d263e329443c55a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/20096807f81dd4bbef26695fb6ad3f5a0601e55ea7ab4a574676b37ef098a01da486cd48118e869064de8c39b430d06edef713fa2e84cbb4e975b5770243cf2b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 16:39:01.018189) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:39:01.018531) ========= 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=20e666a3d4cfbb71505a330e000001b4-1479341446.390656-633439371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:39:01.102185) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 16:39:01.102519) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 16:39:01.102847) ========= ========= Total master_lag: 0.17 =========