builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1476312746.47 results: success (0) buildid: 20161012142646 builduid: 3edd39fec5a24866bc2e60ec60f520cc revision: 22be4ae74653b25186665f22e52a50e7027fd36b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 15:52:26.470305) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 15:52:26.470742) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 15:52:26.471016) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 15:52:26.485510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 15:52:26.485769) ========= 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=7de08804244eb36560b44971000001c3-1476312745.880938-1210367395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-12 15:52:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 215M=0s 2016-10-12 15:52:26 (215 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117643 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 15:52:26.616860) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 15:52:26.617181) ========= 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=7de08804244eb36560b44971000001c3-1476312745.880938-1210367395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020223 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 15:52:26.667189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 15:52:26.667624) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 22be4ae74653b25186665f22e52a50e7027fd36b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 22be4ae74653b25186665f22e52a50e7027fd36b --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=7de08804244eb36560b44971000001c3-1476312745.880938-1210367395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-12 15:52:26,817 truncating revision to first 12 chars 2016-10-12 15:52:26,818 Setting DEBUG logging. 2016-10-12 15:52:26,818 attempt 1/10 2016-10-12 15:52:26,818 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/22be4ae74653?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 15:52:27,191 unpacking tar archive at: mozilla-central-22be4ae74653/testing/mozharness/ program finished with exit code 0 elapsedTime=0.714771 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 15:52:27.395768) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 15:52:27.396087) ========= script_repo_revision: 22be4ae74653b25186665f22e52a50e7027fd36b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 15:52:27.396488) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 15:52:27.396751) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 15:52:27.404530) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-12 15:52:27.404793) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1476312745.880938-1210367395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:52:27 INFO - MultiFileLogger online at 20161012 15:52:27 in /builds/slave/test 15:52:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:52:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:52:27 INFO - {'append_to_log': False, 15:52:27 INFO - 'base_work_dir': '/builds/slave/test', 15:52:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:52:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:52:27 INFO - 'branch': 'Firefox-Non-PGO', 15:52:27 INFO - 'buildbot_json_path': 'buildprops.json', 15:52:27 INFO - 'config_files': ('talos/linux_config.py',), 15:52:27 INFO - 'default_actions': ('clobber', 15:52:27 INFO - 'read-buildbot-config', 15:52:27 INFO - 'download-and-extract', 15:52:27 INFO - 'populate-webroot', 15:52:27 INFO - 'create-virtualenv', 15:52:27 INFO - 'install', 15:52:27 INFO - 'run-tests'), 15:52:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:52:27 INFO - 'download_minidump_stackwalk': True, 15:52:27 INFO - 'download_symbols': 'ondemand', 15:52:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:52:27 INFO - 'tooltool.py': '/tools/tooltool.py', 15:52:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:52:27 INFO - '/tools/misc-python/virtualenv.py')}, 15:52:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:52:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:52:27 INFO - 'installer_path': 'installer.exe', 15:52:27 INFO - 'log_level': 'info', 15:52:27 INFO - 'log_name': 'talos', 15:52:27 INFO - 'log_to_console': True, 15:52:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:52:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:52:27 INFO - 'opt_config_files': (), 15:52:27 INFO - 'pip_index': False, 15:52:27 INFO - 'sps_profile': False, 15:52:27 INFO - 'sps_profile_interval': 0, 15:52:27 INFO - 'suite': 'dromaeojs-e10s', 15:52:27 INFO - 'system_bits': '32', 15:52:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:52:27 INFO - 'title': 'talos-linux64-ix-003', 15:52:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:52:27 INFO - 'use_talos_json': True, 15:52:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:52:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:52:27 INFO - 'work_dir': 'build'} 15:52:27 INFO - [mozharness: 2016-10-12 22:52:27.650691Z] Running clobber step. 15:52:27 INFO - Running pre-action listener: _resource_record_pre_action 15:52:27 INFO - Running main action method: clobber 15:52:27 INFO - rmtree: /builds/slave/test/build 15:52:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:52:28 INFO - Running post-action listener: _resource_record_post_action 15:52:28 INFO - [mozharness: 2016-10-12 22:52:28.144948Z] Finished clobber step (success) 15:52:28 INFO - [mozharness: 2016-10-12 22:52:28.145048Z] Running read-buildbot-config step. 15:52:28 INFO - Running pre-action listener: _resource_record_pre_action 15:52:28 INFO - Running main action method: read_buildbot_config 15:52:28 INFO - Using buildbot properties: 15:52:28 INFO - { 15:52:28 INFO - "project": "", 15:52:28 INFO - "product": "firefox", 15:52:28 INFO - "script_repo_revision": "production", 15:52:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:52:28 INFO - "repository": "", 15:52:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:52:28 INFO - "buildid": "20161012142646", 15:52:28 INFO - "pgo_build": "False", 15:52:28 INFO - "basedir": "/builds/slave/test", 15:52:28 INFO - "buildnumber": 489, 15:52:28 INFO - "slavename": "talos-linux64-ix-003", 15:52:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:52:28 INFO - "platform": "ubuntu64_hw", 15:52:28 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:52:28 INFO - "branch": "mozilla-central", 15:52:28 INFO - "repo_path": "mozilla-central", 15:52:28 INFO - "revision": "22be4ae74653b25186665f22e52a50e7027fd36b", 15:52:28 INFO - "stage_platform": "linux64", 15:52:28 INFO - "builduid": "3edd39fec5a24866bc2e60ec60f520cc", 15:52:28 INFO - "slavebuilddir": "test" 15:52:28 INFO - } 15:52:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:52:28 INFO - Running post-action listener: _resource_record_post_action 15:52:28 INFO - [mozharness: 2016-10-12 22:52:28.147809Z] Finished read-buildbot-config step (success) 15:52:28 INFO - [mozharness: 2016-10-12 22:52:28.147896Z] Running download-and-extract step. 15:52:28 INFO - Running pre-action listener: _resource_record_pre_action 15:52:28 INFO - Running main action method: download_and_extract 15:52:28 INFO - mkdir: /builds/slave/test/build/tests 15:52: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')]} 15:52:28 INFO - trying https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:52:28 INFO - Downloading https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:52:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:52:28 INFO - Downloaded 1361 bytes. 15:52:28 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:52:28 INFO - Using the following test package requirements: 15:52:28 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:52:28 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:52:28 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:52:28 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:28 INFO - u'jsshell-linux-x86_64.zip'], 15:52:28 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:52:28 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:52:28 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:52:28 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:52:28 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:52:28 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:52:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:52:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:52:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:52:28 INFO - Fetch https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:52:29 INFO - Http code: 200 15:52:29 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 15:52:29 INFO - x-amz-cf-id: _Pce5vvo21LKudmDL9ND3lQREuy3Ta1oQYWDJLVeM32wYHrfNv9CqQ== 15:52:29 INFO - x-amz-version-id: h4E6pRu_cf2HzIGqROEqZ9unz027w3sm 15:52:29 INFO - Expected file size: 20547925 15:52:29 INFO - Obtained file size: 20547925 15:52:33 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:52:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:52:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:52:33 INFO - Fetch https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:52:34 INFO - Http code: 200 15:52:34 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 15:52:34 INFO - x-amz-cf-id: c6lWJJfrQ_4y1gU-19dHFb9AiagN-Os8n7da6eaWTP-aB13vxY7YPA== 15:52:34 INFO - x-amz-version-id: h4E6pRu_cf2HzIGqROEqZ9unz027w3sm 15:52:34 INFO - Expected file size: 20547925 15:52:34 INFO - Obtained file size: 20547925 15:52:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:52:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:52:39 INFO - Fetch https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:52:39 INFO - Http code: 200 15:52:39 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 15:52:39 INFO - x-amz-cf-id: _6alt619IeIFKeq_UAfBywwkbBnXQ2P9-G2P3AWkePxmG4-Y1AeSXg== 15:52:39 INFO - x-amz-version-id: 2EPGlhYvij47elcXAoibzd9cJnT4ldd5 15:52:40 INFO - Expected file size: 14409006 15:52:40 INFO - Obtained file size: 14409006 15:52: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')]} 15:52:40 INFO - trying https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:52:40 INFO - Downloading https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:52:41 INFO - Downloaded 55946206 bytes. 15:52:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:52:41 INFO - mkdir: /builds/slave/test/properties 15:52:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:52:41 INFO - Writing to file /builds/slave/test/properties/build_url 15:52:41 INFO - Contents: 15:52:41 INFO - build_url:https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:52:42 INFO - Running post-action listener: _resource_record_post_action 15:52:42 INFO - Running post-action listener: set_extra_try_arguments 15:52:42 INFO - [mozharness: 2016-10-12 22:52:42.271392Z] Finished download-and-extract step (success) 15:52:42 INFO - [mozharness: 2016-10-12 22:52:42.271616Z] Running populate-webroot step. 15:52:42 INFO - Running pre-action listener: _resource_record_pre_action 15:52:42 INFO - Running main action method: populate_webroot 15:52:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:52:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:52:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:52:42 INFO - '--tppagecycles', 15:52:42 INFO - '7'], 15:52:42 INFO - 'tests': ['tsvgm']}}, 15:52:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:52:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:52:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:52:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:52:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:52:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:52:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:42 INFO - 'talos_options': ['--disable-e10s'], 15:52:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:42 INFO - 'talos_options': ['--disable-e10s'], 15:52:42 INFO - 'tests': ['damp', 'tps']}, 15:52:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:42 INFO - 'tests': ['damp', 'tps']}, 15:52:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:52:42 INFO - 'tests': ['dromaeo_dom']}, 15:52:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:52:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:52:42 INFO - 'tests': ['basic_compositor_video']}, 15:52:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:52:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:52:42 INFO - 'tests': ['a11yr', 15:52:42 INFO - 'ts_paint', 15:52:42 INFO - 'tpaint', 15:52:42 INFO - 'sessionrestore', 15:52:42 INFO - 'sessionrestore_no_auto_restore', 15:52:42 INFO - 'tabpaint']}, 15:52:42 INFO - 'other-e10s': {'tests': ['a11yr', 15:52:42 INFO - 'ts_paint', 15:52:42 INFO - 'tpaint', 15:52:42 INFO - 'sessionrestore', 15:52:42 INFO - 'sessionrestore_no_auto_restore', 15:52:42 INFO - 'tabpaint']}, 15:52:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:52:42 INFO - 'ts_paint', 15:52:42 INFO - 'tpaint', 15:52:42 INFO - 'sessionrestore', 15:52:42 INFO - 'sessionrestore_no_auto_restore', 15:52:42 INFO - 'tabpaint']}, 15:52:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:52:42 INFO - 'ts_paint', 15:52:42 INFO - 'tpaint', 15:52:42 INFO - 'sessionrestore', 15:52:42 INFO - 'sessionrestore_no_auto_restore', 15:52:42 INFO - 'tabpaint']}, 15:52:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:52:42 INFO - 'tests': ['a11yr', 15:52:42 INFO - 'ts_paint', 15:52:42 INFO - 'tpaint', 15:52:42 INFO - 'sessionrestore', 15:52:42 INFO - 'sessionrestore_no_auto_restore', 15:52:42 INFO - 'tabpaint']}, 15:52:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:52:42 INFO - 'tests': ['a11yr', 15:52:42 INFO - 'ts_paint', 15:52:42 INFO - 'tpaint', 15:52:42 INFO - 'sessionrestore', 15:52:42 INFO - 'sessionrestore_no_auto_restore', 15:52:42 INFO - 'tabpaint']}, 15:52:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:52:42 INFO - 'tests': ['tsvgx', 15:52:42 INFO - 'tsvgr_opacity', 15:52:42 INFO - 'tart', 15:52:42 INFO - 'tscrollx', 15:52:42 INFO - 'cart']}, 15:52:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:52:42 INFO - 'tsvgr_opacity', 15:52:42 INFO - 'tart', 15:52:42 INFO - 'tscrollx', 15:52:42 INFO - 'cart']}, 15:52:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:42 INFO - 'talos_options': ['--disable-e10s'], 15:52:42 INFO - 'tests': ['tp5o']}, 15:52:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:42 INFO - 'tests': ['tp5o']}, 15:52:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:42 INFO - 'talos_options': ['--disable-e10s', 15:52:42 INFO - '--xperf_path', 15:52:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:42 INFO - 'tests': ['tp5n']}, 15:52:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:42 INFO - 'talos_options': ['--xperf_path', 15:52:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:42 INFO - 'tests': ['tp5n']}}, 15:52:42 INFO - 'talos.zip': {'path': '', 15:52:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:52:42 INFO - Running post-action listener: _resource_record_post_action 15:52:42 INFO - [mozharness: 2016-10-12 22:52:42.286738Z] Finished populate-webroot step (success) 15:52:42 INFO - [mozharness: 2016-10-12 22:52:42.286825Z] Running create-virtualenv step. 15:52:42 INFO - Running pre-action listener: _resource_record_pre_action 15:52:42 INFO - Running main action method: create_virtualenv 15:52:42 INFO - Creating virtualenv /builds/slave/test/build/venv 15:52:42 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 15:52:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:52:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:52:42 INFO - Using real prefix '/usr' 15:52:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:52:42 INFO - Installing distribute.............................................................................................................................................................................................done. 15:52:44 INFO - Installing pip.................done. 15:52:44 INFO - Return code: 0 15:52:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:52:45 INFO - Reading from file tmpfile_stdout 15:52:45 INFO - Output received: 15:52:45 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) 15:52:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f70c012ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b91ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ef60>, '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 0x2b8fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b901d0>, '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': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', '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 15:52:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:52:45 INFO - Using env: {'DISPLAY': ':0', 15:52:45 INFO - 'HOME': '/home/cltbld', 15:52:45 INFO - 'LANG': 'en_US.UTF-8', 15:52:45 INFO - 'LANGUAGE': 'en_US:en', 15:52:45 INFO - 'LOGNAME': 'cltbld', 15:52:45 INFO - 'MAIL': '/var/mail/cltbld', 15:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:45 INFO - 'MOZ_NO_REMOTE': '1', 15:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:45 INFO - 'NO_EM_RESTART': '1', 15:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:45 INFO - 'PWD': '/builds/slave/test', 15:52:45 INFO - 'SHELL': '/bin/bash', 15:52:45 INFO - 'SHLVL': '1', 15:52:45 INFO - 'TERM': 'linux', 15:52:45 INFO - 'TMOUT': '86400', 15:52:45 INFO - 'USER': 'cltbld', 15:52:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', 15:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:45 INFO - '_': '/tools/buildbot/bin/python'} 15:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:45 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 15:52:45 INFO - Cleaning up... 15:52:45 INFO - Return code: 0 15:52:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f70c012ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b91ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ef60>, '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 0x2b8fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b901d0>, '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': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', '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 15:52:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:52:45 INFO - Using env: {'DISPLAY': ':0', 15:52:45 INFO - 'HOME': '/home/cltbld', 15:52:45 INFO - 'LANG': 'en_US.UTF-8', 15:52:45 INFO - 'LANGUAGE': 'en_US:en', 15:52:45 INFO - 'LOGNAME': 'cltbld', 15:52:45 INFO - 'MAIL': '/var/mail/cltbld', 15:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:45 INFO - 'MOZ_NO_REMOTE': '1', 15:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:45 INFO - 'NO_EM_RESTART': '1', 15:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:45 INFO - 'PWD': '/builds/slave/test', 15:52:45 INFO - 'SHELL': '/bin/bash', 15:52:45 INFO - 'SHLVL': '1', 15:52:45 INFO - 'TERM': 'linux', 15:52:45 INFO - 'TMOUT': '86400', 15:52:45 INFO - 'USER': 'cltbld', 15:52:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', 15:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:45 INFO - '_': '/tools/buildbot/bin/python'} 15:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:45 INFO - Downloading/unpacking psutil>=3.1.1 15:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:52:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:47 INFO - Installing collected packages: psutil 15:52:47 INFO - Running setup.py install for psutil 15:52:47 INFO - building 'psutil._psutil_linux' extension 15:52:47 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 15:52:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:52:47 INFO - building 'psutil._psutil_posix' extension 15:52:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:52:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:52:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:48 INFO - Successfully installed psutil 15:52:48 INFO - Cleaning up... 15:52:48 INFO - Return code: 0 15:52:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:52:48 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')]} 15:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:48 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')]} 15:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:48 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 0x7f70c012ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b91ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ef60>, '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 0x2b8fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b901d0>, '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': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', '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 15:52:48 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 15:52:48 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 15:52:48 INFO - Using env: {'DISPLAY': ':0', 15:52:48 INFO - 'HOME': '/home/cltbld', 15:52:48 INFO - 'LANG': 'en_US.UTF-8', 15:52:48 INFO - 'LANGUAGE': 'en_US:en', 15:52:48 INFO - 'LOGNAME': 'cltbld', 15:52:48 INFO - 'MAIL': '/var/mail/cltbld', 15:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:48 INFO - 'MOZ_NO_REMOTE': '1', 15:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:48 INFO - 'NO_EM_RESTART': '1', 15:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:48 INFO - 'PWD': '/builds/slave/test', 15:52:48 INFO - 'SHELL': '/bin/bash', 15:52:48 INFO - 'SHLVL': '1', 15:52:48 INFO - 'TERM': 'linux', 15:52:48 INFO - 'TMOUT': '86400', 15:52:48 INFO - 'USER': 'cltbld', 15:52:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', 15:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:48 INFO - '_': '/tools/buildbot/bin/python'} 15:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:52:50 INFO - Installing collected packages: mozsystemmonitor 15:52:50 INFO - Running setup.py install for mozsystemmonitor 15:52:50 INFO - Successfully installed mozsystemmonitor 15:52:50 INFO - Cleaning up... 15:52:50 INFO - Return code: 0 15:52:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:50 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 0x7f70c012ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b91ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ef60>, '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 0x2b8fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b901d0>, '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': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', '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 15:52:50 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 15:52:50 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 15:52:50 INFO - Using env: {'DISPLAY': ':0', 15:52:50 INFO - 'HOME': '/home/cltbld', 15:52:50 INFO - 'LANG': 'en_US.UTF-8', 15:52:50 INFO - 'LANGUAGE': 'en_US:en', 15:52:50 INFO - 'LOGNAME': 'cltbld', 15:52:50 INFO - 'MAIL': '/var/mail/cltbld', 15:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:50 INFO - 'MOZ_NO_REMOTE': '1', 15:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:50 INFO - 'NO_EM_RESTART': '1', 15:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:50 INFO - 'PWD': '/builds/slave/test', 15:52:50 INFO - 'SHELL': '/bin/bash', 15:52:50 INFO - 'SHLVL': '1', 15:52:50 INFO - 'TERM': 'linux', 15:52:50 INFO - 'TMOUT': '86400', 15:52:50 INFO - 'USER': 'cltbld', 15:52:50 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', 15:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:50 INFO - '_': '/tools/buildbot/bin/python'} 15:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:50 INFO - Downloading/unpacking jsonschema==2.5.1 15:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:52:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:52 INFO - Downloading functools32-3.2.3-2.tar.gz 15:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:52:52 INFO - warning: no files found matching '*.txt' 15:52:52 INFO - no previously-included directories found matching 'build' 15:52:52 INFO - no previously-included directories found matching 'dist' 15:52:52 INFO - no previously-included directories found matching '.git*' 15:52:52 INFO - Installing collected packages: jsonschema, functools32 15:52:52 INFO - Running setup.py install for functools32 15:52:52 INFO - warning: no files found matching '*.txt' 15:52:52 INFO - no previously-included directories found matching 'build' 15:52:52 INFO - no previously-included directories found matching 'dist' 15:52:52 INFO - no previously-included directories found matching '.git*' 15:52:53 INFO - Successfully installed jsonschema functools32 15:52:53 INFO - Cleaning up... 15:52:53 INFO - Return code: 0 15:52:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:53 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 0x7f70c012ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b91ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ef60>, '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 0x2b8fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b901d0>, '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': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', '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 15:52:53 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 15:52:53 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 15:52:53 INFO - Using env: {'DISPLAY': ':0', 15:52:53 INFO - 'HOME': '/home/cltbld', 15:52:53 INFO - 'LANG': 'en_US.UTF-8', 15:52:53 INFO - 'LANGUAGE': 'en_US:en', 15:52:53 INFO - 'LOGNAME': 'cltbld', 15:52:53 INFO - 'MAIL': '/var/mail/cltbld', 15:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:53 INFO - 'MOZ_NO_REMOTE': '1', 15:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:53 INFO - 'NO_EM_RESTART': '1', 15:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:53 INFO - 'PWD': '/builds/slave/test', 15:52:53 INFO - 'SHELL': '/bin/bash', 15:52:53 INFO - 'SHLVL': '1', 15:52:53 INFO - 'TERM': 'linux', 15:52:53 INFO - 'TMOUT': '86400', 15:52:53 INFO - 'USER': 'cltbld', 15:52:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', 15:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:53 INFO - '_': '/tools/buildbot/bin/python'} 15:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:52:53 INFO - Cleaning up... 15:52:53 INFO - Return code: 0 15:52:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:53 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 0x7f70c012ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b91ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ef60>, '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 0x2b8fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b901d0>, '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': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', '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 15:52:53 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 15:52:53 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 15:52:53 INFO - Using env: {'DISPLAY': ':0', 15:52:53 INFO - 'HOME': '/home/cltbld', 15:52:53 INFO - 'LANG': 'en_US.UTF-8', 15:52:53 INFO - 'LANGUAGE': 'en_US:en', 15:52:53 INFO - 'LOGNAME': 'cltbld', 15:52:53 INFO - 'MAIL': '/var/mail/cltbld', 15:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:53 INFO - 'MOZ_NO_REMOTE': '1', 15:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:53 INFO - 'NO_EM_RESTART': '1', 15:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:53 INFO - 'PWD': '/builds/slave/test', 15:52:53 INFO - 'SHELL': '/bin/bash', 15:52:53 INFO - 'SHLVL': '1', 15:52:53 INFO - 'TERM': 'linux', 15:52:53 INFO - 'TMOUT': '86400', 15:52:53 INFO - 'USER': 'cltbld', 15:52:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', 15:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:53 INFO - '_': '/tools/buildbot/bin/python'} 15:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:53 INFO - Downloading/unpacking blobuploader==1.2.4 15:52:53 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 15:52:53 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 15:52:53 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 15:52:53 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 15:52:53 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 15:52:53 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 15:52:55 INFO - Downloading blobuploader-1.2.4.tar.gz 15:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:52:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:52:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:56 INFO - Downloading docopt-0.6.1.tar.gz 15:52:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:52:56 INFO - Installing collected packages: blobuploader, requests, docopt 15:52:56 INFO - Running setup.py install for blobuploader 15:52:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:52:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:52:56 INFO - Running setup.py install for requests 15:52:56 INFO - Running setup.py install for docopt 15:52:56 INFO - Successfully installed blobuploader requests docopt 15:52:56 INFO - Cleaning up... 15:52:56 INFO - Return code: 0 15:52:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f70c012ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b91ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ef60>, '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 0x2b8fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b901d0>, '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': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', '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 15:52:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:52:56 INFO - Using env: {'DISPLAY': ':0', 15:52:56 INFO - 'HOME': '/home/cltbld', 15:52:56 INFO - 'LANG': 'en_US.UTF-8', 15:52:56 INFO - 'LANGUAGE': 'en_US:en', 15:52:56 INFO - 'LOGNAME': 'cltbld', 15:52:56 INFO - 'MAIL': '/var/mail/cltbld', 15:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:56 INFO - 'MOZ_NO_REMOTE': '1', 15:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:56 INFO - 'NO_EM_RESTART': '1', 15:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:56 INFO - 'PWD': '/builds/slave/test', 15:52:56 INFO - 'SHELL': '/bin/bash', 15:52:56 INFO - 'SHLVL': '1', 15:52:56 INFO - 'TERM': 'linux', 15:52:56 INFO - 'TMOUT': '86400', 15:52:56 INFO - 'USER': 'cltbld', 15:52:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', 15:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:56 INFO - '_': '/tools/buildbot/bin/python'} 15:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:57 INFO - Running setup.py (path:/tmp/pip-NOxyL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:57 INFO - Running setup.py (path:/tmp/pip-sS0sfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:57 INFO - Running setup.py (path:/tmp/pip-4RsahR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:57 INFO - Running setup.py (path:/tmp/pip-CZYLMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:57 INFO - Running setup.py (path:/tmp/pip-igSHzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:57 INFO - Running setup.py (path:/tmp/pip-kwptOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:57 INFO - Running setup.py (path:/tmp/pip-ysdJVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:57 INFO - Running setup.py (path:/tmp/pip-31dLyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:57 INFO - Running setup.py (path:/tmp/pip-OKEmEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:57 INFO - Running setup.py (path:/tmp/pip-4HAKRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:57 INFO - Running setup.py (path:/tmp/pip-MdnE3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:57 INFO - Running setup.py (path:/tmp/pip-trNSQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:57 INFO - Running setup.py (path:/tmp/pip-5wRyIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:58 INFO - Running setup.py (path:/tmp/pip-VdO9fS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:58 INFO - Running setup.py (path:/tmp/pip-Zx3DEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:58 INFO - Running setup.py (path:/tmp/pip-LG4Brd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:58 INFO - Running setup.py (path:/tmp/pip-7nzsDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:52:58 INFO - Running setup.py install for manifestparser 15:52:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:52:58 INFO - Running setup.py install for mozcrash 15:52:58 INFO - Running setup.py install for mozdebug 15:52:58 INFO - Running setup.py install for mozdevice 15:52:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:52:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:52:58 INFO - Running setup.py install for mozfile 15:52:58 INFO - Running setup.py install for mozhttpd 15:52:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:52:58 INFO - Running setup.py install for mozinfo 15:52:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:52:59 INFO - Running setup.py install for mozInstall 15:52:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:52:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:52:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:52:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:52:59 INFO - Running setup.py install for mozleak 15:52:59 INFO - Running setup.py install for mozlog 15:52:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:52:59 INFO - Running setup.py install for moznetwork 15:52:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:52:59 INFO - Running setup.py install for mozprocess 15:52:59 INFO - Running setup.py install for mozprofile 15:52:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:52:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:52:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:52:59 INFO - Running setup.py install for mozrunner 15:52:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:52:59 INFO - Running setup.py install for mozscreenshot 15:52:59 INFO - Running setup.py install for moztest 15:52:59 INFO - Running setup.py install for mozversion 15:53:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:53:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:53:00 INFO - Cleaning up... 15:53:00 INFO - Return code: 0 15:53:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:00 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')]} 15:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:00 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')]} 15:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:00 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 0x7f70c012ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b91ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ef60>, '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 0x2b8fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b901d0>, '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': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', '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 15:53:00 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 15:53:00 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 15:53:00 INFO - Using env: {'DISPLAY': ':0', 15:53:00 INFO - 'HOME': '/home/cltbld', 15:53:00 INFO - 'LANG': 'en_US.UTF-8', 15:53:00 INFO - 'LANGUAGE': 'en_US:en', 15:53:00 INFO - 'LOGNAME': 'cltbld', 15:53:00 INFO - 'MAIL': '/var/mail/cltbld', 15:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:00 INFO - 'MOZ_NO_REMOTE': '1', 15:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:00 INFO - 'NO_EM_RESTART': '1', 15:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:00 INFO - 'PWD': '/builds/slave/test', 15:53:00 INFO - 'SHELL': '/bin/bash', 15:53:00 INFO - 'SHLVL': '1', 15:53:00 INFO - 'TERM': 'linux', 15:53:00 INFO - 'TMOUT': '86400', 15:53:00 INFO - 'USER': 'cltbld', 15:53:00 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', 15:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:00 INFO - '_': '/tools/buildbot/bin/python'} 15:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:00 INFO - Running setup.py (path:/tmp/pip-wgMLMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:00 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)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:00 INFO - Running setup.py (path:/tmp/pip-mDVAvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:00 INFO - Running setup.py (path:/tmp/pip-sMHBiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:00 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)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:00 INFO - Running setup.py (path:/tmp/pip-EQ5E3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:00 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)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:00 INFO - Running setup.py (path:/tmp/pip-xOyG7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:00 INFO - Running setup.py (path:/tmp/pip-lgA5UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:00 INFO - Running setup.py (path:/tmp/pip-BRDp_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:00 INFO - Running setup.py (path:/tmp/pip-aVnf4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:00 INFO - Running setup.py (path:/tmp/pip-7RHxxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:00 INFO - Running setup.py (path:/tmp/pip-aI1E1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:01 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)) 15:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:01 INFO - Running setup.py (path:/tmp/pip-9rRR3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:01 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)) 15:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:01 INFO - Running setup.py (path:/tmp/pip-dtZyXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:01 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)) 15:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:01 INFO - Running setup.py (path:/tmp/pip-I7_LWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:01 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)) 15:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:01 INFO - Running setup.py (path:/tmp/pip-mVM6lC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:01 INFO - Running setup.py (path:/tmp/pip-y0gv55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:01 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)) 15:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:01 INFO - Running setup.py (path:/tmp/pip-wJ7MzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:01 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)) 15:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:01 INFO - Running setup.py (path:/tmp/pip-XHYOKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:01 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)) 15:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:53:01 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)) 15:53:01 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)) 15:53:01 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)) 15:53:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:01 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 15:53:01 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 15:53:01 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 15:53:01 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 15:53:01 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 15:53:01 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 15:53:03 INFO - Downloading blessings-1.6.tar.gz 15:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:53:03 INFO - Installing collected packages: blessings 15:53:03 INFO - Running setup.py install for blessings 15:53:03 INFO - Successfully installed blessings 15:53:03 INFO - Cleaning up... 15:53:03 INFO - Return code: 0 15:53:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:53:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:03 INFO - Reading from file tmpfile_stdout 15:53:03 INFO - Current package versions: 15:53:03 INFO - argparse == 1.2.1 15:53:03 INFO - blessings == 1.6 15:53:03 INFO - blobuploader == 1.2.4 15:53:03 INFO - docopt == 0.6.1 15:53:03 INFO - functools32 == 3.2.3-2 15:53:03 INFO - jsonschema == 2.5.1 15:53:03 INFO - manifestparser == 1.1 15:53:03 INFO - mozInstall == 1.12 15:53:03 INFO - mozcrash == 0.17 15:53:03 INFO - mozdebug == 0.1 15:53:03 INFO - mozdevice == 0.48 15:53:03 INFO - mozfile == 1.2 15:53:03 INFO - mozhttpd == 0.7 15:53:03 INFO - mozinfo == 0.9 15:53:03 INFO - mozleak == 0.1 15:53:03 INFO - mozlog == 3.4 15:53:03 INFO - moznetwork == 0.27 15:53:03 INFO - mozprocess == 0.23 15:53:03 INFO - mozprofile == 0.28 15:53:03 INFO - mozrunner == 6.12 15:53:03 INFO - mozscreenshot == 0.1 15:53:03 INFO - mozsystemmonitor == 0.3 15:53:03 INFO - moztest == 0.7 15:53:03 INFO - mozversion == 1.4 15:53:03 INFO - psutil == 3.1.1 15:53:03 INFO - requests == 1.2.3 15:53:03 INFO - wsgiref == 0.1.2 15:53:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f70c012ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b91ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ef60>, '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 0x2b8fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b901d0>, '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': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', '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 15:53:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:53:03 INFO - Using env: {'DISPLAY': ':0', 15:53:03 INFO - 'HOME': '/home/cltbld', 15:53:03 INFO - 'LANG': 'en_US.UTF-8', 15:53:03 INFO - 'LANGUAGE': 'en_US:en', 15:53:03 INFO - 'LOGNAME': 'cltbld', 15:53:03 INFO - 'MAIL': '/var/mail/cltbld', 15:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:03 INFO - 'MOZ_NO_REMOTE': '1', 15:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:03 INFO - 'NO_EM_RESTART': '1', 15:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:03 INFO - 'PWD': '/builds/slave/test', 15:53:03 INFO - 'SHELL': '/bin/bash', 15:53:03 INFO - 'SHLVL': '1', 15:53:03 INFO - 'TERM': 'linux', 15:53:03 INFO - 'TMOUT': '86400', 15:53:03 INFO - 'USER': 'cltbld', 15:53:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', 15:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:03 INFO - '_': '/tools/buildbot/bin/python'} 15:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:04 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)) 15:53:04 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)) 15:53:04 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)) 15:53:04 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)) 15:53:04 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)) 15:53:04 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)) 15:53:04 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)) 15:53:04 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)) 15:53:04 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)) 15:53:04 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)) 15:53:04 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)) 15:53:04 INFO - Cleaning up... 15:53:04 INFO - Return code: 0 15:53:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f70c012ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b91ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ef60>, '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 0x2b8fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b901d0>, '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': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', '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 15:53:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:53:04 INFO - Using env: {'DISPLAY': ':0', 15:53:04 INFO - 'HOME': '/home/cltbld', 15:53:04 INFO - 'LANG': 'en_US.UTF-8', 15:53:04 INFO - 'LANGUAGE': 'en_US:en', 15:53:04 INFO - 'LOGNAME': 'cltbld', 15:53:04 INFO - 'MAIL': '/var/mail/cltbld', 15:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:04 INFO - 'MOZ_NO_REMOTE': '1', 15:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:04 INFO - 'NO_EM_RESTART': '1', 15:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:04 INFO - 'PWD': '/builds/slave/test', 15:53:04 INFO - 'SHELL': '/bin/bash', 15:53:04 INFO - 'SHLVL': '1', 15:53:04 INFO - 'TERM': 'linux', 15:53:04 INFO - 'TMOUT': '86400', 15:53:04 INFO - 'USER': 'cltbld', 15:53:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', 15:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:04 INFO - '_': '/tools/buildbot/bin/python'} 15:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:53:04 INFO - Cleaning up... 15:53:04 INFO - Return code: 0 15:53:04 INFO - Running post-action listener: _resource_record_post_action 15:53:04 INFO - Running post-action listener: _start_resource_monitoring 15:53:04 INFO - Starting resource monitoring. 15:53:04 INFO - [mozharness: 2016-10-12 22:53:04.408699Z] Finished create-virtualenv step (success) 15:53:04 INFO - [mozharness: 2016-10-12 22:53:04.409207Z] Running install step. 15:53:04 INFO - Running pre-action listener: _resource_record_pre_action 15:53:04 INFO - Running main action method: install 15:53:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:04 INFO - Reading from file tmpfile_stdout 15:53:04 INFO - Detecting whether we're running mozinstall >=1.0... 15:53:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:53:04 INFO - Reading from file tmpfile_stdout 15:53:04 INFO - Output received: 15:53:04 INFO - Usage: mozinstall [options] installer 15:53:04 INFO - Options: 15:53:04 INFO - -h, --help show this help message and exit 15:53:04 INFO - -d DEST, --destination=DEST 15:53:04 INFO - Directory to install application into. [default: 15:53:04 INFO - "/builds/slave/test"] 15:53:04 INFO - --app=APP Application being installed. [default: firefox] 15:53:04 INFO - mkdir: /builds/slave/test/build/application 15:53:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:53:20 INFO - Reading from file tmpfile_stdout 15:53:20 INFO - Output received: 15:53:20 INFO - /builds/slave/test/build/application/firefox/firefox 15:53:20 INFO - Running post-action listener: _resource_record_post_action 15:53:20 INFO - [mozharness: 2016-10-12 22:53:20.919190Z] Finished install step (success) 15:53:20 INFO - [mozharness: 2016-10-12 22:53:20.919432Z] Running run-tests step. 15:53:20 INFO - Running pre-action listener: _resource_record_pre_action 15:53:20 INFO - Running main action method: run_tests 15:53:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:53:20 INFO - Python 2.7.3 15:53:20 INFO - Return code: 0 15:53:20 INFO - grabbing minidump binary from tooltool 15:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ef60>, '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 0x2b8fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b901d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:53:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:53:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:53:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:53:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:53:20 INFO - Return code: 0 15:53:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:53:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:53:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:53:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:53:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:53:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 15:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 15:53:21 INFO - Using env: {'DISPLAY': ':0', 15:53:21 INFO - 'HOME': '/home/cltbld', 15:53:21 INFO - 'LANG': 'en_US.UTF-8', 15:53:21 INFO - 'LANGUAGE': 'en_US:en', 15:53:21 INFO - 'LOGNAME': 'cltbld', 15:53:21 INFO - 'MAIL': '/var/mail/cltbld', 15:53:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:53:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:21 INFO - 'MOZ_NO_REMOTE': '1', 15:53:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:53:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:21 INFO - 'NO_EM_RESTART': '1', 15:53:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:21 INFO - 'PWD': '/builds/slave/test', 15:53:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:53:21 INFO - 'SHELL': '/bin/bash', 15:53:21 INFO - 'SHLVL': '1', 15:53:21 INFO - 'TERM': 'linux', 15:53:21 INFO - 'TMOUT': '86400', 15:53:21 INFO - 'USER': 'cltbld', 15:53:21 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1476312745.880938-1210367395', 15:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:21 INFO - '_': '/tools/buildbot/bin/python'} 15:53:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 15:53:21 INFO - mozversion application_buildid: 20161012142646 15:53:21 INFO - mozversion application_changeset: 22be4ae74653b25186665f22e52a50e7027fd36b 15:53:21 INFO - mozversion application_display_name: Nightly 15:53:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:53:21 INFO - mozversion application_name: Firefox 15:53:21 INFO - mozversion application_remotingname: firefox 15:53:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:53:21 INFO - mozversion application_vendor: Mozilla 15:53:21 INFO - mozversion application_version: 52.0a1 15:53:21 INFO - mozversion platform_buildid: 20161012142646 15:53:21 INFO - mozversion platform_changeset: 22be4ae74653b25186665f22e52a50e7027fd36b 15:53:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:53:21 INFO - mozversion platform_version: 52.0a1 15:53:21 INFO - using testdate: 1476312801 15:53:21 INFO - actual date: 1476312801 15:53:21 INFO - starting webserver on 'localhost:54780' 15:53:21 INFO - SUITE-START | Running 2 tests 15:53:21 INFO - TEST-START | dromaeo_css 15:53:21 INFO - operating with platform_type : linux_ 15:53:21 INFO - Initialising browser for dromaeo_css test... 15:53:21 INFO - TEST-INFO | started process 27700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprwp158/profile http://localhost:54780/getInfo.html) 15:53:25 INFO - PROCESS | 27700 | __metrics Screen width/height:1600/1200 15:53:25 INFO - PROCESS | 27700 | colorDepth:24 15:53:25 INFO - PROCESS | 27700 | Browser inner width/height: 1024/697 15:53:25 INFO - PROCESS | 27700 | __metrics 15:53:26 ERROR - PROCESS | 27700 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 15:53:27 INFO - TEST-INFO | 27700: exit 0 15:53:27 INFO - Browser initialized. 15:53:27 INFO - Running cycle 1/1 for dromaeo_css test... 15:53:27 INFO - TEST-INFO | started process 27824 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprwp158/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:39 INFO - PROCESS | 27824 | RSS: Main: 186089472 15:53:39 INFO - PROCESS | 27824 | 15:54:29 INFO - PROCESS | 27824 | 1476312869621 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] 15:56:44 INFO - PROCESS | 27824 | Cycle 1(1): loaded http://localhost:54780/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54780/tests/dromaeo/cssquery-ext.html) 15:56:45 INFO - PROCESS | 27824 | RSS: Main: 199294976 15:56:45 INFO - PROCESS | 27824 | 15:59:48 INFO - PROCESS | 27824 | Cycle 1(1): loaded http://localhost:54780/tests/dromaeo/cssquery-ext.html (next: http://localhost:54780/tests/dromaeo/cssquery-jquery.html) 15:59:48 INFO - PROCESS | 27824 | RSS: Main: 200544256 15:59:48 INFO - PROCESS | 27824 | 16:02:50 INFO - PROCESS | 27824 | Cycle 1(1): loaded http://localhost:54780/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54780/tests/dromaeo/cssquery-mootools.html) 16:02:51 INFO - PROCESS | 27824 | RSS: Main: 202747904 16:02:51 INFO - PROCESS | 27824 | 16:05:53 INFO - PROCESS | 27824 | Cycle 1(1): loaded http://localhost:54780/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54780/tests/dromaeo/cssquery-prototype.html) 16:05:54 INFO - PROCESS | 27824 | RSS: Main: 196407296 16:05:54 INFO - PROCESS | 27824 | 16:08:56 INFO - PROCESS | 27824 | Cycle 1(1): loaded http://localhost:54780/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54780/tests/dromaeo/cssquery-yui.html) 16:08:57 INFO - PROCESS | 27824 | RSS: Main: 198586368 16:08:57 INFO - PROCESS | 27824 | 16:12:00 INFO - PROCESS | 27824 | Cycle 1(1): loaded http://localhost:54780/tests/dromaeo/cssquery-yui.html (next: http://localhost:54780/tests/dromaeo/cssquery-dojo.html) 16:12:00 INFO - PROCESS | 27824 | RSS: Main: 199557120 16:12:00 INFO - PROCESS | 27824 | 16:12:00 INFO - PROCESS | 27824 | __start_tp_report 16:12:00 INFO - PROCESS | 27824 | _x_x_mozilla_page_load 16:12:00 INFO - PROCESS | 27824 | _x_x_mozilla_page_load_details 16:12:00 INFO - PROCESS | 27824 | |i|pagename|runs| 16:12:00 INFO - PROCESS | 27824 | |0;dojo.html;2605.1012400721743;2618.9214323570286;2623.803214758893;2643.7224091470403;2671.345520347515;4696.671233013691;4749.643776716743;4786.521347865212;4801.783919723612;4821.879453013672;4582.839600613979;4706.270528068147;4735.621150307976;4745.003549254652;4771.427428708551;4341.6309613682715;4353.7387756734615;4440.267355886275;4443.289073748201;4514.909701805962;4359.956400436003;4434.445694288214;4471.061077173781;4529.886752831189;4557.794899229542;4311.504177019651;4329.783510824446;4352.586504282088;4388.166248412791;4437.223485889988;4353.804078816461;4355.368471571636;4358.4769827620885;4365.80353884076;4459.0413061192;4390.473143222834;4406.493253275882;4417.801198946023;4423.159599676083;4450.933236001462;4694.671373003891;4745.738984355859;4793.84947612574;4809.302651115604;4832.275158726184;5095.719735414551;5117.692938423706;5127.589792816566;5140.9228861566735;5149.716765577892;5119.6160287978555;5130.615203859688;5132.5124113209185;5142.640015198937;5200.115980283361;4690.835820746258;4725.5510726480925;4765.332853400527;4772.80908763649;4779.474257831635;5238.607104467104;5269.446708095671;5272.156454967264;5303.390110137384;5305.946940530545;5049.873753156127;5050.974745126251;5061.139606266944;5070.188769796815;5125.923111153335;5007.724575148329;5027.4721154279005;5062.544371006627;5124.333836601218;5128;5014.84955451337;5020;5021.799128034838;5044.4198917125;5078.111330517145;4942.184539551005;4956.132676781549;4981.402231732215;4989.90020199594;5055.87360315995;4139.710220284612;4180.958190418118;4181.874543763692;4220.177065472203;4240.469941257343;3686.6313368663455;3718.7396882218527;3760.52993375828;3767.05823544114;3768.2651882883124;4437.134758722018;4462.576055274743;4465.749590114773;4497.8200871964755;4522.932156017662;5019.749012549358;5068.341115654941;5164.567469944984;5165;5169.862630221345;4436.44544431946;4456.799444025027;4475.373447717322;4482.641388688897;4482.775861206992;4492.887677808016;4502.144592527409;4537.636989040869;4572.611328037087;4605.6776025678555;4806.927896081562;4825.30033145199;4826.131296366688;4827.08285425768;4881.219004959332;5188.325517682677;5202.713850738246;5204.0372531081875;5210;5256.816011439581;4732.219183834629;4736.478987311324;4905.23968784839;4959.107360674969;4970.65205435616;4971.65198436106;5028.597712182944;5081.8475445736685;5135.563477104488;5228.37259528859;5186.092433824141;5188.558972487381;5241.554467870274;5283.973580132075;5316.494932981361;5057.367829021372;5079.415867175322;5091.796328146833;5103.387593488805;5156.896862062813;4880.877978050435;4954.851354459372;4971.875703107451;4999.725015124203;5003.77483013258;4922.458529561817;4950.900981980269;4951.678140920829;4956.7769450375545;4979.128652485873;5038.093143234253;5049.57078648319;5052.747362631927;5055.469175736494;5111.131107711623;4834.854954351375;4885.2427873679635;4903.656744027884;4945.480724524017;4987.501249874984 16:12:00 INFO - PROCESS | 27824 | |1;ext.html;518.5022378516624;519.177104289701;522.4279414041624;525.1309083466862;534.3267482971455;38101;39970.600293997086;39998.60001399985;40011.799941000325;40190.397144042865;39845.410048346836;39927;40694.186116277655;40906.59093409065;40924.59075409245;7554.244575542443;7702.152763196044;7705.267999540035;7718.957940678021;7736.574488403136;7559.28186822251;7584.279493448141;7598.4301177411635;7662.846743065135;7679.57762323072;7432.628368581576;7563.168051514329;7573.5834529100875;7575.507592006529;7575.507592006529;7572.848543029136;7671.731489397845;7675.04061992251;7675.808104797369;7679.078510578711;7524.849503009964;7581.696732130708;7591.468597198198;7600.885986710204;7620.123685776151;37593.436098458544;37712.43431348532;37741.056473588105;37752.43371349432;37810.43284350737;3071.2014876132366;3138.98430507846;3189.521571764231;3324.933501329984;3347.6484969078138;27177.320566985785;28109.718902810913;28583.14250572486;28833.85583072092;29691.109266722033;3019.7886147969652;3214.3089235814177;3248.788828726149;3260.396826587089;3290.276139249361;244623;245275;246379;246423;246804;32792;34219.657803422146;54777;55288.17067743987;55358;32950;33067.83466082654;33269.66730332714;33275.33449331048;33347;12930.612081637566;13086.280254586089;13093.345332733325;13119.475220991053;13126.343682815821;9712.9028709712;9731.270154738282;10640;10876.564937402416;10887.074598659203;17686.646267074844;17719.379821706178;17720.9113954432;17837.643247134984;17929.820701793076;6586.80239592813;6748.628825414649;6765.492588055817;6955.852284373022;6961.895571566431;790.8260182759784;866.4844417571535;936.4521754773534;948.2115317645861;982.8574856645746;26058.34854128624;27524.862375687993;27611;27925.364641049495;28410.85794571014;938.1181689212119;951.571792693277;958.4009993753904;960.4237457525429;1019.2277006542193;14405.692116359309;14921.179335136454;15074.54776356711;15078.924605376902;15183.16492592918;346862;348177;349298;350048;351363;49062.26406603904;49702.751486242334;49821.25268120981;49888;49907.25139122916;1120.7366268926796;1125.9099272058215;1146.3179408252076;1165.5454372794618;1180.5454899863614;26036.21891343263;27274.863625681744;27654.44691106207;28308.292292692022;28368.85815570909;42921;46046.53953460557;48401.27398088961;48435.27347089726;52563;344688;347737;348247;348297;348719;36340.636593633724;37102.25795484129;37423.2515349686;37532.437013445364;37990.24019519649;41323.380149298384;41941.370879436225;42529.14941701211;42600;43169.784151079046;35412.822935886186;35611.82194089013;35850.28299434049;36190.63809361873;36674.26651467009;35212.29575408426;35803.10492237611;35858.8207058963;36238.4564231542;36440.635593643725;29672.406551869273;35173.47239791354;35201;35286;35401.468977965866;31442.371152577278;32687.836560817042;33554.16114597155;33820.492692609136;33874.66125338715;24988.250352489453;25213;25272.494550108528;25800.612990804777;25826.870865646302 16:12:00 INFO - PROCESS | 27824 | |2;jquery.html;360.96390360963926;371.05196223648574;372.68321926362586;382.546682181615;393.51204506412057;15178.165200913945;15431.845681543182;16646.167691615432;16727.581810454714;16739.330426782944;15809.367625295003;15963.361465541393;16030.118343491104;16344.673106537863;16412.343506259764;4778.378810754597;5044.445111037801;5052.595792336604;5055.69665820052;5058.873528161807;4849.903001939959;4959.578435832958;5008.223725322581;5011.123053465647;5012.573931215851;5043.39479262489;5301.231321458386;5329.307190065306;5396.730163491829;5402.37872644645;5126.256692779526;5284.207368894658;5286;5290.603204759658;5351.491608297206;5131.846044618667;5131.871703207413;5155.381354237478;5155.7679904404395;5158.329417175781;11772;11985.52057917691;13645.658858528517;19350.709739353922;19467.80532194674;1821.353419536059;1828.6159906419668;1832.4869036669754;1844.0595296398799;1857.3406440713488;8460.83078338436;8873.689420870238;9227.215686666641;9423.717288481357;9459.385139965949;1642.8603568696556;1666.1086318819493;1706.436875830973;1752.2377765671974;1762.7179651255865;61906.71399290097;63898.6805065981;67581.66209168972;68135.61525346589;68918.65540672315;9425.952870235606;9480.620775169054;9577.664781732607;9791.118799308097;9794.363366381162;12909.54816581415;12937.611871643865;12965.805512917314;12968.157069790623;12986;6702.597844129368;6824.931750682529;6943.305669433117;7017.122859642544;7045.929540704527;6460.580062295936;6468.870622587616;6494.967525162344;6675.165604299463;6684.598924064571;4070.3283958147167;4074;4151.626353628188;4165.146145040259;4176.18564379943;1789.3200583778082;1811.855051595869;1821.1531637788491;1824.9908750456163;1839.5916006939556;369.52700543304616;374.3411595591778;391.6220846882772;731.3089130771476;797.6330887791681;10112;10113.64602238918;10350.430726309974;10460.163186945027;10591.258611897247;391.0673044788144;393.9527256729211;396.74608250719564;398.33676927915275;400.1676512853258;5433.782648694087;5504.504594586507;5528.391876893538;5642.23829782974;5739.7704091836695;390153;394165;395916;401600.8399160119;403126;77821.61089194518;78338.60830695811;78588.60705696435;79019.60490197512;80310.59844700739;405.8498355608444;417.9435776170178;418.5166133116256;419.26209870627304;419.55317586770605;9528.182299100727;9627.326087174111;9638.469884156439;9640.276979226446;9641.27690423207;35528.822355888056;35845.462318064725;35952.64047359493;35984.460233097045;36331.45502817513;52806.73596632146;52890.47109528856;52907.470925290254;53183.46816531785;53464.198037030255;7013.754518591825;7103.289671032855;7253.274672532704;7273.3817625502425;7547.886781698388;10065.949670251603;10804.351738895692;11146.944265278622;11594.130440217186;11704.239224450383;9379.249660027317;9539.761505962406;9668.129868311886;10104.69685909424;10274.640387586398;8887.555622218733;9493;9668.613255469703;9926.404415735078;10033;9808.264380171659;10047.145992590711;10113.494325283853;10538.473076346;10917.617883374043;7305.634718263959;7483.251674832691;7543;7638.197989211053;7732.652030658522;9478.85781713261;9530.523473826142;10018.749531261778;10128.189744820544;10177.84733229017 16:12:00 INFO - PROCESS | 27824 | |3;mootools.html;1343.832020997375;1374.0107122871532;1446.5515690136058;1636.3536403120775;1650.818409974902;6753.898691519631;7015.6141412222305;7370.520916140454;8043.477173983694;8088.676452941882;7469.253074692541;7716.228377162295;7739.342155916754;7920.049594048723;7951.801204969878;2186.7813218678125;2221.1226565506613;2222.4777177363308;2224.1992882562263;2224.232639739287;2163.2969284982364;2199.0324257326806;2199.736031676201;2210.292706333974;2212.048819007826;2160.956780864382;2181.683655869898;2187.2344679362177;2203.22886989554;2216.3018649125556;2086.739157605299;2095.9266425675182;2098.98950505248;2099.2967355935625;2107.2097963263777;2089.3940757180553;2119.0782009825775;2138.2516119358256;2144.1209104267177;2149.451889768099;7644.923550764477;7657.846843063107;7715.842623606504;7734.419918506134;7887.211278872124;4441.75570343631;4569.223232050559;4569.702969306984;4570.245909424941;4578.130155270488;2754.4215714699935;2866.1688110447944;2900.825950442959;2918.7664986801005;2921.415716856637;868.3877866104444;900.7448467001547;914.7575892388522;930.4556834251971;930.6370515498893;10563.049325560736;10569.735756605993;10597.470126493645;10658.200634952409;10691.83962240567;3892.1631849152;4029.7985100744845;4183.3515805050265;4190.622843944059;4197.223513649985;8861.24679402258;8907.55462226886;8932.46405215689;8937.195652391316;8938.776530586787;4617.307403889444;4656.557627025427;4678.883027924261;4683.039976804746;4716.764161791897;3636.381815091441;3763.5860055393887;4145.875623731293;4251.787410629456;4261.296886013835;3535.487354333607;3580.1944562473755;3655.469956856294;3718.0890681783135;3733.0667333166707;1156.653004098767;1188.3404710385819;1196.8623608284984;1203.8976686981705;1207.1791181996152;801.2308184143287;810.3395732478011;826.8759686047141;840.1640367833922;851.9265725186186;5244.265802787613;5269.631125821233;5363.892722145613;5401.513863752281;5538.335399752055;372.43204113726784;378.7594877252909;381.5154753463086;384.63263099680904;386.6230425335332;3550.343186510504;3871.6128387161057;3874.4575759393706;3883.126296583246;3893.260280546687;9613.807723845484;9722.416655000723;9741.269404794668;9767;9825.164860986895;9706.077922597342;9764.316497845224;9770.951145244371;9775.462349570842;9782.853257201148;6582.275949645536;6801.18385793708;6898.379145876795;7067.37450386414;7154.35610795031;5180.896382072413;5414.918776218281;5444.673319600836;5524.281843360337;5737.569682273763;8827.735167944971;8844.601992910206;8886.911130888608;8898.955505222433;9014.909850901407;8876.423032502867;9050.728478145666;9276.582553784961;9299;9310.95344523273;5532.557395408438;5758.107493338539;6555.311692272243;6663.500237482305;6714.261431242462;7212.927870721225;7421.962890185515;7517.812054698677;7638.15980242184;7654.387648988179;6427.292997770148;6439.388258115471;6575.013747937847;6670.39966403026;6816.591004539545;6614.305497922649;6734.6632668367365;6751.324867513209;6785.1518560179975;6890.621015843976;6201.410865967726;6280.842978925563;6301.684915754286;6313.652749098844;6317.084022816758;4421.624161946142;4486.12520558488;4641.837535686234;4767.499412561631;4811.206150985048;4746.881327966828;4821.4696383397095;4871.756412179306;4928.8767780805765;4952.603791696728 16:12:00 INFO - PROCESS | 27824 | |4;prototype.html;288.13128417820263;294.2716775979451;301.5190770720701;303.35688340717655;305.03000458541834;4782.689125206868;4925.1627223372025;4929.728864912428;5001.574866136379;5011.649184557083;4742.241241401368;4845.418549774024;4885.951140488594;4889.291052797343;4897.142999975008;3864.1645218521257;3864.478295430109;3867.9806600967095;3869.5743468218475;3875.507929447169;3687.6496732810474;3867.361885288924;3879.2241551689776;3881.5536213335404;3885.669718073967;3804.733668643182;3832.4442955771397;3835.8273877675433;3843.9044872211425;3851.9229615407817;3829.885103446901;3834.194819087967;3841.4621952926755;3847.2882516734494;3863.9613603864163;3419.5383623210796;3420.6237313895454;3428.2286485540803;3432.8970130896114;3435.6220815710253;4646.233371493699;4770.7376094314795;4778.4982576829625;4846.0550192712435;4847.781849816767;4379.540148284448;4385.802638881226;4386.561343865588;4398.186335527937;4404.414410812105;5137.743112844343;5138.332016837787;5141.820036298749;5152.227165925141;5163.277141200235;3647.3802428611657;3656.8171591420587;3692.5015122958325;3705.370087085175;3720.7395482316247;5342.866428339284;5363.195520671852;5366.356037275513;5366.382865970424;5407.810726624589;3786.2995345861104;3801;3823.2162406706557;3831.214601006787;3833.923321533554;3898;3899.883003509899;3919.725619206685;3922.5685174630767;3934.370500719871;4143.772092534879;4262.296721040993;4334.32817913224;4347.478302603708;4421.977890110529;5107.642465027487;5130.743462826844;5136.4606716295;5138.820141295037;5152.098382783073;1260.3552364164852;1299.6101169649066;1304.6542666193466;1332.9000324975666;1335.4858379523953;867.5141920524527;884.9424937200113;898.6630013744846;899.9235065019546;905.9501727405056;4456.286994080931;4477.932831007537;4483.215437298525;4485.452518881046;4486.7083639563325;5121.590272778169;5130.589552835764;5138.537531622172;5152.948470515322;5158.509941555546;4439.733615983051;4470.803375586472;4492.663050271242;4501.842435514741;4503.639708823286;2339.684142640722;2462.6429167770575;2471.826972111935;2485.8553929279474;2489.191012920808;4401.40581021558;4410.405519501596;4430.933535996963;4461.732296062247;4469.664775141812;4693.0992947856175;4742.33607294979;4752.762361881962;4757.548032936866;4762.928556071662;4465.910681786346;4697.647676424282;5007.549320561167;5038.899222015612;5052.646314757932;5345.812896548602;5355.812546561007;5355.9464405357;5363;5393.8112166074;5152.818117494474;5257.842264731911;5261.7895284189735;5267.947320526899;5269.420363759907;4990.15167421532;5013.699178049329;5033.496650334937;5044.192929131322;5069.7211653357945;3704.870329538453;3751.756135851161;3762.9247415051;3765.4916586260506;3766.1902690921584;5102.856800144023;5377.327834020747;5417.079096553516;5429.7556609953435;5444;4798.760061996956;5163.160261856039;5173.81891633791;5178.404483484297;5200.947990520198;5178.197379406198;5182.533571978389;5192.364405212346;5204.73976301191;5214.400343960493;4911.484294149206;5093.388793344822;5109.182530795055;5114.5652619527755;5139.383274006994;5211.583073354198;5219.895602087861;5220.451852555427;5263.7894484220205;5266.682659629751;5052.520010598987;5093.261477085876;5109.46350633193;5113.667611605234;5137.458762371199 16:12:00 INFO - PROCESS | 27824 | |5;yui.html;638.3361304243587;724.7137380734607;738.2912404092071;742.5804420502416;751.3763576231728;12818.615441536756;13426.798598021038;13455.990800689951;13477.123986940867;13502.324883755822;13029.869701302983;13089.280089595093;13092.083554151213;13230.073894827367;13236.205827650349;595.9284885813709;610.1427494370416;721.2354903801987;728.2499026003212;746.7349091072673;745.3925051083377;754.6830331260857;757.7120694136221;758;758.7609902880603;805.19078326282;810.9675612975503;812.6343145584481;813.1137060603941;813.9064007639138;795.9999999999972;797.9785874081185;798.6805277888833;804.7505273365247;805.6092794994423;586.378438854811;586.8679547101868;587.5358466811214;588.2558563417281;589.1722130406786;12666.80999785004;12795.04037197214;12830.486780528861;12847.614571562868;12854.293013884233;13436;13494.595162145151;13851;13984.720305593832;14212.360443780055;10650.733731656694;10820.188485863513;10869;10908.454577271104;10989.670309890636;3335.31626016666;3345.0466617014035;3389.796612203276;3406.659334066598;3471.7743346682387;60653.6967315165;61820.381796181915;62551;62557.374426256065;63343.99999999954;9998.900010999942;10111.848322275171;10112.848307275397;10155.238357123246;10417.010384013658;20035.799642003683;20184.293549725982;20250.594988100154;20298.391048268575;20426.59146817085;6273.8807494383345;6398.136251606066;6400.807975760735;6455.160829092188;6569.835754106186;3333.749968752353;3344.4314466540745;3345.9498107528407;3398.1844357354057;3412.77816941898;2643.1806140096633;2735.9452810944067;2737.0283549340097;2740.8355498670144;3065.4482193205436;508.9745512724349;513.4993381453054;516.8475299786497;521.1947541049088;529.1242992846844;462.51898026052527;553.7784886045614;614.7786796753165;616.8519555306784;632.4118569730103;7694.192109828499;7793;7863.13505514393;7895.881561776578;7983.081945576333;502.4777006937562;553.6152374100043;585.9179714839926;607.1287702147345;608.3429895712708;3504.299140171976;3921.9803900980883;3984.4820173377275;3991.940120898189;4099.8360065597635;87248.12751872528;95781.52109239409;98233;99865;100242.4987875056;85638;86210;86456.54173833103;87315.56342218249;88447.55776221206;48327.4757907678;69801.25496862619;76938.23061769422;77095.22904770993;77510.61244693854;7240.52936559122;7437.293457121565;7581.3176814087;7617.54294742295;7775.261350171724;41404.171916560896;47739.76130119327;48740;48918.75540622274;50903.490965091354;37469.43795843119;42337.57662423459;57759.4224057754;58391.70804145952;60181.69909150426;10472.842907356548;10513.316634418738;10628.627998020032;10798.894215627877;10891.67324980252;12411.62765117048;12420.565280215149;12622.936885315514;12821.102522823312;12975.740485190432;10501.159907207559;10785.245032847626;10948.124150067817;10964.835527467254;10989.340639561651;10034.69895903124;10155.593776248867;10184.18526517862;10469.424181670081;10557.15542756593;10421.166306695597;11090.334579925231;11241.49413276388;11498.597549085742;11528.59649912249;8834.249088827522;8889.244414224864;9412.811743765224;9558.426494410358;9743.366681165702;7964.880526792219;8613.741587752378;9009.54952252398;9279.334662808287;9381.343305968516 16:12:00 INFO - PROCESS | 27824 | __end_tp_report 16:12:00 INFO - PROCESS | 27824 | __start_cc_report 16:12:00 INFO - PROCESS | 27824 | _x_x_mozilla_cycle_collect,352 16:12:00 INFO - PROCESS | 27824 | __end_cc_report 16:12:00 INFO - PROCESS | 27824 | __startTimestamp1476313920815__endTimestamp 16:12:00 INFO - PROCESS | 27824 | 16:12:00 INFO - PROCESS | 27824 | ------- Summary: start ------- 16:12:00 INFO - PROCESS | 27824 | Number of tests: 6 16:12:00 INFO - PROCESS | 27824 | 16:12:00 INFO - PROCESS | 27824 | [#0] dojo.html Cycles:165 Average:4732.00 Median:4880.88 stddev:513.05 (10.5%) stddev-sans-first:486.74 16:12:00 INFO - PROCESS | 27824 | Values: 2605.1 2618.9 2623.8 2643.7 2671.3 4696.7 4749.6 4786.5 4801.8 4821.9 4582.8 4706.3 4735.6 4745.0 4771.4 4341.6 4353.7 4440.3 4443.3 4514.9 4360.0 4434.4 4471.1 4529.9 4557.8 4311.5 4329.8 4352.6 4388.2 4437.2 4353.8 4355.4 4358.5 4365.8 4459.0 4390.5 4406.5 4417.8 4423.2 4450.9 4694.7 4745.7 4793.8 4809.3 4832.3 5095.7 5117.7 5127.6 5140.9 5149.7 5119.6 5130.6 5132.5 5142.6 5200.1 4690.8 4725.6 4765.3 4772.8 4779.5 5238.6 5269.4 5272.2 5303.4 5305.9 5049.9 5051.0 5061.1 5070.2 5125.9 5007.7 5027.5 5062.5 5124.3 5128.0 5014.8 5020.0 5021.8 5044.4 5078.1 4942.2 4956.1 4981.4 4989.9 5055.9 4139.7 4181.0 4181.9 4220.2 4240.5 3686.6 3718.7 3760.5 3767.1 3768.3 4437.1 4462.6 4465.7 4497.8 4522.9 5019.7 5068.3 5164.6 5165.0 5169.9 4436.4 4456.8 4475.4 4482.6 4482.8 4492.9 4502.1 4537.6 4572.6 4605.7 4806.9 4825.3 4826.1 4827.1 4881.2 5188.3 5202.7 5204.0 5210.0 5256.8 4732.2 4736.5 4905.2 4959.1 4970.7 4971.7 5028.6 5081.8 5135.6 5228.4 5186.1 5188.6 5241.6 5284.0 5316.5 5057.4 5079.4 5091.8 5103.4 5156.9 4880.9 4954.9 4971.9 4999.7 5003.8 4922.5 4950.9 4951.7 4956.8 4979.1 5038.1 5049.6 5052.7 5055.5 5111.1 4834.9 4885.2 4903.7 4945.5 4987.5 16:12:00 INFO - PROCESS | 27824 | 16:12:00 INFO - PROCESS | 27824 | [#1] ext.html Cycles:180 Average:46556.97 Median:35854.55 stddev:83577.10 (233.1%) stddev-sans-first:83740.07 16:12:00 INFO - PROCESS | 27824 | Values: 518.5 519.2 522.4 525.1 534.3 38101.0 39970.6 39998.6 40011.8 40190.4 39845.4 39927.0 40694.2 40906.6 40924.6 7554.2 7702.2 7705.3 7719.0 7736.6 7559.3 7584.3 7598.4 7662.8 7679.6 7432.6 7563.2 7573.6 7575.5 7575.5 7572.8 7671.7 7675.0 7675.8 7679.1 7524.8 7581.7 7591.5 7600.9 7620.1 37593.4 37712.4 37741.1 37752.4 37810.4 3071.2 3139.0 3189.5 3324.9 3347.6 27177.3 28109.7 28583.1 28833.9 29691.1 3019.8 3214.3 3248.8 3260.4 3290.3 244623.0 245275.0 246379.0 246423.0 246804.0 32792.0 34219.7 54777.0 55288.2 55358.0 32950.0 33067.8 33269.7 33275.3 33347.0 12930.6 13086.3 13093.3 13119.5 13126.3 9712.9 9731.3 10640.0 10876.6 10887.1 17686.6 17719.4 17720.9 17837.6 17929.8 6586.8 6748.6 6765.5 6955.9 6961.9 790.8 866.5 936.5 948.2 982.9 26058.3 27524.9 27611.0 27925.4 28410.9 938.1 951.6 958.4 960.4 1019.2 14405.7 14921.2 15074.5 15078.9 15183.2 346862.0 348177.0 349298.0 350048.0 351363.0 49062.3 49702.8 49821.3 49888.0 49907.3 1120.7 1125.9 1146.3 1165.5 1180.5 26036.2 27274.9 27654.4 28308.3 28368.9 42921.0 46046.5 48401.3 48435.3 52563.0 344688.0 347737.0 348247.0 348297.0 348719.0 36340.6 37102.3 37423.3 37532.4 37990.2 41323.4 41941.4 42529.1 42600.0 43169.8 35412.8 35611.8 35850.3 36190.6 36674.3 35212.3 35803.1 35858.8 36238.5 36440.6 29672.4 35173.5 35201.0 35286.0 35401.5 31442.4 32687.8 33554.2 33820.5 33874.7 24988.3 25213.0 25272.5 25800.6 25826.9 16:12:00 INFO - PROCESS | 27824 | 16:12:00 INFO - PROCESS | 27824 | [#2] jquery.html Cycles:180 Average:23646.65 Median:4983.90 stddev:65672.50 (1317.7%) stddev-sans-first:65833.46 16:12:00 INFO - PROCESS | 27824 | Values: 361.0 371.1 372.7 382.5 393.5 15178.2 15431.8 16646.2 16727.6 16739.3 15809.4 15963.4 16030.1 16344.7 16412.3 4778.4 5044.4 5052.6 5055.7 5058.9 4849.9 4959.6 5008.2 5011.1 5012.6 5043.4 5301.2 5329.3 5396.7 5402.4 5126.3 5284.2 5286.0 5290.6 5351.5 5131.8 5131.9 5155.4 5155.8 5158.3 11772.0 11985.5 13645.7 19350.7 19467.8 1821.4 1828.6 1832.5 1844.1 1857.3 8460.8 8873.7 9227.2 9423.7 9459.4 1642.9 1666.1 1706.4 1752.2 1762.7 61906.7 63898.7 67581.7 68135.6 68918.7 9426.0 9480.6 9577.7 9791.1 9794.4 12909.5 12937.6 12965.8 12968.2 12986.0 6702.6 6824.9 6943.3 7017.1 7045.9 6460.6 6468.9 6495.0 6675.2 6684.6 4070.3 4074.0 4151.6 4165.1 4176.2 1789.3 1811.9 1821.2 1825.0 1839.6 369.5 374.3 391.6 731.3 797.6 10112.0 10113.6 10350.4 10460.2 10591.3 391.1 394.0 396.7 398.3 400.2 5433.8 5504.5 5528.4 5642.2 5739.8 390153.0 394165.0 395916.0 401600.8 403126.0 77821.6 78338.6 78588.6 79019.6 80310.6 405.8 417.9 418.5 419.3 419.6 9528.2 9627.3 9638.5 9640.3 9641.3 35528.8 35845.5 35952.6 35984.5 36331.5 52806.7 52890.5 52907.5 53183.5 53464.2 7013.8 7103.3 7253.3 7273.4 7547.9 10065.9 10804.4 11146.9 11594.1 11704.2 9379.2 9539.8 9668.1 10104.7 10274.6 8887.6 9493.0 9668.6 9926.4 10033.0 9808.3 10047.1 10113.5 10538.5 10917.6 7305.6 7483.3 7543.0 7638.2 7732.7 9478.9 9530.5 10018.7 10128.2 10177.8 16:12:00 INFO - PROCESS | 27824 | 16:12:00 INFO - PROCESS | 27824 | [#3] mootools.html Cycles:180 Average:5107.78 Median:5212.58 stddev:2882.68 (55.3%) stddev-sans-first:2876.89 16:12:00 INFO - PROCESS | 27824 | Values: 1343.8 1374.0 1446.6 1636.4 1650.8 6753.9 7015.6 7370.5 8043.5 8088.7 7469.3 7716.2 7739.3 7920.0 7951.8 2186.8 2221.1 2222.5 2224.2 2224.2 2163.3 2199.0 2199.7 2210.3 2212.0 2161.0 2181.7 2187.2 2203.2 2216.3 2086.7 2095.9 2099.0 2099.3 2107.2 2089.4 2119.1 2138.3 2144.1 2149.5 7644.9 7657.8 7715.8 7734.4 7887.2 4441.8 4569.2 4569.7 4570.2 4578.1 2754.4 2866.2 2900.8 2918.8 2921.4 868.4 900.7 914.8 930.5 930.6 10563.0 10569.7 10597.5 10658.2 10691.8 3892.2 4029.8 4183.4 4190.6 4197.2 8861.2 8907.6 8932.5 8937.2 8938.8 4617.3 4656.6 4678.9 4683.0 4716.8 3636.4 3763.6 4145.9 4251.8 4261.3 3535.5 3580.2 3655.5 3718.1 3733.1 1156.7 1188.3 1196.9 1203.9 1207.2 801.2 810.3 826.9 840.2 851.9 5244.3 5269.6 5363.9 5401.5 5538.3 372.4 378.8 381.5 384.6 386.6 3550.3 3871.6 3874.5 3883.1 3893.3 9613.8 9722.4 9741.3 9767.0 9825.2 9706.1 9764.3 9771.0 9775.5 9782.9 6582.3 6801.2 6898.4 7067.4 7154.4 5180.9 5414.9 5444.7 5524.3 5737.6 8827.7 8844.6 8886.9 8899.0 9014.9 8876.4 9050.7 9276.6 9299.0 9311.0 5532.6 5758.1 6555.3 6663.5 6714.3 7212.9 7422.0 7517.8 7638.2 7654.4 6427.3 6439.4 6575.0 6670.4 6816.6 6614.3 6734.7 6751.3 6785.2 6890.6 6201.4 6280.8 6301.7 6313.7 6317.1 4421.6 4486.1 4641.8 4767.5 4811.2 4746.9 4821.5 4871.8 4928.9 4952.6 16:12:00 INFO - PROCESS | 27824 | 16:12:00 INFO - PROCESS | 27824 | [#4] prototype.html Cycles:180 Average:4240.38 Median:4747.55 stddev:1235.95 (26.0%) stddev-sans-first:1203.29 16:12:00 INFO - PROCESS | 27824 | Values: 288.1 294.3 301.5 303.4 305.0 4782.7 4925.2 4929.7 5001.6 5011.6 4742.2 4845.4 4886.0 4889.3 4897.1 3864.2 3864.5 3868.0 3869.6 3875.5 3687.6 3867.4 3879.2 3881.6 3885.7 3804.7 3832.4 3835.8 3843.9 3851.9 3829.9 3834.2 3841.5 3847.3 3864.0 3419.5 3420.6 3428.2 3432.9 3435.6 4646.2 4770.7 4778.5 4846.1 4847.8 4379.5 4385.8 4386.6 4398.2 4404.4 5137.7 5138.3 5141.8 5152.2 5163.3 3647.4 3656.8 3692.5 3705.4 3720.7 5342.9 5363.2 5366.4 5366.4 5407.8 3786.3 3801.0 3823.2 3831.2 3833.9 3898.0 3899.9 3919.7 3922.6 3934.4 4143.8 4262.3 4334.3 4347.5 4422.0 5107.6 5130.7 5136.5 5138.8 5152.1 1260.4 1299.6 1304.7 1332.9 1335.5 867.5 884.9 898.7 899.9 906.0 4456.3 4477.9 4483.2 4485.5 4486.7 5121.6 5130.6 5138.5 5152.9 5158.5 4439.7 4470.8 4492.7 4501.8 4503.6 2339.7 2462.6 2471.8 2485.9 2489.2 4401.4 4410.4 4430.9 4461.7 4469.7 4693.1 4742.3 4752.8 4757.5 4762.9 4465.9 4697.6 5007.5 5038.9 5052.6 5345.8 5355.8 5355.9 5363.0 5393.8 5152.8 5257.8 5261.8 5267.9 5269.4 4990.2 5013.7 5033.5 5044.2 5069.7 3704.9 3751.8 3762.9 3765.5 3766.2 5102.9 5377.3 5417.1 5429.8 5444.0 4798.8 5163.2 5173.8 5178.4 5200.9 5178.2 5182.5 5192.4 5204.7 5214.4 4911.5 5093.4 5109.2 5114.6 5139.4 5211.6 5219.9 5220.5 5263.8 5266.7 5052.5 5093.3 5109.5 5113.7 5137.5 16:12:00 INFO - PROCESS | 27824 | 16:12:00 INFO - PROCESS | 27824 | [#5] yui.html Cycles:180 Average:17313.01 Median:25708.50 stddev:24922.67 (96.9%) stddev-sans-first:24961.13 16:12:00 INFO - PROCESS | 27824 | Values: 638.3 724.7 738.3 742.6 751.4 12818.6 13426.8 13456.0 13477.1 13502.3 13029.9 13089.3 13092.1 13230.1 13236.2 595.9 610.1 721.2 728.2 746.7 745.4 754.7 757.7 758.0 758.8 805.2 811.0 812.6 813.1 813.9 796.0 798.0 798.7 804.8 805.6 586.4 586.9 587.5 588.3 589.2 12666.8 12795.0 12830.5 12847.6 12854.3 13436.0 13494.6 13851.0 13984.7 14212.4 10650.7 10820.2 10869.0 10908.5 10989.7 3335.3 3345.0 3389.8 3406.7 3471.8 60653.7 61820.4 62551.0 62557.4 63344.0 9998.9 10111.8 10112.8 10155.2 10417.0 20035.8 20184.3 20250.6 20298.4 20426.6 6273.9 6398.1 6400.8 6455.2 6569.8 3333.7 3344.4 3345.9 3398.2 3412.8 2643.2 2735.9 2737.0 2740.8 3065.4 509.0 513.5 516.8 521.2 529.1 462.5 553.8 614.8 616.9 632.4 7694.2 7793.0 7863.1 7895.9 7983.1 502.5 553.6 585.9 607.1 608.3 3504.3 3922.0 3984.5 3991.9 4099.8 87248.1 95781.5 98233.0 99865.0 100242.5 85638.0 86210.0 86456.5 87315.6 88447.6 48327.5 69801.3 76938.2 77095.2 77510.6 7240.5 7437.3 7581.3 7617.5 7775.3 41404.2 47739.8 48740.0 48918.8 50903.5 37469.4 42337.6 57759.4 58391.7 60181.7 10472.8 10513.3 10628.6 10798.9 10891.7 12411.6 12420.6 12622.9 12821.1 12975.7 10501.2 10785.2 10948.1 10964.8 10989.3 10034.7 10155.6 10184.2 10469.4 10557.2 10421.2 11090.3 11241.5 11498.6 11528.6 8834.2 8889.2 9412.8 9558.4 9743.4 7964.9 8613.7 9009.5 9279.3 9381.3 16:12:00 INFO - PROCESS | 27824 | -------- Summary: end -------- 16:12:00 INFO - PROCESS | 27824 | 16:12:01 INFO - TEST-INFO | 27824: exit 0 16:12:01 INFO - TEST-OK | dromaeo_css | took 1120703ms 16:12:01 INFO - TEST-START | kraken 16:12:01 INFO - operating with platform_type : linux_ 16:12:01 INFO - Initialising browser for kraken test... 16:12:01 INFO - TEST-INFO | started process 28185 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJThFjY/profile http://localhost:54780/getInfo.html) 16:12:06 INFO - PROCESS | 28185 | __metrics Screen width/height:1600/1200 16:12:06 INFO - PROCESS | 28185 | colorDepth:24 16:12:06 INFO - PROCESS | 28185 | Browser inner width/height: 1024/697 16:12:06 INFO - PROCESS | 28185 | __metrics 16:12:07 ERROR - PROCESS | 28185 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 16:12:08 INFO - TEST-INFO | 28185: exit 0 16:12:08 INFO - Browser initialized. 16:12:08 INFO - Running cycle 1/1 for kraken test... 16:12:08 INFO - TEST-INFO | started process 28306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJThFjY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:20 INFO - PROCESS | 28306 | RSS: Main: 186105856 16:12:20 INFO - PROCESS | 28306 | 16:12:23 INFO - PROCESS | 28306 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54780/tests/kraken/driver.html?testName=audio-beat-detection) 16:12:24 INFO - PROCESS | 28306 | RSS: Main: 199405568 16:12:24 INFO - PROCESS | 28306 | 16:12:27 INFO - PROCESS | 28306 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54780/tests/kraken/driver.html?testName=audio-dft) 16:12:28 INFO - PROCESS | 28306 | RSS: Main: 198365184 16:12:28 INFO - PROCESS | 28306 | 16:12:30 INFO - PROCESS | 28306 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54780/tests/kraken/driver.html?testName=audio-fft) 16:12:31 INFO - PROCESS | 28306 | RSS: Main: 193073152 16:12:31 INFO - PROCESS | 28306 | 16:12:33 INFO - PROCESS | 28306 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54780/tests/kraken/driver.html?testName=audio-oscillator) 16:12:34 INFO - PROCESS | 28306 | RSS: Main: 193757184 16:12:34 INFO - PROCESS | 28306 | 16:12:36 INFO - PROCESS | 28306 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54780/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:12:37 INFO - PROCESS | 28306 | RSS: Main: 194416640 16:12:37 INFO - PROCESS | 28306 | 16:12:40 INFO - PROCESS | 28306 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54780/tests/kraken/driver.html?testName=imaging-darkroom) 16:12:41 INFO - PROCESS | 28306 | RSS: Main: 193982464 16:12:41 INFO - PROCESS | 28306 | 16:12:44 INFO - PROCESS | 28306 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54780/tests/kraken/driver.html?testName=imaging-desaturate) 16:12:45 INFO - PROCESS | 28306 | RSS: Main: 192520192 16:12:45 INFO - PROCESS | 28306 | 16:12:48 INFO - PROCESS | 28306 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54780/tests/kraken/driver.html?testName=json-parse-financial) 16:12:48 INFO - PROCESS | 28306 | RSS: Main: 193585152 16:12:48 INFO - PROCESS | 28306 | 16:12:50 INFO - PROCESS | 28306 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54780/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:12:51 INFO - PROCESS | 28306 | RSS: Main: 194023424 16:12:51 INFO - PROCESS | 28306 | 16:12:53 INFO - PROCESS | 28306 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54780/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:12:53 INFO - PROCESS | 28306 | RSS: Main: 193462272 16:12:53 INFO - PROCESS | 28306 | 16:12:55 INFO - PROCESS | 28306 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54780/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:12:56 INFO - PROCESS | 28306 | RSS: Main: 194248704 16:12:56 INFO - PROCESS | 28306 | 16:12:59 INFO - PROCESS | 28306 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:13:00 INFO - PROCESS | 28306 | RSS: Main: 194273280 16:13:00 INFO - PROCESS | 28306 | 16:13:03 INFO - PROCESS | 28306 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:13:03 INFO - PROCESS | 28306 | RSS: Main: 194646016 16:13:03 INFO - PROCESS | 28306 | 16:13:05 INFO - PROCESS | 28306 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54780/tests/kraken/driver.html?testName=ai-astar) 16:13:06 INFO - PROCESS | 28306 | RSS: Main: 197500928 16:13:06 INFO - PROCESS | 28306 | 16:13:06 INFO - PROCESS | 28306 | __start_tp_report 16:13:06 INFO - PROCESS | 28306 | _x_x_mozilla_page_load 16:13:06 INFO - PROCESS | 28306 | _x_x_mozilla_page_load_details 16:13:06 INFO - PROCESS | 28306 | |i|pagename|runs| 16:13:06 INFO - PROCESS | 28306 | |0;ai-astar;108;117;115;115;115;114;115;115;117;115 16:13:06 INFO - PROCESS | 28306 | |1;audio-beat-detection;156;129;129;180;134;129;128;129;165;131 16:13:06 INFO - PROCESS | 28306 | |2;audio-dft;164;175;164;164;163;162;161;165;165;164 16:13:06 INFO - PROCESS | 28306 | |3;audio-fft;76;76;78;113;78;78;77;80;117;78 16:13:06 INFO - PROCESS | 28306 | |4;audio-oscillator;85;85;108;83;84;83;105;85;84;110 16:13:06 INFO - PROCESS | 28306 | |5;imaging-gaussian-blur;119;118;117;118;118;117;118;117;119;118 16:13:06 INFO - PROCESS | 28306 | |6;imaging-darkroom;148;148;147;147;147;149;147;148;148;149 16:13:06 INFO - PROCESS | 28306 | |7;imaging-desaturate;95;96;95;96;96;96;96;95;96;95 16:13:06 INFO - PROCESS | 28306 | |8;json-parse-financial;64;64;66;64;65;73;66;65;64;69 16:13:06 INFO - PROCESS | 28306 | |9;json-stringify-tinderbox;66;67;66;66;66;66;66;66;66;67 16:13:06 INFO - PROCESS | 28306 | |10;stanford-crypto-aes;85;89;84;86;90;86;85;84;95;89 16:13:06 INFO - PROCESS | 28306 | |11;stanford-crypto-ccm;150;167;144;145;144;143;143;148;179;141 16:13:06 INFO - PROCESS | 28306 | |12;stanford-crypto-pbkdf2;182;177;178;176;180;177;179;178;172;178 16:13:06 INFO - PROCESS | 28306 | |13;stanford-crypto-sha256-iterative;72;72;70;72;71;71;77;72;70;73 16:13:06 INFO - PROCESS | 28306 | __end_tp_report 16:13:06 INFO - PROCESS | 28306 | __start_cc_report 16:13:06 INFO - PROCESS | 28306 | _x_x_mozilla_cycle_collect,873 16:13:06 INFO - PROCESS | 28306 | __end_cc_report 16:13:06 INFO - PROCESS | 28306 | __startTimestamp1476313986036__endTimestamp 16:13:06 INFO - PROCESS | 28306 | 16:13:06 INFO - PROCESS | 28306 | ------- Summary: start ------- 16:13:06 INFO - PROCESS | 28306 | Number of tests: 14 16:13:06 INFO - PROCESS | 28306 | 16:13:06 INFO - PROCESS | 28306 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:2.50 (2.2%) stddev-sans-first:1.00 16:13:06 INFO - PROCESS | 28306 | Values: 108.0 117.0 115.0 115.0 115.0 114.0 115.0 115.0 117.0 115.0 16:13:06 INFO - PROCESS | 28306 | 16:13:06 INFO - PROCESS | 28306 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:132.50 stddev:18.90 (14.3%) stddev-sans-first:19.25 16:13:06 INFO - PROCESS | 28306 | Values: 156.0 129.0 129.0 180.0 134.0 129.0 128.0 129.0 165.0 131.0 16:13:06 INFO - PROCESS | 28306 | 16:13:06 INFO - PROCESS | 28306 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:3.83 (2.3%) stddev-sans-first:4.06 16:13:06 INFO - PROCESS | 28306 | Values: 164.0 175.0 164.0 164.0 163.0 162.0 161.0 165.0 165.0 164.0 16:13:06 INFO - PROCESS | 28306 | 16:13:06 INFO - PROCESS | 28306 | [#3] audio-fft Cycles:10 Average:85.10 Median:78.00 stddev:15.83 (20.3%) stddev-sans-first:16.44 16:13:06 INFO - PROCESS | 28306 | Values: 76.0 76.0 78.0 113.0 78.0 78.0 77.0 80.0 117.0 78.0 16:13:06 INFO - PROCESS | 28306 | 16:13:06 INFO - PROCESS | 28306 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:84.00 stddev:11.45 (13.6%) stddev-sans-first:11.92 16:13:06 INFO - PROCESS | 28306 | Values: 85.0 85.0 108.0 83.0 84.0 83.0 105.0 85.0 84.0 110.0 16:13:06 INFO - PROCESS | 28306 | 16:13:06 INFO - PROCESS | 28306 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 16:13:06 INFO - PROCESS | 28306 | Values: 119.0 118.0 117.0 118.0 118.0 117.0 118.0 117.0 119.0 118.0 16:13:06 INFO - PROCESS | 28306 | 16:13:06 INFO - PROCESS | 28306 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 16:13:06 INFO - PROCESS | 28306 | Values: 148.0 148.0 147.0 147.0 147.0 149.0 147.0 148.0 148.0 149.0 16:13:06 INFO - PROCESS | 28306 | 16:13:06 INFO - PROCESS | 28306 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 16:13:06 INFO - PROCESS | 28306 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 16:13:06 INFO - PROCESS | 28306 | 16:13:06 INFO - PROCESS | 28306 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:65.50 stddev:2.91 (4.4%) stddev-sans-first:2.99 16:13:06 INFO - PROCESS | 28306 | Values: 64.0 64.0 66.0 64.0 65.0 73.0 66.0 65.0 64.0 69.0 16:13:06 INFO - PROCESS | 28306 | 16:13:06 INFO - PROCESS | 28306 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 16:13:06 INFO - PROCESS | 28306 | Values: 66.0 67.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 67.0 16:13:06 INFO - PROCESS | 28306 | 16:13:06 INFO - PROCESS | 28306 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:87.50 stddev:3.47 (4.0%) stddev-sans-first:3.57 16:13:06 INFO - PROCESS | 28306 | Values: 85.0 89.0 84.0 86.0 90.0 86.0 85.0 84.0 95.0 89.0 16:13:06 INFO - PROCESS | 28306 | 16:13:06 INFO - PROCESS | 28306 | [#11] stanford-crypto-ccm Cycles:10 Average:150.40 Median:146.50 stddev:12.51 (8.5%) stddev-sans-first:13.27 16:13:06 INFO - PROCESS | 28306 | Values: 150.0 167.0 144.0 145.0 144.0 143.0 143.0 148.0 179.0 141.0 16:13:06 INFO - PROCESS | 28306 | 16:13:06 INFO - PROCESS | 28306 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.70 Median:178.00 stddev:2.63 (1.5%) stddev-sans-first:2.28 16:13:06 INFO - PROCESS | 28306 | Values: 182.0 177.0 178.0 176.0 180.0 177.0 179.0 178.0 172.0 178.0 16:13:06 INFO - PROCESS | 28306 | 16:13:06 INFO - PROCESS | 28306 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:2.00 (2.8%) stddev-sans-first:2.12 16:13:06 INFO - PROCESS | 28306 | Values: 72.0 72.0 70.0 72.0 71.0 71.0 77.0 72.0 70.0 73.0 16:13:06 INFO - PROCESS | 28306 | -------- Summary: end -------- 16:13:06 INFO - PROCESS | 28306 | 16:13:07 INFO - TEST-INFO | 28306: exit 0 16:13:07 INFO - TEST-OK | kraken | took 65359ms 16:13:07 INFO - SUITE-END | took 1186s 16:13:07 INFO - Completed test suite (00:19:46) 16:13:07 INFO - javascript benchmark 16:13:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6213.669817445444, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2605.1012400721743, 2618.9214323570286, 2623.803214758893, 2643.7224091470403, 2671.345520347515, 4696.671233013691, 4749.643776716743, 4786.521347865212, 4801.783919723612, 4821.879453013672, 4582.839600613979, 4706.270528068147, 4735.621150307976, 4745.003549254652, 4771.427428708551, 4341.6309613682715, 4353.7387756734615, 4440.267355886275, 4443.289073748201, 4514.909701805962, 4359.956400436003, 4434.445694288214, 4471.061077173781, 4529.886752831189, 4557.794899229542, 4311.504177019651, 4329.783510824446, 4352.586504282088, 4388.166248412791, 4437.223485889988, 4353.804078816461, 4355.368471571636, 4358.4769827620885, 4365.80353884076, 4459.0413061192, 4390.473143222834, 4406.493253275882, 4417.801198946023, 4423.159599676083, 4450.933236001462, 4694.671373003891, 4745.738984355859, 4793.84947612574, 4809.302651115604, 4832.275158726184, 5095.719735414551, 5117.692938423706, 5127.589792816566, 5140.9228861566735, 5149.716765577892, 5119.6160287978555, 5130.615203859688, 5132.5124113209185, 5142.640015198937, 5200.115980283361, 4690.835820746258, 4725.5510726480925, 4765.332853400527, 4772.80908763649, 4779.474257831635, 5238.607104467104, 5269.446708095671, 5272.156454967264, 5303.390110137384, 5305.946940530545, 5049.873753156127, 5050.974745126251, 5061.139606266944, 5070.188769796815, 5125.923111153335, 5007.724575148329, 5027.4721154279005, 5062.544371006627, 5124.333836601218, 5128.0, 5014.84955451337, 5020.0, 5021.799128034838, 5044.4198917125, 5078.111330517145, 4942.184539551005, 4956.132676781549, 4981.402231732215, 4989.90020199594, 5055.87360315995, 4139.710220284612, 4180.958190418118, 4181.874543763692, 4220.177065472203, 4240.469941257343, 3686.6313368663455, 3718.7396882218527, 3760.52993375828, 3767.05823544114, 3768.2651882883124, 4437.134758722018, 4462.576055274743, 4465.749590114773, 4497.8200871964755, 4522.932156017662, 5019.749012549358, 5068.341115654941, 5164.567469944984, 5165.0, 5169.862630221345, 4436.44544431946, 4456.799444025027, 4475.373447717322, 4482.641388688897, 4482.775861206992, 4492.887677808016, 4502.144592527409, 4537.636989040869, 4572.611328037087, 4605.6776025678555, 4806.927896081562, 4825.30033145199, 4826.131296366688, 4827.08285425768, 4881.219004959332, 5188.325517682677, 5202.713850738246, 5204.0372531081875, 5210.0, 5256.816011439581, 4732.219183834629, 4736.478987311324, 4905.23968784839, 4959.107360674969, 4970.65205435616, 4971.65198436106, 5028.597712182944, 5081.8475445736685, 5135.563477104488, 5228.37259528859, 5186.092433824141, 5188.558972487381, 5241.554467870274, 5283.973580132075, 5316.494932981361, 5057.367829021372, 5079.415867175322, 5091.796328146833, 5103.387593488805, 5156.896862062813, 4880.877978050435, 4954.851354459372, 4971.875703107451, 4999.725015124203, 5003.77483013258, 4922.458529561817, 4950.900981980269, 4951.678140920829, 4956.7769450375545, 4979.128652485873, 5038.093143234253, 5049.57078648319, 5052.747362631927, 5055.469175736494, 5111.131107711623, 4834.854954351375, 4885.2427873679635, 4903.656744027884, 4945.480724524017, 4987.501249874984], "value": 4698.027243276174, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.5022378516624, 519.177104289701, 522.4279414041624, 525.1309083466862, 534.3267482971455, 38101.0, 39970.600293997086, 39998.60001399985, 40011.799941000325, 40190.397144042865, 39845.410048346836, 39927.0, 40694.186116277655, 40906.59093409065, 40924.59075409245, 7554.244575542443, 7702.152763196044, 7705.267999540035, 7718.957940678021, 7736.574488403136, 7559.28186822251, 7584.279493448141, 7598.4301177411635, 7662.846743065135, 7679.57762323072, 7432.628368581576, 7563.168051514329, 7573.5834529100875, 7575.507592006529, 7575.507592006529, 7572.848543029136, 7671.731489397845, 7675.04061992251, 7675.808104797369, 7679.078510578711, 7524.849503009964, 7581.696732130708, 7591.468597198198, 7600.885986710204, 7620.123685776151, 37593.436098458544, 37712.43431348532, 37741.056473588105, 37752.43371349432, 37810.43284350737, 3071.2014876132366, 3138.98430507846, 3189.521571764231, 3324.933501329984, 3347.6484969078138, 27177.320566985785, 28109.718902810913, 28583.14250572486, 28833.85583072092, 29691.109266722033, 3019.7886147969652, 3214.3089235814177, 3248.788828726149, 3260.396826587089, 3290.276139249361, 244623.0, 245275.0, 246379.0, 246423.0, 246804.0, 32792.0, 34219.657803422146, 54777.0, 55288.17067743987, 55358.0, 32950.0, 33067.83466082654, 33269.66730332714, 33275.33449331048, 33347.0, 12930.612081637566, 13086.280254586089, 13093.345332733325, 13119.475220991053, 13126.343682815821, 9712.9028709712, 9731.270154738282, 10640.0, 10876.564937402416, 10887.074598659203, 17686.646267074844, 17719.379821706178, 17720.9113954432, 17837.643247134984, 17929.820701793076, 6586.80239592813, 6748.628825414649, 6765.492588055817, 6955.852284373022, 6961.895571566431, 790.8260182759784, 866.4844417571535, 936.4521754773534, 948.2115317645861, 982.8574856645746, 26058.34854128624, 27524.862375687993, 27611.0, 27925.364641049495, 28410.85794571014, 938.1181689212119, 951.571792693277, 958.4009993753904, 960.4237457525429, 1019.2277006542193, 14405.692116359309, 14921.179335136454, 15074.54776356711, 15078.924605376902, 15183.16492592918, 346862.0, 348177.0, 349298.0, 350048.0, 351363.0, 49062.26406603904, 49702.751486242334, 49821.25268120981, 49888.0, 49907.25139122916, 1120.7366268926796, 1125.9099272058215, 1146.3179408252076, 1165.5454372794618, 1180.5454899863614, 26036.21891343263, 27274.863625681744, 27654.44691106207, 28308.292292692022, 28368.85815570909, 42921.0, 46046.53953460557, 48401.27398088961, 48435.27347089726, 52563.0, 344688.0, 347737.0, 348247.0, 348297.0, 348719.0, 36340.636593633724, 37102.25795484129, 37423.2515349686, 37532.437013445364, 37990.24019519649, 41323.380149298384, 41941.370879436225, 42529.14941701211, 42600.0, 43169.784151079046, 35412.822935886186, 35611.82194089013, 35850.28299434049, 36190.63809361873, 36674.26651467009, 35212.29575408426, 35803.10492237611, 35858.8207058963, 36238.4564231542, 36440.635593643725, 29672.406551869273, 35173.47239791354, 35201.0, 35286.0, 35401.468977965866, 31442.371152577278, 32687.836560817042, 33554.16114597155, 33820.492692609136, 33874.66125338715, 24988.250352489453, 25213.0, 25272.494550108528, 25800.612990804777, 25826.870865646302], "value": 17171.900213538847, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.96390360963926, 371.05196223648574, 372.68321926362586, 382.546682181615, 393.51204506412057, 15178.165200913945, 15431.845681543182, 16646.167691615432, 16727.581810454714, 16739.330426782944, 15809.367625295003, 15963.361465541393, 16030.118343491104, 16344.673106537863, 16412.343506259764, 4778.378810754597, 5044.445111037801, 5052.595792336604, 5055.69665820052, 5058.873528161807, 4849.903001939959, 4959.578435832958, 5008.223725322581, 5011.123053465647, 5012.573931215851, 5043.39479262489, 5301.231321458386, 5329.307190065306, 5396.730163491829, 5402.37872644645, 5126.256692779526, 5284.207368894658, 5286.0, 5290.603204759658, 5351.491608297206, 5131.846044618667, 5131.871703207413, 5155.381354237478, 5155.7679904404395, 5158.329417175781, 11772.0, 11985.52057917691, 13645.658858528517, 19350.709739353922, 19467.80532194674, 1821.353419536059, 1828.6159906419668, 1832.4869036669754, 1844.0595296398799, 1857.3406440713488, 8460.83078338436, 8873.689420870238, 9227.215686666641, 9423.717288481357, 9459.385139965949, 1642.8603568696556, 1666.1086318819493, 1706.436875830973, 1752.2377765671974, 1762.7179651255865, 61906.71399290097, 63898.6805065981, 67581.66209168972, 68135.61525346589, 68918.65540672315, 9425.952870235606, 9480.620775169054, 9577.664781732607, 9791.118799308097, 9794.363366381162, 12909.54816581415, 12937.611871643865, 12965.805512917314, 12968.157069790623, 12986.0, 6702.597844129368, 6824.931750682529, 6943.305669433117, 7017.122859642544, 7045.929540704527, 6460.580062295936, 6468.870622587616, 6494.967525162344, 6675.165604299463, 6684.598924064571, 4070.3283958147167, 4074.0, 4151.626353628188, 4165.146145040259, 4176.18564379943, 1789.3200583778082, 1811.855051595869, 1821.1531637788491, 1824.9908750456163, 1839.5916006939556, 369.52700543304616, 374.3411595591778, 391.6220846882772, 731.3089130771476, 797.6330887791681, 10112.0, 10113.64602238918, 10350.430726309974, 10460.163186945027, 10591.258611897247, 391.0673044788144, 393.9527256729211, 396.74608250719564, 398.33676927915275, 400.1676512853258, 5433.782648694087, 5504.504594586507, 5528.391876893538, 5642.23829782974, 5739.7704091836695, 390153.0, 394165.0, 395916.0, 401600.8399160119, 403126.0, 77821.61089194518, 78338.60830695811, 78588.60705696435, 79019.60490197512, 80310.59844700739, 405.8498355608444, 417.9435776170178, 418.5166133116256, 419.26209870627304, 419.55317586770605, 9528.182299100727, 9627.326087174111, 9638.469884156439, 9640.276979226446, 9641.27690423207, 35528.822355888056, 35845.462318064725, 35952.64047359493, 35984.460233097045, 36331.45502817513, 52806.73596632146, 52890.47109528856, 52907.470925290254, 53183.46816531785, 53464.198037030255, 7013.754518591825, 7103.289671032855, 7253.274672532704, 7273.3817625502425, 7547.886781698388, 10065.949670251603, 10804.351738895692, 11146.944265278622, 11594.130440217186, 11704.239224450383, 9379.249660027317, 9539.761505962406, 9668.129868311886, 10104.69685909424, 10274.640387586398, 8887.555622218733, 9493.0, 9668.613255469703, 9926.404415735078, 10033.0, 9808.264380171659, 10047.145992590711, 10113.494325283853, 10538.473076346, 10917.617883374043, 7305.634718263959, 7483.251674832691, 7543.0, 7638.197989211053, 7732.652030658522, 9478.85781713261, 9530.523473826142, 10018.749531261778, 10128.189744820544, 10177.84733229017], "value": 7195.081027709093, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.832020997375, 1374.0107122871532, 1446.5515690136058, 1636.3536403120775, 1650.818409974902, 6753.898691519631, 7015.6141412222305, 7370.520916140454, 8043.477173983694, 8088.676452941882, 7469.253074692541, 7716.228377162295, 7739.342155916754, 7920.049594048723, 7951.801204969878, 2186.7813218678125, 2221.1226565506613, 2222.4777177363308, 2224.1992882562263, 2224.232639739287, 2163.2969284982364, 2199.0324257326806, 2199.736031676201, 2210.292706333974, 2212.048819007826, 2160.956780864382, 2181.683655869898, 2187.2344679362177, 2203.22886989554, 2216.3018649125556, 2086.739157605299, 2095.9266425675182, 2098.98950505248, 2099.2967355935625, 2107.2097963263777, 2089.3940757180553, 2119.0782009825775, 2138.2516119358256, 2144.1209104267177, 2149.451889768099, 7644.923550764477, 7657.846843063107, 7715.842623606504, 7734.419918506134, 7887.211278872124, 4441.75570343631, 4569.223232050559, 4569.702969306984, 4570.245909424941, 4578.130155270488, 2754.4215714699935, 2866.1688110447944, 2900.825950442959, 2918.7664986801005, 2921.415716856637, 868.3877866104444, 900.7448467001547, 914.7575892388522, 930.4556834251971, 930.6370515498893, 10563.049325560736, 10569.735756605993, 10597.470126493645, 10658.200634952409, 10691.83962240567, 3892.1631849152, 4029.7985100744845, 4183.3515805050265, 4190.622843944059, 4197.223513649985, 8861.24679402258, 8907.55462226886, 8932.46405215689, 8937.195652391316, 8938.776530586787, 4617.307403889444, 4656.557627025427, 4678.883027924261, 4683.039976804746, 4716.764161791897, 3636.381815091441, 3763.5860055393887, 4145.875623731293, 4251.787410629456, 4261.296886013835, 3535.487354333607, 3580.1944562473755, 3655.469956856294, 3718.0890681783135, 3733.0667333166707, 1156.653004098767, 1188.3404710385819, 1196.8623608284984, 1203.8976686981705, 1207.1791181996152, 801.2308184143287, 810.3395732478011, 826.8759686047141, 840.1640367833922, 851.9265725186186, 5244.265802787613, 5269.631125821233, 5363.892722145613, 5401.513863752281, 5538.335399752055, 372.43204113726784, 378.7594877252909, 381.5154753463086, 384.63263099680904, 386.6230425335332, 3550.343186510504, 3871.6128387161057, 3874.4575759393706, 3883.126296583246, 3893.260280546687, 9613.807723845484, 9722.416655000723, 9741.269404794668, 9767.0, 9825.164860986895, 9706.077922597342, 9764.316497845224, 9770.951145244371, 9775.462349570842, 9782.853257201148, 6582.275949645536, 6801.18385793708, 6898.379145876795, 7067.37450386414, 7154.35610795031, 5180.896382072413, 5414.918776218281, 5444.673319600836, 5524.281843360337, 5737.569682273763, 8827.735167944971, 8844.601992910206, 8886.911130888608, 8898.955505222433, 9014.909850901407, 8876.423032502867, 9050.728478145666, 9276.582553784961, 9299.0, 9310.95344523273, 5532.557395408438, 5758.107493338539, 6555.311692272243, 6663.500237482305, 6714.261431242462, 7212.927870721225, 7421.962890185515, 7517.812054698677, 7638.15980242184, 7654.387648988179, 6427.292997770148, 6439.388258115471, 6575.013747937847, 6670.39966403026, 6816.591004539545, 6614.305497922649, 6734.6632668367365, 6751.324867513209, 6785.1518560179975, 6890.621015843976, 6201.410865967726, 6280.842978925563, 6301.684915754286, 6313.652749098844, 6317.084022816758, 4421.624161946142, 4486.12520558488, 4641.837535686234, 4767.499412561631, 4811.206150985048, 4746.881327966828, 4821.4696383397095, 4871.756412179306, 4928.8767780805765, 4952.603791696728], "value": 4037.0652058056176, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.13128417820263, 294.2716775979451, 301.5190770720701, 303.35688340717655, 305.03000458541834, 4782.689125206868, 4925.1627223372025, 4929.728864912428, 5001.574866136379, 5011.649184557083, 4742.241241401368, 4845.418549774024, 4885.951140488594, 4889.291052797343, 4897.142999975008, 3864.1645218521257, 3864.478295430109, 3867.9806600967095, 3869.5743468218475, 3875.507929447169, 3687.6496732810474, 3867.361885288924, 3879.2241551689776, 3881.5536213335404, 3885.669718073967, 3804.733668643182, 3832.4442955771397, 3835.8273877675433, 3843.9044872211425, 3851.9229615407817, 3829.885103446901, 3834.194819087967, 3841.4621952926755, 3847.2882516734494, 3863.9613603864163, 3419.5383623210796, 3420.6237313895454, 3428.2286485540803, 3432.8970130896114, 3435.6220815710253, 4646.233371493699, 4770.7376094314795, 4778.4982576829625, 4846.0550192712435, 4847.781849816767, 4379.540148284448, 4385.802638881226, 4386.561343865588, 4398.186335527937, 4404.414410812105, 5137.743112844343, 5138.332016837787, 5141.820036298749, 5152.227165925141, 5163.277141200235, 3647.3802428611657, 3656.8171591420587, 3692.5015122958325, 3705.370087085175, 3720.7395482316247, 5342.866428339284, 5363.195520671852, 5366.356037275513, 5366.382865970424, 5407.810726624589, 3786.2995345861104, 3801.0, 3823.2162406706557, 3831.214601006787, 3833.923321533554, 3898.0, 3899.883003509899, 3919.725619206685, 3922.5685174630767, 3934.370500719871, 4143.772092534879, 4262.296721040993, 4334.32817913224, 4347.478302603708, 4421.977890110529, 5107.642465027487, 5130.743462826844, 5136.4606716295, 5138.820141295037, 5152.098382783073, 1260.3552364164852, 1299.6101169649066, 1304.6542666193466, 1332.9000324975666, 1335.4858379523953, 867.5141920524527, 884.9424937200113, 898.6630013744846, 899.9235065019546, 905.9501727405056, 4456.286994080931, 4477.932831007537, 4483.215437298525, 4485.452518881046, 4486.7083639563325, 5121.590272778169, 5130.589552835764, 5138.537531622172, 5152.948470515322, 5158.509941555546, 4439.733615983051, 4470.803375586472, 4492.663050271242, 4501.842435514741, 4503.639708823286, 2339.684142640722, 2462.6429167770575, 2471.826972111935, 2485.8553929279474, 2489.191012920808, 4401.40581021558, 4410.405519501596, 4430.933535996963, 4461.732296062247, 4469.664775141812, 4693.0992947856175, 4742.33607294979, 4752.762361881962, 4757.548032936866, 4762.928556071662, 4465.910681786346, 4697.647676424282, 5007.549320561167, 5038.899222015612, 5052.646314757932, 5345.812896548602, 5355.812546561007, 5355.9464405357, 5363.0, 5393.8112166074, 5152.818117494474, 5257.842264731911, 5261.7895284189735, 5267.947320526899, 5269.420363759907, 4990.15167421532, 5013.699178049329, 5033.496650334937, 5044.192929131322, 5069.7211653357945, 3704.870329538453, 3751.756135851161, 3762.9247415051, 3765.4916586260506, 3766.1902690921584, 5102.856800144023, 5377.327834020747, 5417.079096553516, 5429.7556609953435, 5444.0, 4798.760061996956, 5163.160261856039, 5173.81891633791, 5178.404483484297, 5200.947990520198, 5178.197379406198, 5182.533571978389, 5192.364405212346, 5204.73976301191, 5214.400343960493, 4911.484294149206, 5093.388793344822, 5109.182530795055, 5114.5652619527755, 5139.383274006994, 5211.583073354198, 5219.895602087861, 5220.451852555427, 5263.7894484220205, 5266.682659629751, 5052.520010598987, 5093.261477085876, 5109.46350633193, 5113.667611605234, 5137.458762371199], "value": 3847.0268924776046, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.3361304243587, 724.7137380734607, 738.2912404092071, 742.5804420502416, 751.3763576231728, 12818.615441536756, 13426.798598021038, 13455.990800689951, 13477.123986940867, 13502.324883755822, 13029.869701302983, 13089.280089595093, 13092.083554151213, 13230.073894827367, 13236.205827650349, 595.9284885813709, 610.1427494370416, 721.2354903801987, 728.2499026003212, 746.7349091072673, 745.3925051083377, 754.6830331260857, 757.7120694136221, 758.0, 758.7609902880603, 805.19078326282, 810.9675612975503, 812.6343145584481, 813.1137060603941, 813.9064007639138, 795.9999999999972, 797.9785874081185, 798.6805277888833, 804.7505273365247, 805.6092794994423, 586.378438854811, 586.8679547101868, 587.5358466811214, 588.2558563417281, 589.1722130406786, 12666.80999785004, 12795.04037197214, 12830.486780528861, 12847.614571562868, 12854.293013884233, 13436.0, 13494.595162145151, 13851.0, 13984.720305593832, 14212.360443780055, 10650.733731656694, 10820.188485863513, 10869.0, 10908.454577271104, 10989.670309890636, 3335.31626016666, 3345.0466617014035, 3389.796612203276, 3406.659334066598, 3471.7743346682387, 60653.6967315165, 61820.381796181915, 62551.0, 62557.374426256065, 63343.99999999954, 9998.900010999942, 10111.848322275171, 10112.848307275397, 10155.238357123246, 10417.010384013658, 20035.799642003683, 20184.293549725982, 20250.594988100154, 20298.391048268575, 20426.59146817085, 6273.8807494383345, 6398.136251606066, 6400.807975760735, 6455.160829092188, 6569.835754106186, 3333.749968752353, 3344.4314466540745, 3345.9498107528407, 3398.1844357354057, 3412.77816941898, 2643.1806140096633, 2735.9452810944067, 2737.0283549340097, 2740.8355498670144, 3065.4482193205436, 508.9745512724349, 513.4993381453054, 516.8475299786497, 521.1947541049088, 529.1242992846844, 462.51898026052527, 553.7784886045614, 614.7786796753165, 616.8519555306784, 632.4118569730103, 7694.192109828499, 7793.0, 7863.13505514393, 7895.881561776578, 7983.081945576333, 502.4777006937562, 553.6152374100043, 585.9179714839926, 607.1287702147345, 608.3429895712708, 3504.299140171976, 3921.9803900980883, 3984.4820173377275, 3991.940120898189, 4099.8360065597635, 87248.12751872528, 95781.52109239409, 98233.0, 99865.0, 100242.4987875056, 85638.0, 86210.0, 86456.54173833103, 87315.56342218249, 88447.55776221206, 48327.4757907678, 69801.25496862619, 76938.23061769422, 77095.22904770993, 77510.61244693854, 7240.52936559122, 7437.293457121565, 7581.3176814087, 7617.54294742295, 7775.261350171724, 41404.171916560896, 47739.76130119327, 48740.0, 48918.75540622274, 50903.490965091354, 37469.43795843119, 42337.57662423459, 57759.4224057754, 58391.70804145952, 60181.69909150426, 10472.842907356548, 10513.316634418738, 10628.627998020032, 10798.894215627877, 10891.67324980252, 12411.62765117048, 12420.565280215149, 12622.936885315514, 12821.102522823312, 12975.740485190432, 10501.159907207559, 10785.245032847626, 10948.124150067817, 10964.835527467254, 10989.340639561651, 10034.69895903124, 10155.593776248867, 10184.18526517862, 10469.424181670081, 10557.15542756593, 10421.166306695597, 11090.334579925231, 11241.49413276388, 11498.597549085742, 11528.59649912249, 8834.249088827522, 8889.244414224864, 9412.811743765224, 9558.426494410358, 9743.366681165702, 7964.880526792219, 8613.741587752378, 9009.54952252398, 9279.334662808287, 9381.343305968516], "value": 6383.829114189829, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 117.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 129.0, 129.0, 180.0, 134.0, 129.0, 128.0, 129.0, 165.0, 131.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 175.0, 164.0, 164.0, 163.0, 162.0, 161.0, 165.0, 165.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 113.0, 78.0, 78.0, 77.0, 80.0, 117.0, 78.0], "value": 85.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 108.0, 83.0, 84.0, 83.0, 105.0, 85.0, 84.0, 110.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 119.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 147.0, 149.0, 147.0, 148.0, 148.0, 149.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 64.0, 65.0, 73.0, 66.0, 65.0, 64.0, 69.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 84.0, 86.0, 90.0, 86.0, 85.0, 84.0, 95.0, 89.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 167.0, 144.0, 145.0, 144.0, 143.0, 143.0, 148.0, 179.0, 141.0], "value": 150.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 177.0, 178.0, 176.0, 180.0, 177.0, 179.0, 178.0, 172.0, 178.0], "value": 177.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 70.0, 72.0, 71.0, 71.0, 77.0, 72.0, 70.0, 73.0], "value": 72.0, "unit": "score"}]}]} 16:13:07 INFO - Return code: 0 16:13:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:13:07 ERROR - # TBPL SUCCESS # 16:13:07 INFO - Running post-action listener: _resource_record_post_action 16:13:07 INFO - [mozharness: 2016-10-12 23:13:07.862479Z] Finished run-tests step (success) 16:13:07 INFO - Running post-run listener: _resource_record_post_run 16:13:07 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393437184; Read time: 8; Write time: 211136 16:13:07 INFO - TinderboxPrint: CPU usage
13.4% 16:13:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:13:07 INFO - TinderboxPrint: I/O write bytes / time
393,437,184 / 211,136 16:13:07 INFO - TinderboxPrint: CPU idle
8,306.1 (86.6%) 16:13:07 INFO - TinderboxPrint: CPU user
1,224.7 (12.8%) 16:13:07 INFO - TinderboxPrint: Swap in / out
0 / 0 16:13:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99287040; Read time: 0; Write time: 54896 16:13:07 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291627008; Read time: 0; Write time: 155832 16:13:08 INFO - Running post-run listener: _upload_blobber_files 16:13:08 INFO - Blob upload gear active. 16:13:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:13:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:13:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:13:08 INFO - (blobuploader) - INFO - Open directory for files ... 16:13:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:13:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:13:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:10 INFO - (blobuploader) - INFO - Done attempting. 16:13:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:13:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:13:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:11 INFO - (blobuploader) - INFO - Done attempting. 16:13:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:13:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:13:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:15 INFO - (blobuploader) - INFO - Done attempting. 16:13:15 INFO - (blobuploader) - INFO - Iteration through files over. 16:13:16 INFO - Return code: 0 16:13:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:13:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:13:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e9f74d410e7354dedadbd699b02b6df3c5a7e852d3d95e0b84d085f0d25f84d1b7271b65ed235e3ff6c272e66d7c93dd9169a7fd2521d416999b705628c7245", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56121ec0fbf3fade1a012f6c6dd7b99acb71995e19fe80cd66382c78aaa48c2cd86b90ce152deb371270640f6ea03bcd624388182ec8c28ebfbbaaf5d09ea8db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71889b769df384b6f98ec581ac80cfad17261ee87265d90c625e76116d37115c04fa51812428a4aa7d8f22677fc3d2066fe1095c8598a8d2fda01183458644ce"} 16:13:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:13:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:13:16 INFO - Contents: 16:13:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e9f74d410e7354dedadbd699b02b6df3c5a7e852d3d95e0b84d085f0d25f84d1b7271b65ed235e3ff6c272e66d7c93dd9169a7fd2521d416999b705628c7245", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56121ec0fbf3fade1a012f6c6dd7b99acb71995e19fe80cd66382c78aaa48c2cd86b90ce152deb371270640f6ea03bcd624388182ec8c28ebfbbaaf5d09ea8db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71889b769df384b6f98ec581ac80cfad17261ee87265d90c625e76116d37115c04fa51812428a4aa7d8f22677fc3d2066fe1095c8598a8d2fda01183458644ce"} 16:13:16 INFO - Running post-run listener: copy_logs_to_upload_dir 16:13:16 INFO - Copying logs to upload dir... 16:13:16 INFO - mkdir: /builds/slave/test/build/upload/logs 16:13:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.530398 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-12 16:13:15.950499) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 16:13:15.953620) ========= 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=7de08804244eb36560b44971000001c3-1476312745.880938-1210367395 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/Firefox-Non-PGO/sha512/7e9f74d410e7354dedadbd699b02b6df3c5a7e852d3d95e0b84d085f0d25f84d1b7271b65ed235e3ff6c272e66d7c93dd9169a7fd2521d416999b705628c7245", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56121ec0fbf3fade1a012f6c6dd7b99acb71995e19fe80cd66382c78aaa48c2cd86b90ce152deb371270640f6ea03bcd624388182ec8c28ebfbbaaf5d09ea8db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71889b769df384b6f98ec581ac80cfad17261ee87265d90c625e76116d37115c04fa51812428a4aa7d8f22677fc3d2066fe1095c8598a8d2fda01183458644ce"} build_url:https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/C0L40-UEQJquoENL4L27oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e9f74d410e7354dedadbd699b02b6df3c5a7e852d3d95e0b84d085f0d25f84d1b7271b65ed235e3ff6c272e66d7c93dd9169a7fd2521d416999b705628c7245", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56121ec0fbf3fade1a012f6c6dd7b99acb71995e19fe80cd66382c78aaa48c2cd86b90ce152deb371270640f6ea03bcd624388182ec8c28ebfbbaaf5d09ea8db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71889b769df384b6f98ec581ac80cfad17261ee87265d90c625e76116d37115c04fa51812428a4aa7d8f22677fc3d2066fe1095c8598a8d2fda01183458644ce"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 16:13:15.979082) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 16:13:15.979411) ========= 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=7de08804244eb36560b44971000001c3-1476312745.880938-1210367395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 16:13:16.063248) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 16:13:16.063577) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 16:13:16.063885) ========= ========= Total master_lag: 0.17 =========