builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1479649814.34 results: success (0) buildid: 20161120030205 builduid: 744fcfad5279496d9b84a5c32e841077 revision: 57a8cde3f08ca9d60bcd8bdd698ceec687f0aed2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-20 05:50:14.344116) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-20 05:50:14.344903) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-20 05:50:14.345291) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-20 05:50:14.374502) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 05:50:14.375067) ========= 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=3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-20 05:50:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 66.4M=0s 2016-11-20 05:50:15 (66.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122877 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 05:50:14.512930) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 05:50:14.513242) ========= 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=3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019616 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 05:50:14.562727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 05:50:14.563113) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 57a8cde3f08ca9d60bcd8bdd698ceec687f0aed2 --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 57a8cde3f08ca9d60bcd8bdd698ceec687f0aed2 --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=3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-20 05:50:15,852 truncating revision to first 12 chars 2016-11-20 05:50:15,852 Setting DEBUG logging. 2016-11-20 05:50:15,852 attempt 1/10 2016-11-20 05:50:15,852 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/57a8cde3f08c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-20 05:50:16,156 unpacking tar archive at: mozilla-central-57a8cde3f08c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622225 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 05:50:15.200408) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-20 05:50:15.200726) ========= script_repo_revision: 57a8cde3f08ca9d60bcd8bdd698ceec687f0aed2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-20 05:50:15.201230) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-20 05:50:15.201509) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-20 05:50:15.210911) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-20 05:50:15.211211) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:50:16 INFO - MultiFileLogger online at 20161120 05:50:16 in /builds/slave/test 05:50:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:50:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:50:16 INFO - {'append_to_log': False, 05:50:16 INFO - 'base_work_dir': '/builds/slave/test', 05:50:16 INFO - 'blob_upload_branch': 'Firefox', 05:50:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:50:16 INFO - 'branch': 'Firefox', 05:50:16 INFO - 'buildbot_json_path': 'buildprops.json', 05:50:16 INFO - 'config_files': ('talos/linux_config.py',), 05:50:16 INFO - 'default_actions': ('clobber', 05:50:16 INFO - 'read-buildbot-config', 05:50:16 INFO - 'download-and-extract', 05:50:16 INFO - 'populate-webroot', 05:50:16 INFO - 'create-virtualenv', 05:50:16 INFO - 'install', 05:50:16 INFO - 'run-tests'), 05:50:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:50:16 INFO - 'download_minidump_stackwalk': True, 05:50:16 INFO - 'download_symbols': 'ondemand', 05:50:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:50:16 INFO - 'tooltool.py': '/tools/tooltool.py', 05:50:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:50:16 INFO - '/tools/misc-python/virtualenv.py')}, 05:50:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:50:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:50:16 INFO - 'installer_path': 'installer.exe', 05:50:16 INFO - 'log_level': 'info', 05:50:16 INFO - 'log_name': 'talos', 05:50:16 INFO - 'log_to_console': True, 05:50:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:50:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:50:16 INFO - 'opt_config_files': (), 05:50:16 INFO - 'pip_index': False, 05:50:16 INFO - 'sps_profile': False, 05:50:16 INFO - 'sps_profile_interval': 0, 05:50:16 INFO - 'suite': 'dromaeojs-e10s', 05:50:16 INFO - 'system_bits': '32', 05:50:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:50:16 INFO - 'title': 'talos-linux64-ix-059', 05:50:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:50:16 INFO - 'use_talos_json': True, 05:50:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:50:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:50:16 INFO - 'work_dir': 'build'} 05:50:16 INFO - [mozharness: 2016-11-20 13:50:16.595146Z] Running clobber step. 05:50:16 INFO - Running pre-action listener: _resource_record_pre_action 05:50:16 INFO - Running main action method: clobber 05:50:16 INFO - rmtree: /builds/slave/test/build 05:50:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:50:17 INFO - Running post-action listener: _resource_record_post_action 05:50:17 INFO - [mozharness: 2016-11-20 13:50:17.563092Z] Finished clobber step (success) 05:50:17 INFO - [mozharness: 2016-11-20 13:50:17.563191Z] Running read-buildbot-config step. 05:50:17 INFO - Running pre-action listener: _resource_record_pre_action 05:50:17 INFO - Running main action method: read_buildbot_config 05:50:17 INFO - Using buildbot properties: 05:50:17 INFO - { 05:50:17 INFO - "project": "", 05:50:17 INFO - "product": "firefox", 05:50:17 INFO - "script_repo_revision": "production", 05:50:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:50:17 INFO - "repository": "", 05:50:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:50:17 INFO - "buildid": "20161120030205", 05:50:17 INFO - "stage_platform": "linux64-pgo", 05:50:17 INFO - "basedir": "/builds/slave/test", 05:50:17 INFO - "nightly_build": "True", 05:50:17 INFO - "buildnumber": 200, 05:50:17 INFO - "slavename": "talos-linux64-ix-059", 05:50:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:50:17 INFO - "platform": "ubuntu64_hw", 05:50:17 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:50:17 INFO - "branch": "mozilla-central", 05:50:17 INFO - "repo_path": "mozilla-central", 05:50:17 INFO - "revision": "57a8cde3f08ca9d60bcd8bdd698ceec687f0aed2", 05:50:17 INFO - "pgo_build": "True", 05:50:17 INFO - "builduid": "744fcfad5279496d9b84a5c32e841077", 05:50:17 INFO - "slavebuilddir": "test" 05:50:17 INFO - } 05:50:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 05:50:17 INFO - Running post-action listener: _resource_record_post_action 05:50:17 INFO - [mozharness: 2016-11-20 13:50:17.565938Z] Finished read-buildbot-config step (success) 05:50:17 INFO - [mozharness: 2016-11-20 13:50:17.566026Z] Running download-and-extract step. 05:50:17 INFO - Running pre-action listener: _resource_record_pre_action 05:50:17 INFO - Running main action method: download_and_extract 05:50:17 INFO - mkdir: /builds/slave/test/build/tests 05:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:17 INFO - trying https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:50:17 INFO - Downloading https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:50:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:50:18 INFO - Downloaded 1361 bytes. 05:50:18 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:50:18 INFO - Using the following test package requirements: 05:50:18 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:50:18 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:50:18 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:50:18 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:18 INFO - u'jsshell-linux-x86_64.zip'], 05:50:18 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:50:18 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:50:18 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:50:18 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:50:18 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:50:18 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:50:18 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:50:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:50:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:50:18 INFO - Fetch https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:50:18 INFO - Http code: 200 05:50:18 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 05:50:18 INFO - x-amz-cf-id: 3A7cC0c6jehokgD9S5IRlHhOD4QeTs7vjvK1IR2-rlOhhUQGBJVEzQ== 05:50:18 INFO - x-amz-version-id: 6m67YZUlbdvRkVTEYEZQee4JIXAR5zku 05:50:19 INFO - Expected file size: 21946119 05:50:19 INFO - Obtained file size: 21946119 05:50:23 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:50:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:50:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:50:23 INFO - Fetch https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:50:23 INFO - Http code: 200 05:50:23 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 05:50:23 INFO - x-amz-cf-id: kcE4kcbAVKU0PdQGIHJRyBUVle7lEc0VJHoCZhpS8MyK-Fg4JbcQ9g== 05:50:23 INFO - x-amz-version-id: 6m67YZUlbdvRkVTEYEZQee4JIXAR5zku 05:50:23 INFO - Expected file size: 21946119 05:50:23 INFO - Obtained file size: 21946119 05:50:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 05:50:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:50:28 INFO - Fetch https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:50:28 INFO - Http code: 200 05:50:28 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 05:50:28 INFO - x-amz-cf-id: gE5e5cj6O7Unu_xqIOxISOj7CTbRvngJAyv-i4dY3C6rhtvSma7PNg== 05:50:28 INFO - x-amz-version-id: P8IhJ455a.QYvMN.t7LnHBnspN8vcx3s 05:50:29 INFO - Expected file size: 14409392 05:50:29 INFO - Obtained file size: 14409392 05:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:29 INFO - trying https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:50:29 INFO - Downloading https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:50:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:50:30 INFO - Downloaded 59581251 bytes. 05:50:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:50:30 INFO - mkdir: /builds/slave/test/properties 05:50:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:50:30 INFO - Writing to file /builds/slave/test/properties/build_url 05:50:30 INFO - Contents: 05:50:30 INFO - build_url:https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:50:31 INFO - Running post-action listener: _resource_record_post_action 05:50:31 INFO - Running post-action listener: set_extra_try_arguments 05:50:31 INFO - [mozharness: 2016-11-20 13:50:31.403610Z] Finished download-and-extract step (success) 05:50:31 INFO - [mozharness: 2016-11-20 13:50:31.403873Z] Running populate-webroot step. 05:50:31 INFO - Running pre-action listener: _resource_record_pre_action 05:50:31 INFO - Running main action method: populate_webroot 05:50:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:50:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:50:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:50:31 INFO - '--tppagecycles', 05:50:31 INFO - '7'], 05:50:31 INFO - 'tests': ['tsvgm']}}, 05:50:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:50:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:50:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:50:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:50:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:50:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:50:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:50:31 INFO - 'talos_options': ['--disable-e10s'], 05:50:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:50:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:50:31 INFO - 'talos_options': ['--disable-e10s'], 05:50:31 INFO - 'tests': ['damp', 'tps']}, 05:50:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:50:31 INFO - 'tests': ['damp', 'tps']}, 05:50:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:50:31 INFO - 'tests': ['dromaeo_dom']}, 05:50:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:50:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:50:31 INFO - 'tests': ['basic_compositor_video']}, 05:50:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:50:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:50:31 INFO - 'tests': ['a11yr', 05:50:31 INFO - 'ts_paint', 05:50:31 INFO - 'tpaint', 05:50:31 INFO - 'sessionrestore', 05:50:31 INFO - 'sessionrestore_no_auto_restore', 05:50:31 INFO - 'tabpaint']}, 05:50:31 INFO - 'other-e10s': {'tests': ['a11yr', 05:50:31 INFO - 'ts_paint', 05:50:31 INFO - 'tpaint', 05:50:31 INFO - 'sessionrestore', 05:50:31 INFO - 'sessionrestore_no_auto_restore', 05:50:31 INFO - 'tabpaint']}, 05:50:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:50:31 INFO - 'ts_paint', 05:50:31 INFO - 'tpaint', 05:50:31 INFO - 'sessionrestore', 05:50:31 INFO - 'sessionrestore_no_auto_restore', 05:50:31 INFO - 'tabpaint']}, 05:50:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:50:31 INFO - 'ts_paint', 05:50:31 INFO - 'tpaint', 05:50:31 INFO - 'sessionrestore', 05:50:31 INFO - 'sessionrestore_no_auto_restore', 05:50:31 INFO - 'tabpaint']}, 05:50:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:50:31 INFO - 'tests': ['a11yr', 05:50:31 INFO - 'ts_paint', 05:50:31 INFO - 'tpaint', 05:50:31 INFO - 'sessionrestore', 05:50:31 INFO - 'sessionrestore_no_auto_restore', 05:50:31 INFO - 'tabpaint']}, 05:50:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:50:31 INFO - 'tests': ['a11yr', 05:50:31 INFO - 'ts_paint', 05:50:31 INFO - 'tpaint', 05:50:31 INFO - 'sessionrestore', 05:50:31 INFO - 'sessionrestore_no_auto_restore', 05:50:31 INFO - 'tabpaint']}, 05:50:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:50:31 INFO - 'tests': ['tsvgx', 05:50:31 INFO - 'tsvgr_opacity', 05:50:31 INFO - 'tart', 05:50:31 INFO - 'tscrollx', 05:50:31 INFO - 'cart']}, 05:50:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:50:31 INFO - 'tsvgr_opacity', 05:50:31 INFO - 'tart', 05:50:31 INFO - 'tscrollx', 05:50:31 INFO - 'cart']}, 05:50:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:50:31 INFO - 'talos_options': ['--disable-e10s'], 05:50:31 INFO - 'tests': ['tp5o']}, 05:50:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:50:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:50:31 INFO - 'talos_options': ['--disable-e10s', 05:50:31 INFO - '--xperf_path', 05:50:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:31 INFO - 'tests': ['tp5n']}, 05:50:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:50:31 INFO - 'talos_options': ['--xperf_path', 05:50:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:31 INFO - 'tests': ['tp5n']}}, 05:50:31 INFO - 'talos.zip': {'path': '', 05:50:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:50:31 INFO - Running post-action listener: _resource_record_post_action 05:50:31 INFO - [mozharness: 2016-11-20 13:50:31.421593Z] Finished populate-webroot step (success) 05:50:31 INFO - [mozharness: 2016-11-20 13:50:31.421681Z] Running create-virtualenv step. 05:50:31 INFO - Running pre-action listener: _resource_record_pre_action 05:50:31 INFO - Running main action method: create_virtualenv 05:50:31 INFO - Creating virtualenv /builds/slave/test/build/venv 05:50:31 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 05:50:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:50:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:50:31 INFO - Using real prefix '/usr' 05:50:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:50:32 INFO - Installing distribute.............................................................................................................................................................................................done. 05:50:34 INFO - Installing pip.................done. 05:50:34 INFO - Return code: 0 05:50:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:50:34 INFO - Reading from file tmpfile_stdout 05:50:34 INFO - Output received: 05:50:34 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) 05:50:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:50:34 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')]} 05:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:34 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')]} 05:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:34 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 0x7f349da7ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ffb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1529fc0>, '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 0x152aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152b350>, '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': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', '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 05:50:34 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 05:50:34 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 05:50:34 INFO - Using env: {'DISPLAY': ':0', 05:50:34 INFO - 'HOME': '/home/cltbld', 05:50:34 INFO - 'LANG': 'en_US.UTF-8', 05:50:34 INFO - 'LANGUAGE': 'en_US:en', 05:50:34 INFO - 'LOGNAME': 'cltbld', 05:50:34 INFO - 'MAIL': '/var/mail/cltbld', 05:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:34 INFO - 'MOZ_NO_REMOTE': '1', 05:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:34 INFO - 'NO_EM_RESTART': '1', 05:50:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:34 INFO - 'PWD': '/builds/slave/test', 05:50:34 INFO - 'SHELL': '/bin/bash', 05:50:34 INFO - 'SHLVL': '1', 05:50:34 INFO - 'TERM': 'linux', 05:50:34 INFO - 'TMOUT': '86400', 05:50:34 INFO - 'USER': 'cltbld', 05:50:34 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', 05:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:34 INFO - '_': '/tools/buildbot/bin/python'} 05:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:34 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 05:50:34 INFO - Cleaning up... 05:50:34 INFO - Return code: 0 05:50:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:50:34 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')]} 05:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:34 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')]} 05:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:34 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 0x7f349da7ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ffb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1529fc0>, '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 0x152aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152b350>, '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': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', '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 05:50:34 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 05:50:34 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 05:50:34 INFO - Using env: {'DISPLAY': ':0', 05:50:34 INFO - 'HOME': '/home/cltbld', 05:50:34 INFO - 'LANG': 'en_US.UTF-8', 05:50:34 INFO - 'LANGUAGE': 'en_US:en', 05:50:34 INFO - 'LOGNAME': 'cltbld', 05:50:34 INFO - 'MAIL': '/var/mail/cltbld', 05:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:34 INFO - 'MOZ_NO_REMOTE': '1', 05:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:34 INFO - 'NO_EM_RESTART': '1', 05:50:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:34 INFO - 'PWD': '/builds/slave/test', 05:50:34 INFO - 'SHELL': '/bin/bash', 05:50:34 INFO - 'SHLVL': '1', 05:50:34 INFO - 'TERM': 'linux', 05:50:34 INFO - 'TMOUT': '86400', 05:50:34 INFO - 'USER': 'cltbld', 05:50:34 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', 05:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:34 INFO - '_': '/tools/buildbot/bin/python'} 05:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:34 INFO - Downloading/unpacking psutil>=3.1.1 05:50:34 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 05:50:34 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 05:50:34 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 05:50:34 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 05:50:34 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 05:50:34 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 05:50:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:50:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:36 INFO - Installing collected packages: psutil 05:50:36 INFO - Running setup.py install for psutil 05:50:36 INFO - building 'psutil._psutil_linux' extension 05:50:36 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 05:50:36 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 05:50:36 INFO - building 'psutil._psutil_posix' extension 05:50:36 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 05:50:37 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 05:50:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:37 INFO - Successfully installed psutil 05:50:37 INFO - Cleaning up... 05:50:37 INFO - Return code: 0 05:50:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:50:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f349da7ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ffb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1529fc0>, '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 0x152aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152b350>, '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': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', '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 05:50:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:50:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:50:37 INFO - Using env: {'DISPLAY': ':0', 05:50:37 INFO - 'HOME': '/home/cltbld', 05:50:37 INFO - 'LANG': 'en_US.UTF-8', 05:50:37 INFO - 'LANGUAGE': 'en_US:en', 05:50:37 INFO - 'LOGNAME': 'cltbld', 05:50:37 INFO - 'MAIL': '/var/mail/cltbld', 05:50:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:37 INFO - 'MOZ_NO_REMOTE': '1', 05:50:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:37 INFO - 'NO_EM_RESTART': '1', 05:50:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:37 INFO - 'PWD': '/builds/slave/test', 05:50:37 INFO - 'SHELL': '/bin/bash', 05:50:37 INFO - 'SHLVL': '1', 05:50:37 INFO - 'TERM': 'linux', 05:50:37 INFO - 'TMOUT': '86400', 05:50:37 INFO - 'USER': 'cltbld', 05:50:37 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', 05:50:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:37 INFO - '_': '/tools/buildbot/bin/python'} 05:50:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:50:37 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 05:50:37 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 05:50:37 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 05:50:37 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 05:50:37 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 05:50:37 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 05:50:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:50:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:50:39 INFO - Installing collected packages: mozsystemmonitor 05:50:39 INFO - Running setup.py install for mozsystemmonitor 05:50:39 INFO - Successfully installed mozsystemmonitor 05:50:39 INFO - Cleaning up... 05:50:39 INFO - Return code: 0 05:50:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:39 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 0x7f349da7ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ffb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1529fc0>, '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 0x152aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152b350>, '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': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', '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 05:50:39 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 05:50:39 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 05:50:39 INFO - Using env: {'DISPLAY': ':0', 05:50:39 INFO - 'HOME': '/home/cltbld', 05:50:39 INFO - 'LANG': 'en_US.UTF-8', 05:50:39 INFO - 'LANGUAGE': 'en_US:en', 05:50:39 INFO - 'LOGNAME': 'cltbld', 05:50:39 INFO - 'MAIL': '/var/mail/cltbld', 05:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:39 INFO - 'MOZ_NO_REMOTE': '1', 05:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:39 INFO - 'NO_EM_RESTART': '1', 05:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:39 INFO - 'PWD': '/builds/slave/test', 05:50:39 INFO - 'SHELL': '/bin/bash', 05:50:39 INFO - 'SHLVL': '1', 05:50:39 INFO - 'TERM': 'linux', 05:50:39 INFO - 'TMOUT': '86400', 05:50:39 INFO - 'USER': 'cltbld', 05:50:39 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', 05:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:39 INFO - '_': '/tools/buildbot/bin/python'} 05:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:39 INFO - Downloading/unpacking jsonschema==2.5.1 05:50:39 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 05:50:39 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 05:50:39 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 05:50:39 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 05:50:39 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 05:50:39 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 05:50:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:50:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:42 INFO - Downloading functools32-3.2.3-2.tar.gz 05:50:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:50:42 INFO - warning: no files found matching '*.txt' 05:50:42 INFO - no previously-included directories found matching 'build' 05:50:42 INFO - no previously-included directories found matching 'dist' 05:50:42 INFO - no previously-included directories found matching '.git*' 05:50:42 INFO - Installing collected packages: jsonschema, functools32 05:50:42 INFO - Running setup.py install for functools32 05:50:42 INFO - warning: no files found matching '*.txt' 05:50:42 INFO - no previously-included directories found matching 'build' 05:50:42 INFO - no previously-included directories found matching 'dist' 05:50:42 INFO - no previously-included directories found matching '.git*' 05:50:42 INFO - Successfully installed jsonschema functools32 05:50:42 INFO - Cleaning up... 05:50:42 INFO - Return code: 0 05:50:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:50:42 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')]} 05:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:42 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')]} 05:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:42 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 0x7f349da7ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ffb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1529fc0>, '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 0x152aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152b350>, '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': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', '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 05:50:42 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 05:50:42 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 05:50:42 INFO - Using env: {'DISPLAY': ':0', 05:50:42 INFO - 'HOME': '/home/cltbld', 05:50:42 INFO - 'LANG': 'en_US.UTF-8', 05:50:42 INFO - 'LANGUAGE': 'en_US:en', 05:50:42 INFO - 'LOGNAME': 'cltbld', 05:50:42 INFO - 'MAIL': '/var/mail/cltbld', 05:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:42 INFO - 'MOZ_NO_REMOTE': '1', 05:50:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:42 INFO - 'NO_EM_RESTART': '1', 05:50:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:42 INFO - 'PWD': '/builds/slave/test', 05:50:42 INFO - 'SHELL': '/bin/bash', 05:50:42 INFO - 'SHLVL': '1', 05:50:42 INFO - 'TERM': 'linux', 05:50:42 INFO - 'TMOUT': '86400', 05:50:42 INFO - 'USER': 'cltbld', 05:50:42 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', 05:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:42 INFO - '_': '/tools/buildbot/bin/python'} 05:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:50:42 INFO - Cleaning up... 05:50:42 INFO - Return code: 0 05:50:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:50:42 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')]} 05:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:42 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')]} 05:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:42 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 0x7f349da7ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ffb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1529fc0>, '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 0x152aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152b350>, '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': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', '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 05:50:42 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 05:50:42 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 05:50:42 INFO - Using env: {'DISPLAY': ':0', 05:50:42 INFO - 'HOME': '/home/cltbld', 05:50:42 INFO - 'LANG': 'en_US.UTF-8', 05:50:42 INFO - 'LANGUAGE': 'en_US:en', 05:50:42 INFO - 'LOGNAME': 'cltbld', 05:50:42 INFO - 'MAIL': '/var/mail/cltbld', 05:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:42 INFO - 'MOZ_NO_REMOTE': '1', 05:50:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:42 INFO - 'NO_EM_RESTART': '1', 05:50:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:42 INFO - 'PWD': '/builds/slave/test', 05:50:42 INFO - 'SHELL': '/bin/bash', 05:50:42 INFO - 'SHLVL': '1', 05:50:42 INFO - 'TERM': 'linux', 05:50:42 INFO - 'TMOUT': '86400', 05:50:42 INFO - 'USER': 'cltbld', 05:50:42 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', 05:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:42 INFO - '_': '/tools/buildbot/bin/python'} 05:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:42 INFO - Downloading/unpacking blobuploader==1.2.4 05:50:42 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 05:50:42 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 05:50:42 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 05:50:42 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 05:50:42 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 05:50:42 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 05:50:44 INFO - Downloading blobuploader-1.2.4.tar.gz 05:50:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:50:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:50:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50:45 INFO - Downloading docopt-0.6.1.tar.gz 05:50:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:50:45 INFO - Installing collected packages: blobuploader, requests, docopt 05:50:45 INFO - Running setup.py install for blobuploader 05:50:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:50:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:50:45 INFO - Running setup.py install for requests 05:50:45 INFO - Running setup.py install for docopt 05:50:46 INFO - Successfully installed blobuploader requests docopt 05:50:46 INFO - Cleaning up... 05:50:46 INFO - Return code: 0 05:50:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50:46 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')]} 05:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:46 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')]} 05:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:46 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 0x7f349da7ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ffb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1529fc0>, '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 0x152aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152b350>, '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': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', '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 05:50:46 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 05:50:46 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 05:50:46 INFO - Using env: {'DISPLAY': ':0', 05:50:46 INFO - 'HOME': '/home/cltbld', 05:50:46 INFO - 'LANG': 'en_US.UTF-8', 05:50:46 INFO - 'LANGUAGE': 'en_US:en', 05:50:46 INFO - 'LOGNAME': 'cltbld', 05:50:46 INFO - 'MAIL': '/var/mail/cltbld', 05:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:46 INFO - 'MOZ_NO_REMOTE': '1', 05:50:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:46 INFO - 'NO_EM_RESTART': '1', 05:50:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:46 INFO - 'PWD': '/builds/slave/test', 05:50:46 INFO - 'SHELL': '/bin/bash', 05:50:46 INFO - 'SHLVL': '1', 05:50:46 INFO - 'TERM': 'linux', 05:50:46 INFO - 'TMOUT': '86400', 05:50:46 INFO - 'USER': 'cltbld', 05:50:46 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', 05:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:46 INFO - '_': '/tools/buildbot/bin/python'} 05:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:50:46 INFO - Running setup.py (path:/tmp/pip-Z83X36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:50:46 INFO - Running setup.py (path:/tmp/pip-IZSbRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:50:46 INFO - Running setup.py (path:/tmp/pip-2fxKhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:50:46 INFO - Running setup.py (path:/tmp/pip-XtZ2ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:50:46 INFO - Running setup.py (path:/tmp/pip-1ZoKU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:50:46 INFO - Running setup.py (path:/tmp/pip-Fa7VrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:50:46 INFO - Running setup.py (path:/tmp/pip-vl_Jk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:50:46 INFO - Running setup.py (path:/tmp/pip-9aj4gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:50:46 INFO - Running setup.py (path:/tmp/pip-_MN34_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:50:46 INFO - Running setup.py (path:/tmp/pip-mIj1XT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:50:47 INFO - Running setup.py (path:/tmp/pip-w1Az16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:50:47 INFO - Running setup.py (path:/tmp/pip-msbMyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:50:47 INFO - Running setup.py (path:/tmp/pip-JRb4cZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:50:47 INFO - Running setup.py (path:/tmp/pip-vhdgVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:47 INFO - Running setup.py (path:/tmp/pip-56CBLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:50:47 INFO - Running setup.py (path:/tmp/pip-RJ4L4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:50:47 INFO - Running setup.py (path:/tmp/pip-MKe9Ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:50:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:50:47 INFO - Running setup.py install for manifestparser 05:50:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:50:47 INFO - Running setup.py install for mozcrash 05:50:47 INFO - Running setup.py install for mozdebug 05:50:47 INFO - Running setup.py install for mozdevice 05:50:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:50:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:50:47 INFO - Running setup.py install for mozfile 05:50:48 INFO - Running setup.py install for mozhttpd 05:50:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Running setup.py install for mozinfo 05:50:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Running setup.py install for mozInstall 05:50:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Running setup.py install for mozleak 05:50:48 INFO - Running setup.py install for mozlog 05:50:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Running setup.py install for moznetwork 05:50:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Running setup.py install for mozprocess 05:50:48 INFO - Running setup.py install for mozprofile 05:50:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Running setup.py install for mozrunner 05:50:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Running setup.py install for mozscreenshot 05:50:49 INFO - Running setup.py install for moztest 05:50:49 INFO - Running setup.py install for mozversion 05:50:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:50:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:50:49 INFO - Cleaning up... 05:50:49 INFO - Return code: 0 05:50:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:49 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 0x7f349da7ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ffb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1529fc0>, '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 0x152aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152b350>, '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': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', '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 05:50:49 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 05:50:49 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 05:50:49 INFO - Using env: {'DISPLAY': ':0', 05:50:49 INFO - 'HOME': '/home/cltbld', 05:50:49 INFO - 'LANG': 'en_US.UTF-8', 05:50:49 INFO - 'LANGUAGE': 'en_US:en', 05:50:49 INFO - 'LOGNAME': 'cltbld', 05:50:49 INFO - 'MAIL': '/var/mail/cltbld', 05:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:49 INFO - 'MOZ_NO_REMOTE': '1', 05:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:49 INFO - 'NO_EM_RESTART': '1', 05:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:49 INFO - 'PWD': '/builds/slave/test', 05:50:49 INFO - 'SHELL': '/bin/bash', 05:50:49 INFO - 'SHLVL': '1', 05:50:49 INFO - 'TERM': 'linux', 05:50:49 INFO - 'TMOUT': '86400', 05:50:49 INFO - 'USER': 'cltbld', 05:50:49 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', 05:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:49 INFO - '_': '/tools/buildbot/bin/python'} 05:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:50:49 INFO - Running setup.py (path:/tmp/pip-w0Lz0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:50:49 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)) 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:50:49 INFO - Running setup.py (path:/tmp/pip-f6nHIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:50:49 INFO - Running setup.py (path:/tmp/pip-SG7eqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:50:49 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)) 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:50:49 INFO - Running setup.py (path:/tmp/pip-7EeXJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:50:49 INFO - Running setup.py (path:/tmp/pip-TnFEYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:50:49 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)) 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:50:49 INFO - Running setup.py (path:/tmp/pip-aXf8aG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:50:49 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)) 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:50:49 INFO - Running setup.py (path:/tmp/pip-fcyWSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:50:50 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)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:50:50 INFO - Running setup.py (path:/tmp/pip-PcXnKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:50:50 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)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:50:50 INFO - Running setup.py (path:/tmp/pip-h5s62o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:50:50 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)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:50:50 INFO - Running setup.py (path:/tmp/pip-Qn8AwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:50:50 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)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:50:50 INFO - Running setup.py (path:/tmp/pip-ofA8aP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:50:50 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)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:50:50 INFO - Running setup.py (path:/tmp/pip-vIj9QH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:50:50 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)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:50:50 INFO - Running setup.py (path:/tmp/pip-DDr5vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:50:50 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)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:50:50 INFO - Running setup.py (path:/tmp/pip-aAbsz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:50 INFO - Running setup.py (path:/tmp/pip-F90Z38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:50 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)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:50:50 INFO - Running setup.py (path:/tmp/pip-jLH85W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:50:50 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)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:50:50 INFO - Running setup.py (path:/tmp/pip-PHiPTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:50:50 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)) 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:50:50 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)) 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:50:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50:52 INFO - Downloading blessings-1.6.tar.gz 05:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:50:52 INFO - Installing collected packages: blessings 05:50:52 INFO - Running setup.py install for blessings 05:50:52 INFO - Successfully installed blessings 05:50:52 INFO - Cleaning up... 05:50:52 INFO - Return code: 0 05:50:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:50:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:50:53 INFO - Reading from file tmpfile_stdout 05:50:53 INFO - Current package versions: 05:50:53 INFO - argparse == 1.2.1 05:50:53 INFO - blessings == 1.6 05:50:53 INFO - blobuploader == 1.2.4 05:50:53 INFO - docopt == 0.6.1 05:50:53 INFO - functools32 == 3.2.3-2 05:50:53 INFO - jsonschema == 2.5.1 05:50:53 INFO - manifestparser == 1.1 05:50:53 INFO - mozInstall == 1.12 05:50:53 INFO - mozcrash == 1.0 05:50:53 INFO - mozdebug == 0.1 05:50:53 INFO - mozdevice == 0.49 05:50:53 INFO - mozfile == 1.2 05:50:53 INFO - mozhttpd == 0.7 05:50:53 INFO - mozinfo == 0.9 05:50:53 INFO - mozleak == 0.1 05:50:53 INFO - mozlog == 3.4 05:50:53 INFO - moznetwork == 0.27 05:50:53 INFO - mozprocess == 0.23 05:50:53 INFO - mozprofile == 0.28 05:50:53 INFO - mozrunner == 6.13 05:50:53 INFO - mozscreenshot == 0.1 05:50:53 INFO - mozsystemmonitor == 0.3 05:50:53 INFO - moztest == 0.7 05:50:53 INFO - mozversion == 1.4 05:50:53 INFO - psutil == 3.1.1 05:50:53 INFO - requests == 1.2.3 05:50:53 INFO - wsgiref == 0.1.2 05:50:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50: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')]} 05:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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')]} 05:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:53 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 0x7f349da7ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ffb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1529fc0>, '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 0x152aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152b350>, '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': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', '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 05:50:53 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 05:50:53 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 05:50:53 INFO - Using env: {'DISPLAY': ':0', 05:50:53 INFO - 'HOME': '/home/cltbld', 05:50:53 INFO - 'LANG': 'en_US.UTF-8', 05:50:53 INFO - 'LANGUAGE': 'en_US:en', 05:50:53 INFO - 'LOGNAME': 'cltbld', 05:50:53 INFO - 'MAIL': '/var/mail/cltbld', 05:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:53 INFO - 'MOZ_NO_REMOTE': '1', 05:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:53 INFO - 'NO_EM_RESTART': '1', 05:50:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:53 INFO - 'PWD': '/builds/slave/test', 05:50:53 INFO - 'SHELL': '/bin/bash', 05:50:53 INFO - 'SHLVL': '1', 05:50:53 INFO - 'TERM': 'linux', 05:50:53 INFO - 'TMOUT': '86400', 05:50:53 INFO - 'USER': 'cltbld', 05:50:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', 05:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:53 INFO - '_': '/tools/buildbot/bin/python'} 05:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:53 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)) 05:50:53 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)) 05:50:53 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)) 05:50:53 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)) 05:50:53 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)) 05:50:53 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)) 05:50:53 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)) 05:50:53 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)) 05:50:53 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)) 05:50:53 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)) 05:50:53 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)) 05:50:53 INFO - Cleaning up... 05:50:53 INFO - Return code: 0 05:50:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:50: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')]} 05:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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')]} 05:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f349da7ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ffb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1529fc0>, '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 0x152aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152b350>, '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': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', '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 05:50: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', 'jsonschema'] in /builds/slave/test/build 05:50: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 jsonschema 05:50:53 INFO - Using env: {'DISPLAY': ':0', 05:50:53 INFO - 'HOME': '/home/cltbld', 05:50:53 INFO - 'LANG': 'en_US.UTF-8', 05:50:53 INFO - 'LANGUAGE': 'en_US:en', 05:50:53 INFO - 'LOGNAME': 'cltbld', 05:50:53 INFO - 'MAIL': '/var/mail/cltbld', 05:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:53 INFO - 'MOZ_NO_REMOTE': '1', 05:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:53 INFO - 'NO_EM_RESTART': '1', 05:50:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:53 INFO - 'PWD': '/builds/slave/test', 05:50:53 INFO - 'SHELL': '/bin/bash', 05:50:53 INFO - 'SHLVL': '1', 05:50:53 INFO - 'TERM': 'linux', 05:50:53 INFO - 'TMOUT': '86400', 05:50:53 INFO - 'USER': 'cltbld', 05:50:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', 05:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:53 INFO - '_': '/tools/buildbot/bin/python'} 05:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:50:53 INFO - Cleaning up... 05:50:53 INFO - Return code: 0 05:50:53 INFO - Running post-action listener: _resource_record_post_action 05:50:53 INFO - Running post-action listener: _start_resource_monitoring 05:50:53 INFO - Starting resource monitoring. 05:50:53 INFO - [mozharness: 2016-11-20 13:50:53.688576Z] Finished create-virtualenv step (success) 05:50:53 INFO - [mozharness: 2016-11-20 13:50:53.689050Z] Running install step. 05:50:53 INFO - Running pre-action listener: _resource_record_pre_action 05:50:53 INFO - Running main action method: install 05:50:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:50:53 INFO - Reading from file tmpfile_stdout 05:50:53 INFO - Detecting whether we're running mozinstall >=1.0... 05:50:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:50:53 INFO - Reading from file tmpfile_stdout 05:50:53 INFO - Output received: 05:50:53 INFO - Usage: mozinstall [options] installer 05:50:53 INFO - Options: 05:50:53 INFO - -h, --help show this help message and exit 05:50:53 INFO - -d DEST, --destination=DEST 05:50:53 INFO - Directory to install application into. [default: 05:50:53 INFO - "/builds/slave/test"] 05:50:53 INFO - --app=APP Application being installed. [default: firefox] 05:50:53 INFO - mkdir: /builds/slave/test/build/application 05:50:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:51:10 INFO - Reading from file tmpfile_stdout 05:51:10 INFO - Output received: 05:51:10 INFO - /builds/slave/test/build/application/firefox/firefox 05:51:10 INFO - Running post-action listener: _resource_record_post_action 05:51:10 INFO - [mozharness: 2016-11-20 13:51:10.884064Z] Finished install step (success) 05:51:10 INFO - [mozharness: 2016-11-20 13:51:10.884305Z] Running run-tests step. 05:51:10 INFO - Running pre-action listener: _resource_record_pre_action 05:51:10 INFO - Running main action method: run_tests 05:51:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:51:10 INFO - Python 2.7.3 05:51:10 INFO - Return code: 0 05:51:10 INFO - grabbing minidump binary from tooltool 05:51:10 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')]} 05:51:10 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 0x1529fc0>, '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 0x152aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152b350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:51:10 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 05:51:10 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 05:51:10 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 05:51:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:51:10 INFO - Return code: 0 05:51:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:51:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:51:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:51:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:51:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:51:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 05:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 05:51:10 INFO - Using env: {'DISPLAY': ':0', 05:51:10 INFO - 'HOME': '/home/cltbld', 05:51:10 INFO - 'LANG': 'en_US.UTF-8', 05:51:10 INFO - 'LANGUAGE': 'en_US:en', 05:51:10 INFO - 'LOGNAME': 'cltbld', 05:51:10 INFO - 'MAIL': '/var/mail/cltbld', 05:51:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:51:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:10 INFO - 'MOZ_NO_REMOTE': '1', 05:51:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:10 INFO - 'NO_EM_RESTART': '1', 05:51:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:10 INFO - 'PWD': '/builds/slave/test', 05:51:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:51:10 INFO - 'SHELL': '/bin/bash', 05:51:10 INFO - 'SHLVL': '1', 05:51:10 INFO - 'TERM': 'linux', 05:51:10 INFO - 'TMOUT': '86400', 05:51:10 INFO - 'USER': 'cltbld', 05:51:10 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266', 05:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:10 INFO - '_': '/tools/buildbot/bin/python'} 05:51:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 05:51:11 INFO - mozversion application_buildid: 20161120030205 05:51:11 INFO - mozversion application_changeset: 57a8cde3f08ca9d60bcd8bdd698ceec687f0aed2 05:51:11 INFO - mozversion application_display_name: Nightly 05:51:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:51:11 INFO - mozversion application_name: Firefox 05:51:11 INFO - mozversion application_remotingname: firefox 05:51:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:51:11 INFO - mozversion application_vendor: Mozilla 05:51:11 INFO - mozversion application_version: 53.0a1 05:51:11 INFO - mozversion platform_buildid: 20161120030205 05:51:11 INFO - mozversion platform_changeset: 57a8cde3f08ca9d60bcd8bdd698ceec687f0aed2 05:51:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:51:11 INFO - mozversion platform_version: 53.0a1 05:51:11 INFO - using testdate: 1479649871 05:51:11 INFO - actual date: 1479649871 05:51:11 INFO - starting webserver on 'localhost:32989' 05:51:11 INFO - SUITE-START | Running 2 tests 05:51:11 INFO - TEST-START | dromaeo_css 05:51:11 INFO - operating with platform_type : linux_ 05:51:11 INFO - Initialising browser for dromaeo_css test... 05:51:11 INFO - TEST-INFO | started process 14269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdYGX01/profile http://localhost:32989/getInfo.html) 05:51:15 INFO - PROCESS | 14269 | __metrics Screen width/height:1600/1200 05:51:15 INFO - PROCESS | 14269 | colorDepth:24 05:51:15 INFO - PROCESS | 14269 | Browser inner width/height: 1024/697 05:51:15 INFO - PROCESS | 14269 | __metrics 05:51:16 ERROR - PROCESS | 14269 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 05:51:16 INFO - TEST-INFO | 14269: exit 0 05:51:16 INFO - Browser initialized. 05:51:16 INFO - Running cycle 1/1 for dromaeo_css test... 05:51:16 INFO - TEST-INFO | started process 14393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdYGX01/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:29 INFO - PROCESS | 14393 | RSS: Main: 186609664 05:51:29 INFO - PROCESS | 14393 | 05:52:18 INFO - PROCESS | 14393 | 1479649938877 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] 05:54:31 INFO - PROCESS | 14393 | Cycle 1(1): loaded http://localhost:32989/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32989/tests/dromaeo/cssquery-ext.html) 05:54:32 INFO - PROCESS | 14393 | RSS: Main: 198221824 05:54:32 INFO - PROCESS | 14393 | 05:57:34 INFO - PROCESS | 14393 | Cycle 1(1): loaded http://localhost:32989/tests/dromaeo/cssquery-ext.html (next: http://localhost:32989/tests/dromaeo/cssquery-jquery.html) 05:57:35 INFO - PROCESS | 14393 | RSS: Main: 197091328 05:57:35 INFO - PROCESS | 14393 | 06:00:37 INFO - PROCESS | 14393 | Cycle 1(1): loaded http://localhost:32989/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32989/tests/dromaeo/cssquery-mootools.html) 06:00:38 INFO - PROCESS | 14393 | RSS: Main: 199548928 06:00:38 INFO - PROCESS | 14393 | 06:03:39 INFO - PROCESS | 14393 | Cycle 1(1): loaded http://localhost:32989/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32989/tests/dromaeo/cssquery-prototype.html) 06:03:40 INFO - PROCESS | 14393 | RSS: Main: 195813376 06:03:40 INFO - PROCESS | 14393 | 06:06:43 INFO - PROCESS | 14393 | Cycle 1(1): loaded http://localhost:32989/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32989/tests/dromaeo/cssquery-yui.html) 06:06:43 INFO - PROCESS | 14393 | RSS: Main: 199909376 06:06:43 INFO - PROCESS | 14393 | 06:09:46 INFO - PROCESS | 14393 | Cycle 1(1): loaded http://localhost:32989/tests/dromaeo/cssquery-yui.html (next: http://localhost:32989/tests/dromaeo/cssquery-dojo.html) 06:09:46 INFO - PROCESS | 14393 | RSS: Main: 199413760 06:09:46 INFO - PROCESS | 14393 | 06:09:46 INFO - PROCESS | 14393 | __start_tp_report 06:09:46 INFO - PROCESS | 14393 | _x_x_mozilla_page_load 06:09:46 INFO - PROCESS | 14393 | _x_x_mozilla_page_load_details 06:09:46 INFO - PROCESS | 14393 | |i|pagename|runs| 06:09:46 INFO - PROCESS | 14393 | |0;dojo.html;3119.2669722615183;3138.9372212555736;3162.3359094590137;3179.2369831240494;3183.4428974929388;5351.384590772062;5409.83770486886;5443.428440013796;5485.4788795064505;5492.038893193685;5407.621466497347;5439.700816455093;5525.475079867416;5550.47270509302;5557.499825015748;4983.576396006344;5008.6493945423745;5054.974725126369;5079.720615366154;5119.4880511948695;5021.497850214968;5124.077666020134;5153.922691159635;5175.171972484403;5215.843524694265;4966.081274964107;4967.180415231483;5018.619879533121;5021.748912554394;5085.0592640361465;5040;5043.798248070073;5047.873803154914;5081.28861959326;5099.923501147486;4995.150824359831;4999.475055119196;5003.974980125113;5016.297718319438;5045.243213517965;5431.701256430894;5452.427495113036;5466.781328746845;5484.478974497456;5549.890021995617;5900.232969713953;5921;5934.762609495615;5944.554158438134;5956.344802071769;5919.526437884959;5975.790847320323;5994.100884867261;6005.489533389624;6032.095185722133;5490.560755139619;5492.423295553989;5498.670079795225;5499.50504454601;5500.4224556420995;6017.578769486094;6031.306399764083;6055.061465472859;6086.239220097488;6088.847778805477;5680.7727690892725;5786.247787787561;5811.070228763378;5852.297724273115;5853.94146058534;5767.567432442584;5774;5872;5913.970430147908;5925.170476133345;5827.388124246978;5875.647461152259;5943.227380440515;5955.4640082391925;6059.909101363483;5701.515371193495;5773.538116950634;5971.5222782177325;5985.012472942003;5995.400459953969;4506.864794056183;4510.120526497301;4527.275635898241;4543.5910768031035;4558.0655965526985;4023.114914718757;4035.414864844581;4064;4066.34938409853;4095.9590404096175;5615.775368985195;5645.407232240637;5647.830565083054;5671.177679236487;5690.800821971211;5716.114002329646;5758.107493338539;5760.8190320984095;5829.09649004405;5973.731182096816;5551.361593416808;5563.304586926634;5592.356878958891;5605.411431799603;5607.383187849333;5032.446430892599;5051.570616497639;5089.160288552347;5091.66904151229;5159;5922.970385148046;5928.7845991572485;6092.086187071975;6095.512359011268;6128.325884152829;5824;5840.386759390203;5864.266966629171;5871.882562348815;5872.060470324727;6081.179040829431;6089.086637004308;6092;6097.4817140543555;6130.141780150871;5799.391063938226;5811.56413269015;5824.5631577631;5833.241678581757;5850.210221620197;5760;5805.8548536286935;5816.389279125631;5883.705814709333;5899.4985426239255;5783.8554036149435;5835.620684655484;5852.18069470283;5890.293164820249;5906.970465147647;5634.464725851038;5692.5730570208225;5769.423057694197;5868.149118377897;5879.176915231786;5697.003024470784;5778.56660750437;5796.913046304225;5813.941860581509;5836.649801011953;5617.241672374177;5912.260967379078;5923.763049477972;5936.079907614327;5950.166976623363;5564.19319198722;5632.971835140798;5660.801871934463;5672.773089076556;5738.282714660668 06:09:46 INFO - PROCESS | 14393 | |1;ext.html;562.9465200805923;570.5464155995983;580.7793038645312;590.6928397233436;593.4095574902972;40421.79789101054;42008.579914200884;42751.14497710044;44757;44924.77537612316;42643;43138.35292470615;43160.33137183343;43589.56410435903;43650.563494365044;8400.159984001597;8446.324294056492;8536.103709110546;8586.398952073358;8600.268977136951;8412.1587841216;8527.18991695788;8577.52823594702;8583.95708021459;8607.139286071375;8530.70142545011;8595.95702021489;8601.440906341068;8619.741407757778;8624.051354351017;8522.190391912758;8573.271271941892;8594.183552562528;8630.669719175787;8631.913680863174;8423.199796019368;8500.192481714228;8506.702265420681;8513.787155321104;8524.914750852475;40166.59833401658;40606;40617.593824061674;40650.18699626021;40709.59290407088;3106.08370530694;3175.682431756829;3343.281194543185;3593.6226696196786;3717.5538935327663;29414.411711765857;29626.111216663536;29939.700602993908;30456.54315185274;30491.23771905698;4040.4949381327333;4079.363976536205;4156.43888075109;4172.436721042651;4211.578842115795;321171;325189;325821.3708931464;325846;326551;53805.73097134489;54167.45832541703;54199;54309.45690543123;54549;35963.28073438517;37054.629453705114;37082.25835483275;38122;38387.61612383896;15140;15163.090214586939;15248.618784530476;15316.846831531764;15360.078395296094;11354.772904542027;11441.084713222923;11492.138089643311;11512.481938312796;11512.654620361403;18285.257211418393;18317.717759756957;18433.815661843477;18438.35465758692;18530.258789648262;6942.375186233263;6948.756793512304;7142.964285178541;7168.354848063699;7211.531250468703;986.4611206517856;1022.3456987527989;1051.574112484445;1099.3294090604725;1105.3423213188141;30215.395692086036;30641.38717225643;31102.572735734866;31140.377192456024;31604.209894752814;1042.166266986408;1055.024102704995;1057.7831544533353;1112.2770199370311;1132.4337831084458;15521.844781552265;15604;15917.294060009826;15961.680766384607;16203.513894583182;450980;453059;454069;454456.92060032644;454825;55827.48776305076;55902.440975590536;56317;56458.15312770312;56478;1307.3920626908343;1313.4483516922915;1329.8337707786334;1341.2690083904295;1354.3093022558369;27080.32299192457;28305.858470707513;29373.11880643584;29684.554731679473;29911.55132673055;47128.52871471241;47503.762481187376;47587.76206119086;48238.59347427218;48286.275705863736;403834;403940;405644;406169;407597;26937.191884243504;27224.319392015357;27247.591286130326;27273.86363068172;27392.315192120357;43541;44479.555204448836;44955.10089798251;45451.09097817959;45467.31799022951;37616.81191594025;37947.81026094852;38449;38829.61170388373;39561.60438395695;38272.2345553093;38422.423663645626;38614.2277154461;38629.42055869108;39334.80332598319;33653.66346336603;34450.31099377948;37865;38736;38957.41563876601;28468.43063138767;34050.829745852105;35014.29971400608;37110.62889371072;37573.24853502969;26184.214473565822;26604.73646439681;26628.733712662626;26731.465370692087;26913.192604221906 06:09:46 INFO - PROCESS | 14393 | |2;jquery.html;393.45702929956656;395.7922090902274;404.36312807328454;410.16531358685074;419.39816363518355;17522;19013.52466188346;19169.32907348243;19183.520411989706;19814.405567832953;18925.959072251022;19096.236150553963;19119.522011949673;19278.421647350602;19408.22367105314;5425.810096646608;5475.4524547545325;5695;5772.076467765159;5794.768209271645;5668.376478587352;5779.393163717812;5804.477597016267;5807.186993820868;5815.767369305223;5738.684372359518;6143.385661433866;6202.883480973423;6257.593256438339;6269.717862696167;5554.888902221933;6253.687315634223;6257.468115210213;6289.402506761873;6291.937080629226;5591.692456914868;5670.801521946753;5706.686132262724;5719.914201286984;5721.656700597978;15217.239138043164;22371;22679.433014174778;22720.65919011216;22813.885930570406;2290.415943934303;2295.91964281251;2344.812415006795;2603.2450589329073;2787.010611233003;9912.653057142965;10020.94989525055;10135.847962280572;10670.573177072907;10679.466026698712;1849.6023354978745;1868.8037756035556;1917.424772568224;1933.3426634944187;1979.2379933725476;79393;83299.16700832975;84634.99999999939;84737.57631211866;85827.57086214592;10485.318454300446;10956.945215273872;11040.710657407086;11069.280496767846;11399.772004559862;15505.534833955;15531.611709707347;15553.144577048144;15559.144247066293;15567.353549896545;7398.519096258726;7623.199564045806;7699;7715.035620547432;7740.225977402328;6844.691988860413;7096.183938846995;7135.036770035978;7246.782596522113;7258.673359698826;4653.790579423934;4680.297955306732;4791.688540244873;4823.083614113307;4900.803967841318;1891.8297353238274;1951.5999220159833;1973.6842105263088;2022.8280596149198;2052.2509284111193;828.4408024583503;947.3226642950186;963.8650588917557;986.7681094942683;1056.487603512296;17835.821641783674;18135.274589016557;18788.436346909613;18946.810531894782;19104.426867194008;888.2183678362999;954.379653225409;960.5533426956359;984.1487113646645;992.5979978108877;7819.530828150216;10655.84016239757;10702.571897124184;10713.83929241062;10750.78498430027;436329;439067;468951;474135;477108;91517;95517.6568820088;96584.51707741416;97305.51347243218;97618;955.2358113509165;968.8885778135464;997.8104160209682;1003.5684655598017;1006.094514936563;16057.598560036093;17037;17046.829531704523;17082;17548.2103305349;42622.78688606537;42753.931151720215;43275.35086973635;43426.914327142076;43528.34707479327;54237.72881135569;54267.45732542624;54814;60836.391636084845;62570.37429625646;7502.21226771203;7715.729949451742;7886.605669716377;8568.271696905833;8798.988116366443;9609.290931721527;13021.283829389096;13366.799498007733;13383.665408364868;13647.249401283025;11764.70588235301;11831.11266654987;11856.940715296369;12142.453589588666;12237.388130593257;11090.44547772592;11177.161712871404;11666.533338666359;11780.234284771463;12027.879721202677;11201.271917325348;11477.82783258235;11863.940680296544;12116.394180291127;12144.696382590506;7662.157162711986;7792.961035194788;7883.881741773764;7897.68409263623;8113.878291825746;11277.32336059839;11323.830142548033;11352.943235284101;11358.659240222807;11506.367149806842 06:09:46 INFO - PROCESS | 14393 | |3;mootools.html;1430.3920833645702;1449.2463918762244;1578.5027716269374;1672.7323628219488;1696.372342233373;7966.362690984714;8275.21385468381;8508.574571271443;8595.527246001475;8621.051684314729;8430.83138337233;8650.524221167832;8673.089325620798;8714.477131372121;8724.127587241273;2310.1683393978155;2354.564405584964;2356.6818479505305;2358.3043002314357;2360.976390236093;2310.9653355199684;2340.8010319122895;2371.490129622131;2383.5232953409386;2390.6653068570326;2312.9653055204185;2322.1640209524558;2343.9648405273933;2349.3891588187107;2352.482453860148;2235.6758270050914;2261.6720575516624;2266.61467550516;2270.1713874435877;2289.519200967799;2276.5105502317083;2291.4385975435957;2296.2996286132725;2299.367673889677;2310.6996090508296;8611.6985905493;8646.65413383464;8685.174908383693;8714;8726.996395414546;5111.591072714174;5235.73821308933;5243.737813109367;5255.054090263751;5264.894702105975;3023.3650933304034;3134.968650313513;3341.064501939461;3362.277110421271;3364.074879408158;1065.6217042949797;1076.9623063192828;1082.3830416662506;1089.493385575711;1138.669785762128;11494.942525287404;11591.710207244801;11638.94180529109;11667.824982625267;11694.532218711242;4373.737575745466;4553.658475614276;4602.907941841145;4638.675292729544;4646.256598944153;9284.675036373694;9318.627254909728;9321.72034838956;9336.719898403058;9363.297752668577;5205.765740541685;5235.188545775411;5242.0302244084205;5257.0274499217;5260.868478288074;4574.153781550423;4591.931121033187;4791.089692958327;4806.831760888352;4886.218205087169;3654.2143439160177;3778.3387907116694;3810.237952409529;3856.6143385661208;3896.5518965318784;1200.7598480303975;1205.120262208575;1217.117589747426;1217.3365515793914;1224.0085530720146;889.4929889962789;894.4990805149007;899.4648184330313;915.9542022898828;916.3219217778795;5711.914321285184;5768.278965129359;5863.941360586339;5885.440883116097;6074.726637301332;440.8523144746546;453.82300902647995;464.96840599292426;474.0944795440761;480.8365155847029;3697.6487233712755;3820.980895095562;3831.63599458051;3861.343571592836;3866.342721737255;9790.608375664893;10126.240531960133;10144.188464922789;10149.49252537385;10156.23828212887;9770.706878793648;9927.15619172364;10044.748881278027;10119.595216191417;10162.23783216247;7776.416768742367;7790.298873101448;7866.567338796307;7909.694900341494;7942;5673.631213971079;5673.858153546194;5709.771609135754;5753.9136912945505;5840.357560668238;9131.863022054542;9193.954030229806;9226.031266716898;9319.813603728024;9323.953380233055;9359.812803744024;9411.10594493522;9542.42745435276;9708.660196893075;9710.660126895526;6932.896006559805;7084.539504932163;7116.181639111568;7117.7152913882865;7166.426685865223;7644.579548124907;7704.653290601825;7715.22847715224;7730.420218483524;7731.690732370867;7182.245864184186;7183.173934997542;7276.854462910606;7376.4467664926415;7485.288897554724;7086.220515743161;7126.251743567058;7170.569765814068;7198.964005179941;7250.274972502708;6568.8357791055605;6683.498737594603;6708.094407255153;6725.293844146294;6746.696398661974;4823.397075365579;4955.752212389294;4983.327250821238;5047.375364810205;5106.565941894981;4965.900681986413;5009.273655319886;5076.213186956028;5098.209777484496;5165.922511162411 06:09:46 INFO - PROCESS | 14393 | |4;prototype.html;332.5842696629214;338.1762284920909;347.334853755059;348.4216201106163;355.62481581931087;5280.2343660169345;5375.274337964373;5479.780808767649;5523.558115350772;5581.748821303036;5227.86930326742;5332.173513105465;5401.135818269077;5412.377576578695;5415.48552887476;4253.532111467744;4264.893377665568;4283.97858010711;4303.419038429819;4308.6983911126235;4226.154769046203;4246.256905041605;4274.487061552618;4287.6569874410125;4329.177456283312;4241.533431322568;4249.893752656178;4259.446271984638;4264.765437900915;4275.935860962088;4224.845328882261;4269;4276.166147601219;4301.956980430187;4312.870613881589;3724.571674257468;3798.753081049723;3842.231553689245;3848.461215429842;3861.38217885137;5291.947080529222;5332.520073193393;5349.946500535023;5364.570834333244;5387.595930305203;4822.373091498082;4839.104765618372;4839.749516474821;4840.806367745321;4876.926846097312;5468.863278418032;5692.573057020699;5699.632088298778;5709.74306156224;5713.315081633063;4151.647109995623;4153.8961525961795;4170.311898536738;4173.624373806372;4205.432266643995;5920.467157955804;5939.970300148515;5972.104184372379;5982.431668991482;5993.340732519419;4090.402594352548;4237.5168690958535;4296.2696341621995;4308.224519586442;4317.07182955666;4229.435109009686;4294.506131794821;4307.935380969288;4307.9752516317285;4309.095090031128;4826;4892.828750993698;4896.926546101811;4929.9014019720125;4931.7040977541465;5656.321241451053;5785.942140578624;5786.553361659585;5812.273465816773;5823.359430462646;1444.732724445981;1460.5983354577363;1462.714770619719;1465.2746890289375;1473.1897456398938;970.4662435660358;1013.3717095400899;1027.2244455436248;1031.3657100883054;1032.8450732390052;5340.012097761926;5360.303160589098;5369.570434365241;5389.326334208224;5414.729263536808;5702.173184888251;5719.7426115824055;5727.570432217517;5773.913391299134;5787.768489260467;5239.716269513993;5357.821279318544;5375.6774593524515;5564.972175139179;5601.439856014447;2971.376011037706;2983.6573541906228;2984.567237750514;2985.940281194364;3005.413944280888;5590.679867854876;5811.3316968548315;5836.824895253149;5865.794697185578;5910.083936989773;5705.71471426427;5719.428057194331;5740.191839570522;5760.36635970043;5771.903338365697;5863.736131874076;5889.411058894077;5890.3226128994;5891.410858914074;5900.350961394243;5382.596305277199;5617.662940223599;5631.239782629293;5668.744906479301;5672.461116193955;5504.834854954358;5537.529310008534;5571.13647384656;5578.888422231614;5590.664560126405;5815.539753846455;5860.882782344244;5901.350851406256;5926.644401335933;5953.9404605955115;4014.799260036928;4082.3264161413035;4082.530508991504;4083.6733061354425;4084.3056680363816;5725.971370143123;5737.799177028784;5744.770209191585;5776.747068643316;5799.998001379035;5405.945940540544;5552.0290296944;5567.526760225426;5590.720463976866;5621.634593751393;5607.971960140173;5697.173909783141;5774.653520788766;5775.740091695968;5790.913136303043;5654.886902262014;5696.003199440164;5711.228984087261;5747.195392645117;5749.1663708762835;5739.339975902658;5760.769569217185;5763.279590051244;5788.942110578841;5916.881662366643;5652.745626446737;5679.233303503974;5689.345725241485;5713.971430142823;5719.8570035749435 06:09:46 INFO - PROCESS | 14393 | |5;yui.html;627.8587317853483;636.3954243468703;673.8854394752891;703.3072423662692;732.5128789355077;14173.220472873987;15590.610234744137;15625.29686164124;15790.4473343433;15896.602584935368;13909.165450073002;14108.012439129265;14153.716925661507;14222;14421.206833624146;785.3834739729299;800.5636927874323;801.1667865419956;803.0644299391203;805.8186907945724;763.9961800190991;776.8990031295924;793.1513280789558;794.7258195922426;798.9280964713174;827.896512935883;837.1461109668135;838.2120806441956;839.1985653700732;839.4207996482407;830.4311546590604;830.7507747675673;832.2925513313666;833.5957060825494;833.7707130539089;607.8237311179753;610.7923306075911;613.4601550635457;614.1003429975108;614.3978900677362;14522.201278929655;14528.564143075724;14547.70904581913;14561.053531520418;14572.635684107876;12230.327331996737;12281.69295767604;12400.689982750504;12789.360531973458;13137.73724525504;11493.942530287379;11607.709807254801;11647;11753.177277590572;11784.292942423397;4120.75275483472;4125.91748165038;4188.434561334242;4261.4460120184485;4307.289297265978;62408.68795655993;62643.686781566255;62885;63715.362846371405;64437.355626443605;9282;9360.204382627553;9517.809643807224;9538.332316737762;9619;18171.182296796676;18371;18377.632447350978;18490.44528664142;18539.629207415775;7244;7383.372413344819;7454.254574542502;7635.083789945242;7723.845523089507;4296.484421869396;4373.103513779667;4415.801288942005;4439.356293337448;4450.888727781831;3007.77441691874;3090.5518699788854;3090.6136732908385;3090.8918187863765;3096.148559146253;539.5386944162684;541.1179776963525;549.4779959038929;551.2337850387964;556.7105105345198;573.7848306884919;585.5286494372072;595.0984258847849;599.0445239842444;622.7633499270248;7738.845223095506;8265.545395003333;8408.41141120128;8423.904892364077;8457.746267611981;530.6550742017643;556.8218170185502;567.9403662615366;625.4839757200328;641.2177143884453;3847.211321679049;4095.086786737737;4123.8969025773995;4133.875983720493;4249.723767955073;64677.67661161664;80290.59854700688;84608;85359.57320213359;89341;44606.776966114965;49685.50314496881;65688;68329.31670683328;75904.24095759082;56399.71800140973;68583.65708171527;68637;68782.31217687759;68945.65527172331;7831.334336581226;7967.362610991223;8052.798680033046;8106.797330066795;8192.67229310821;46180;47233.763831182;47285.52714472811;48056.759716201195;48601.270980936024;38762.41856372213;51351;62308.37691623207;63432.68283658552;64408.35591644211;11294.717632059264;11510;11694.181407301747;11722.561732995411;11755.647330580096;12937.094403391673;13023.544175953795;13210.207387556777;13287.069905106937;13505.189688618715;12298.815517767061;12405.379731013594;12541.561045363733;12961.351932403153;13112.672183195496;11355.489002995051;11739.413029348669;12037.157398981988;12088.576899808464;12505.624831254712;11880.346580937785;12234.204776689487;12280.75438491243;12630;12826.358682066046;9405;9610.471424071464;9618.711438656852;9802.264830137625;10075.496225188564;10189.541470633987;10512.947435262775;10590.735231618963;10643.09533689614;10668.413237272025 06:09:46 INFO - PROCESS | 14393 | __end_tp_report 06:09:46 INFO - PROCESS | 14393 | __start_cc_report 06:09:46 INFO - PROCESS | 14393 | _x_x_mozilla_cycle_collect,338 06:09:46 INFO - PROCESS | 14393 | __end_cc_report 06:09:46 INFO - PROCESS | 14393 | __startTimestamp1479650986854__endTimestamp 06:09:46 INFO - PROCESS | 14393 | 06:09:46 INFO - PROCESS | 14393 | ------- Summary: start ------- 06:09:46 INFO - PROCESS | 14393 | Number of tests: 6 06:09:46 INFO - PROCESS | 14393 | 06:09:46 INFO - PROCESS | 14393 | [#0] dojo.html Cycles:165 Average:5486.74 Median:5692.57 stddev:620.28 (10.9%) stddev-sans-first:593.73 06:09:46 INFO - PROCESS | 14393 | Values: 3119.3 3138.9 3162.3 3179.2 3183.4 5351.4 5409.8 5443.4 5485.5 5492.0 5407.6 5439.7 5525.5 5550.5 5557.5 4983.6 5008.6 5055.0 5079.7 5119.5 5021.5 5124.1 5153.9 5175.2 5215.8 4966.1 4967.2 5018.6 5021.7 5085.1 5040.0 5043.8 5047.9 5081.3 5099.9 4995.2 4999.5 5004.0 5016.3 5045.2 5431.7 5452.4 5466.8 5484.5 5549.9 5900.2 5921.0 5934.8 5944.6 5956.3 5919.5 5975.8 5994.1 6005.5 6032.1 5490.6 5492.4 5498.7 5499.5 5500.4 6017.6 6031.3 6055.1 6086.2 6088.8 5680.8 5786.2 5811.1 5852.3 5853.9 5767.6 5774.0 5872.0 5914.0 5925.2 5827.4 5875.6 5943.2 5955.5 6059.9 5701.5 5773.5 5971.5 5985.0 5995.4 4506.9 4510.1 4527.3 4543.6 4558.1 4023.1 4035.4 4064.0 4066.3 4096.0 5615.8 5645.4 5647.8 5671.2 5690.8 5716.1 5758.1 5760.8 5829.1 5973.7 5551.4 5563.3 5592.4 5605.4 5607.4 5032.4 5051.6 5089.2 5091.7 5159.0 5923.0 5928.8 6092.1 6095.5 6128.3 5824.0 5840.4 5864.3 5871.9 5872.1 6081.2 6089.1 6092.0 6097.5 6130.1 5799.4 5811.6 5824.6 5833.2 5850.2 5760.0 5805.9 5816.4 5883.7 5899.5 5783.9 5835.6 5852.2 5890.3 5907.0 5634.5 5692.6 5769.4 5868.1 5879.2 5697.0 5778.6 5796.9 5813.9 5836.6 5617.2 5912.3 5923.8 5936.1 5950.2 5564.2 5633.0 5660.8 5672.8 5738.3 06:09:46 INFO - PROCESS | 14393 | 06:09:46 INFO - PROCESS | 14393 | [#1] ext.html Cycles:180 Average:54586.32 Median:38893.51 stddev:105245.08 (270.6%) stddev-sans-first:105462.16 06:09:46 INFO - PROCESS | 14393 | Values: 562.9 570.5 580.8 590.7 593.4 40421.8 42008.6 42751.1 44757.0 44924.8 42643.0 43138.4 43160.3 43589.6 43650.6 8400.2 8446.3 8536.1 8586.4 8600.3 8412.2 8527.2 8577.5 8584.0 8607.1 8530.7 8596.0 8601.4 8619.7 8624.1 8522.2 8573.3 8594.2 8630.7 8631.9 8423.2 8500.2 8506.7 8513.8 8524.9 40166.6 40606.0 40617.6 40650.2 40709.6 3106.1 3175.7 3343.3 3593.6 3717.6 29414.4 29626.1 29939.7 30456.5 30491.2 4040.5 4079.4 4156.4 4172.4 4211.6 321171.0 325189.0 325821.4 325846.0 326551.0 53805.7 54167.5 54199.0 54309.5 54549.0 35963.3 37054.6 37082.3 38122.0 38387.6 15140.0 15163.1 15248.6 15316.8 15360.1 11354.8 11441.1 11492.1 11512.5 11512.7 18285.3 18317.7 18433.8 18438.4 18530.3 6942.4 6948.8 7143.0 7168.4 7211.5 986.5 1022.3 1051.6 1099.3 1105.3 30215.4 30641.4 31102.6 31140.4 31604.2 1042.2 1055.0 1057.8 1112.3 1132.4 15521.8 15604.0 15917.3 15961.7 16203.5 450980.0 453059.0 454069.0 454456.9 454825.0 55827.5 55902.4 56317.0 56458.2 56478.0 1307.4 1313.4 1329.8 1341.3 1354.3 27080.3 28305.9 29373.1 29684.6 29911.6 47128.5 47503.8 47587.8 48238.6 48286.3 403834.0 403940.0 405644.0 406169.0 407597.0 26937.2 27224.3 27247.6 27273.9 27392.3 43541.0 44479.6 44955.1 45451.1 45467.3 37616.8 37947.8 38449.0 38829.6 39561.6 38272.2 38422.4 38614.2 38629.4 39334.8 33653.7 34450.3 37865.0 38736.0 38957.4 28468.4 34050.8 35014.3 37110.6 37573.2 26184.2 26604.7 26628.7 26731.5 26913.2 06:09:46 INFO - PROCESS | 14393 | 06:09:46 INFO - PROCESS | 14393 | [#2] jquery.html Cycles:180 Average:28175.83 Median:42688.36 stddev:76110.39 (178.3%) stddev-sans-first:76295.31 06:09:46 INFO - PROCESS | 14393 | Values: 393.5 395.8 404.4 410.2 419.4 17522.0 19013.5 19169.3 19183.5 19814.4 18926.0 19096.2 19119.5 19278.4 19408.2 5425.8 5475.5 5695.0 5772.1 5794.8 5668.4 5779.4 5804.5 5807.2 5815.8 5738.7 6143.4 6202.9 6257.6 6269.7 5554.9 6253.7 6257.5 6289.4 6291.9 5591.7 5670.8 5706.7 5719.9 5721.7 15217.2 22371.0 22679.4 22720.7 22813.9 2290.4 2295.9 2344.8 2603.2 2787.0 9912.7 10020.9 10135.8 10670.6 10679.5 1849.6 1868.8 1917.4 1933.3 1979.2 79393.0 83299.2 84635.0 84737.6 85827.6 10485.3 10956.9 11040.7 11069.3 11399.8 15505.5 15531.6 15553.1 15559.1 15567.4 7398.5 7623.2 7699.0 7715.0 7740.2 6844.7 7096.2 7135.0 7246.8 7258.7 4653.8 4680.3 4791.7 4823.1 4900.8 1891.8 1951.6 1973.7 2022.8 2052.3 828.4 947.3 963.9 986.8 1056.5 17835.8 18135.3 18788.4 18946.8 19104.4 888.2 954.4 960.6 984.1 992.6 7819.5 10655.8 10702.6 10713.8 10750.8 436329.0 439067.0 468951.0 474135.0 477108.0 91517.0 95517.7 96584.5 97305.5 97618.0 955.2 968.9 997.8 1003.6 1006.1 16057.6 17037.0 17046.8 17082.0 17548.2 42622.8 42753.9 43275.4 43426.9 43528.3 54237.7 54267.5 54814.0 60836.4 62570.4 7502.2 7715.7 7886.6 8568.3 8799.0 9609.3 13021.3 13366.8 13383.7 13647.2 11764.7 11831.1 11856.9 12142.5 12237.4 11090.4 11177.2 11666.5 11780.2 12027.9 11201.3 11477.8 11863.9 12116.4 12144.7 7662.2 7793.0 7883.9 7897.7 8113.9 11277.3 11323.8 11352.9 11358.7 11506.4 06:09:46 INFO - PROCESS | 14393 | 06:09:46 INFO - PROCESS | 14393 | [#3] mootools.html Cycles:180 Average:5511.29 Median:5109.08 stddev:3063.55 (60.0%) stddev-sans-first:3056.79 06:09:46 INFO - PROCESS | 14393 | Values: 1430.4 1449.2 1578.5 1672.7 1696.4 7966.4 8275.2 8508.6 8595.5 8621.1 8430.8 8650.5 8673.1 8714.5 8724.1 2310.2 2354.6 2356.7 2358.3 2361.0 2311.0 2340.8 2371.5 2383.5 2390.7 2313.0 2322.2 2344.0 2349.4 2352.5 2235.7 2261.7 2266.6 2270.2 2289.5 2276.5 2291.4 2296.3 2299.4 2310.7 8611.7 8646.7 8685.2 8714.0 8727.0 5111.6 5235.7 5243.7 5255.1 5264.9 3023.4 3135.0 3341.1 3362.3 3364.1 1065.6 1077.0 1082.4 1089.5 1138.7 11494.9 11591.7 11638.9 11667.8 11694.5 4373.7 4553.7 4602.9 4638.7 4646.3 9284.7 9318.6 9321.7 9336.7 9363.3 5205.8 5235.2 5242.0 5257.0 5260.9 4574.2 4591.9 4791.1 4806.8 4886.2 3654.2 3778.3 3810.2 3856.6 3896.6 1200.8 1205.1 1217.1 1217.3 1224.0 889.5 894.5 899.5 916.0 916.3 5711.9 5768.3 5863.9 5885.4 6074.7 440.9 453.8 465.0 474.1 480.8 3697.6 3821.0 3831.6 3861.3 3866.3 9790.6 10126.2 10144.2 10149.5 10156.2 9770.7 9927.2 10044.7 10119.6 10162.2 7776.4 7790.3 7866.6 7909.7 7942.0 5673.6 5673.9 5709.8 5753.9 5840.4 9131.9 9194.0 9226.0 9319.8 9324.0 9359.8 9411.1 9542.4 9708.7 9710.7 6932.9 7084.5 7116.2 7117.7 7166.4 7644.6 7704.7 7715.2 7730.4 7731.7 7182.2 7183.2 7276.9 7376.4 7485.3 7086.2 7126.3 7170.6 7199.0 7250.3 6568.8 6683.5 6708.1 6725.3 6746.7 4823.4 4955.8 4983.3 5047.4 5106.6 4965.9 5009.3 5076.2 5098.2 5165.9 06:09:46 INFO - PROCESS | 14393 | 06:09:46 INFO - PROCESS | 14393 | [#4] prototype.html Cycles:180 Average:4778.41 Median:5395.23 stddev:1382.10 (25.6%) stddev-sans-first:1345.09 06:09:46 INFO - PROCESS | 14393 | Values: 332.6 338.2 347.3 348.4 355.6 5280.2 5375.3 5479.8 5523.6 5581.7 5227.9 5332.2 5401.1 5412.4 5415.5 4253.5 4264.9 4284.0 4303.4 4308.7 4226.2 4246.3 4274.5 4287.7 4329.2 4241.5 4249.9 4259.4 4264.8 4275.9 4224.8 4269.0 4276.2 4302.0 4312.9 3724.6 3798.8 3842.2 3848.5 3861.4 5291.9 5332.5 5349.9 5364.6 5387.6 4822.4 4839.1 4839.7 4840.8 4876.9 5468.9 5692.6 5699.6 5709.7 5713.3 4151.6 4153.9 4170.3 4173.6 4205.4 5920.5 5940.0 5972.1 5982.4 5993.3 4090.4 4237.5 4296.3 4308.2 4317.1 4229.4 4294.5 4307.9 4308.0 4309.1 4826.0 4892.8 4896.9 4929.9 4931.7 5656.3 5785.9 5786.6 5812.3 5823.4 1444.7 1460.6 1462.7 1465.3 1473.2 970.5 1013.4 1027.2 1031.4 1032.8 5340.0 5360.3 5369.6 5389.3 5414.7 5702.2 5719.7 5727.6 5773.9 5787.8 5239.7 5357.8 5375.7 5565.0 5601.4 2971.4 2983.7 2984.6 2985.9 3005.4 5590.7 5811.3 5836.8 5865.8 5910.1 5705.7 5719.4 5740.2 5760.4 5771.9 5863.7 5889.4 5890.3 5891.4 5900.4 5382.6 5617.7 5631.2 5668.7 5672.5 5504.8 5537.5 5571.1 5578.9 5590.7 5815.5 5860.9 5901.4 5926.6 5953.9 4014.8 4082.3 4082.5 4083.7 4084.3 5726.0 5737.8 5744.8 5776.7 5800.0 5405.9 5552.0 5567.5 5590.7 5621.6 5608.0 5697.2 5774.7 5775.7 5790.9 5654.9 5696.0 5711.2 5747.2 5749.2 5739.3 5760.8 5763.3 5788.9 5916.9 5652.7 5679.2 5689.3 5714.0 5719.9 06:09:46 INFO - PROCESS | 14393 | 06:09:46 INFO - PROCESS | 14393 | [#5] yui.html Cycles:180 Average:16630.82 Median:535.10 stddev:21791.00 (4072.3%) stddev-sans-first:21819.00 06:09:46 INFO - PROCESS | 14393 | Values: 627.9 636.4 673.9 703.3 732.5 14173.2 15590.6 15625.3 15790.4 15896.6 13909.2 14108.0 14153.7 14222.0 14421.2 785.4 800.6 801.2 803.1 805.8 764.0 776.9 793.2 794.7 798.9 827.9 837.1 838.2 839.2 839.4 830.4 830.8 832.3 833.6 833.8 607.8 610.8 613.5 614.1 614.4 14522.2 14528.6 14547.7 14561.1 14572.6 12230.3 12281.7 12400.7 12789.4 13137.7 11493.9 11607.7 11647.0 11753.2 11784.3 4120.8 4125.9 4188.4 4261.4 4307.3 62408.7 62643.7 62885.0 63715.4 64437.4 9282.0 9360.2 9517.8 9538.3 9619.0 18171.2 18371.0 18377.6 18490.4 18539.6 7244.0 7383.4 7454.3 7635.1 7723.8 4296.5 4373.1 4415.8 4439.4 4450.9 3007.8 3090.6 3090.6 3090.9 3096.1 539.5 541.1 549.5 551.2 556.7 573.8 585.5 595.1 599.0 622.8 7738.8 8265.5 8408.4 8423.9 8457.7 530.7 556.8 567.9 625.5 641.2 3847.2 4095.1 4123.9 4133.9 4249.7 64677.7 80290.6 84608.0 85359.6 89341.0 44606.8 49685.5 65688.0 68329.3 75904.2 56399.7 68583.7 68637.0 68782.3 68945.7 7831.3 7967.4 8052.8 8106.8 8192.7 46180.0 47233.8 47285.5 48056.8 48601.3 38762.4 51351.0 62308.4 63432.7 64408.4 11294.7 11510.0 11694.2 11722.6 11755.6 12937.1 13023.5 13210.2 13287.1 13505.2 12298.8 12405.4 12541.6 12961.4 13112.7 11355.5 11739.4 12037.2 12088.6 12505.6 11880.3 12234.2 12280.8 12630.0 12826.4 9405.0 9610.5 9618.7 9802.3 10075.5 10189.5 10512.9 10590.7 10643.1 10668.4 06:09:46 INFO - PROCESS | 14393 | -------- Summary: end -------- 06:09:46 INFO - PROCESS | 14393 | 06:09:47 INFO - TEST-INFO | 14393: exit 0 06:09:47 INFO - TEST-OK | dromaeo_css | took 1116698ms 06:09:47 INFO - TEST-START | kraken 06:09:47 INFO - operating with platform_type : linux_ 06:09:47 INFO - Initialising browser for kraken test... 06:09:47 INFO - TEST-INFO | started process 14748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCj4wf1/profile http://localhost:32989/getInfo.html) 06:09:52 INFO - PROCESS | 14748 | __metrics Screen width/height:1600/1200 06:09:52 INFO - PROCESS | 14748 | colorDepth:24 06:09:52 INFO - PROCESS | 14748 | Browser inner width/height: 1024/697 06:09:52 INFO - PROCESS | 14748 | __metrics 06:09:52 ERROR - PROCESS | 14748 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 06:09:53 INFO - TEST-INFO | 14748: exit 0 06:09:53 INFO - Browser initialized. 06:09:53 INFO - Running cycle 1/1 for kraken test... 06:09:53 INFO - TEST-INFO | started process 14870 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCj4wf1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:10:05 INFO - PROCESS | 14870 | RSS: Main: 186355712 06:10:05 INFO - PROCESS | 14870 | 06:10:08 INFO - PROCESS | 14870 | Cycle 1(1): loaded http://localhost:32989/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32989/tests/kraken/driver.html?testName=audio-beat-detection) 06:10:09 INFO - PROCESS | 14870 | RSS: Main: 199294976 06:10:09 INFO - PROCESS | 14870 | 06:10:12 INFO - PROCESS | 14870 | Cycle 1(1): loaded http://localhost:32989/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32989/tests/kraken/driver.html?testName=audio-dft) 06:10:12 INFO - PROCESS | 14870 | RSS: Main: 197242880 06:10:12 INFO - PROCESS | 14870 | 06:10:15 INFO - PROCESS | 14870 | Cycle 1(1): loaded http://localhost:32989/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32989/tests/kraken/driver.html?testName=audio-fft) 06:10:16 INFO - PROCESS | 14870 | RSS: Main: 193646592 06:10:16 INFO - PROCESS | 14870 | 06:10:18 INFO - PROCESS | 14870 | Cycle 1(1): loaded http://localhost:32989/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32989/tests/kraken/driver.html?testName=audio-oscillator) 06:10:19 INFO - PROCESS | 14870 | RSS: Main: 194310144 06:10:19 INFO - PROCESS | 14870 | 06:10:21 INFO - PROCESS | 14870 | Cycle 1(1): loaded http://localhost:32989/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32989/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:10:21 INFO - PROCESS | 14870 | RSS: Main: 194387968 06:10:21 INFO - PROCESS | 14870 | 06:10:24 INFO - PROCESS | 14870 | Cycle 1(1): loaded http://localhost:32989/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32989/tests/kraken/driver.html?testName=imaging-darkroom) 06:10:25 INFO - PROCESS | 14870 | RSS: Main: 200183808 06:10:25 INFO - PROCESS | 14870 | 06:10:28 INFO - PROCESS | 14870 | Cycle 1(1): loaded http://localhost:32989/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32989/tests/kraken/driver.html?testName=imaging-desaturate) 06:10:29 INFO - PROCESS | 14870 | RSS: Main: 196083712 06:10:29 INFO - PROCESS | 14870 | 06:10:32 INFO - PROCESS | 14870 | Cycle 1(1): loaded http://localhost:32989/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32989/tests/kraken/driver.html?testName=json-parse-financial) 06:10:33 INFO - PROCESS | 14870 | RSS: Main: 197906432 06:10:33 INFO - PROCESS | 14870 | 06:10:34 INFO - PROCESS | 14870 | Cycle 1(1): loaded http://localhost:32989/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32989/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:10:35 INFO - PROCESS | 14870 | RSS: Main: 197660672 06:10:35 INFO - PROCESS | 14870 | 06:10:37 INFO - PROCESS | 14870 | Cycle 1(1): loaded http://localhost:32989/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32989/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:10:37 INFO - PROCESS | 14870 | RSS: Main: 197779456 06:10:37 INFO - PROCESS | 14870 | 06:10:39 INFO - PROCESS | 14870 | Cycle 1(1): loaded http://localhost:32989/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32989/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:10:40 INFO - PROCESS | 14870 | RSS: Main: 197943296 06:10:40 INFO - PROCESS | 14870 | 06:10:43 INFO - PROCESS | 14870 | Cycle 1(1): loaded http://localhost:32989/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:10:43 INFO - PROCESS | 14870 | RSS: Main: 197861376 06:10:43 INFO - PROCESS | 14870 | 06:10:46 INFO - PROCESS | 14870 | Cycle 1(1): loaded http://localhost:32989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:10:47 INFO - PROCESS | 14870 | RSS: Main: 198004736 06:10:47 INFO - PROCESS | 14870 | 06:10:49 INFO - PROCESS | 14870 | Cycle 1(1): loaded http://localhost:32989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32989/tests/kraken/driver.html?testName=ai-astar) 06:10:49 INFO - PROCESS | 14870 | RSS: Main: 199061504 06:10:49 INFO - PROCESS | 14870 | 06:10:49 INFO - PROCESS | 14870 | __start_tp_report 06:10:49 INFO - PROCESS | 14870 | _x_x_mozilla_page_load 06:10:49 INFO - PROCESS | 14870 | _x_x_mozilla_page_load_details 06:10:49 INFO - PROCESS | 14870 | |i|pagename|runs| 06:10:49 INFO - PROCESS | 14870 | |0;ai-astar;106;116;113;114;115;115;113;112;114;115 06:10:49 INFO - PROCESS | 14870 | |1;audio-beat-detection;156;127;127;175;127;125;126;126;175;128 06:10:49 INFO - PROCESS | 14870 | |2;audio-dft;161;163;175;171;163;164;163;164;165;164 06:10:49 INFO - PROCESS | 14870 | |3;audio-fft;76;75;75;112;77;75;77;76;101;75 06:10:49 INFO - PROCESS | 14870 | |4;audio-oscillator;83;83;112;82;83;81;100;82;81;114 06:10:49 INFO - PROCESS | 14870 | |5;imaging-gaussian-blur;118;117;118;117;117;117;122;117;118;117 06:10:49 INFO - PROCESS | 14870 | |6;imaging-darkroom;148;149;148;148;148;147;146;148;146;148 06:10:49 INFO - PROCESS | 14870 | |7;imaging-desaturate;97;97;97;96;96;96;95;97;96;95 06:10:49 INFO - PROCESS | 14870 | |8;json-parse-financial;52;52;52;54;54;55;54;53;53;58 06:10:49 INFO - PROCESS | 14870 | |9;json-stringify-tinderbox;63;63;61;62;63;63;62;63;62;63 06:10:49 INFO - PROCESS | 14870 | |10;stanford-crypto-aes;82;87;83;82;83;82;80;82;82;92 06:10:49 INFO - PROCESS | 14870 | |11;stanford-crypto-ccm;135;133;133;148;137;135;138;143;183;132 06:10:49 INFO - PROCESS | 14870 | |12;stanford-crypto-pbkdf2;167;176;173;165;170;169;169;175;168;168 06:10:49 INFO - PROCESS | 14870 | |13;stanford-crypto-sha256-iterative;65;66;65;66;68;71;66;64;64;63 06:10:49 INFO - PROCESS | 14870 | __end_tp_report 06:10:49 INFO - PROCESS | 14870 | __start_cc_report 06:10:49 INFO - PROCESS | 14870 | _x_x_mozilla_cycle_collect,825 06:10:49 INFO - PROCESS | 14870 | __end_cc_report 06:10:49 INFO - PROCESS | 14870 | __startTimestamp1479651049308__endTimestamp 06:10:49 INFO - PROCESS | 14870 | 06:10:49 INFO - PROCESS | 14870 | ------- Summary: start ------- 06:10:49 INFO - PROCESS | 14870 | Number of tests: 14 06:10:49 INFO - PROCESS | 14870 | 06:10:49 INFO - PROCESS | 14870 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.50 stddev:2.83 (2.5%) stddev-sans-first:1.27 06:10:49 INFO - PROCESS | 14870 | Values: 106.0 116.0 113.0 114.0 115.0 115.0 113.0 112.0 114.0 115.0 06:10:49 INFO - PROCESS | 14870 | 06:10:49 INFO - PROCESS | 14870 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:127.50 stddev:21.00 (16.5%) stddev-sans-first:21.37 06:10:49 INFO - PROCESS | 14870 | Values: 156.0 127.0 127.0 175.0 127.0 125.0 126.0 126.0 175.0 128.0 06:10:49 INFO - PROCESS | 14870 | 06:10:49 INFO - PROCESS | 14870 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.00 stddev:4.30 (2.6%) stddev-sans-first:4.27 06:10:49 INFO - PROCESS | 14870 | Values: 161.0 163.0 175.0 171.0 163.0 164.0 163.0 164.0 165.0 164.0 06:10:49 INFO - PROCESS | 14870 | 06:10:49 INFO - PROCESS | 14870 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.50 stddev:13.25 (17.5%) stddev-sans-first:13.88 06:10:49 INFO - PROCESS | 14870 | Values: 76.0 75.0 75.0 112.0 77.0 75.0 77.0 76.0 101.0 75.0 06:10:49 INFO - PROCESS | 14870 | 06:10:49 INFO - PROCESS | 14870 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:82.00 stddev:13.32 (16.2%) stddev-sans-first:13.88 06:10:49 INFO - PROCESS | 14870 | Values: 83.0 83.0 112.0 82.0 83.0 81.0 100.0 82.0 81.0 114.0 06:10:49 INFO - PROCESS | 14870 | 06:10:49 INFO - PROCESS | 14870 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:117.50 stddev:1.55 (1.3%) stddev-sans-first:1.64 06:10:49 INFO - PROCESS | 14870 | Values: 118.0 117.0 118.0 117.0 117.0 117.0 122.0 117.0 118.0 117.0 06:10:49 INFO - PROCESS | 14870 | 06:10:49 INFO - PROCESS | 14870 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 06:10:49 INFO - PROCESS | 14870 | Values: 148.0 149.0 148.0 148.0 148.0 147.0 146.0 148.0 146.0 148.0 06:10:49 INFO - PROCESS | 14870 | 06:10:49 INFO - PROCESS | 14870 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.50 stddev:0.79 (0.8%) stddev-sans-first:0.78 06:10:49 INFO - PROCESS | 14870 | Values: 97.0 97.0 97.0 96.0 96.0 96.0 95.0 97.0 96.0 95.0 06:10:49 INFO - PROCESS | 14870 | 06:10:49 INFO - PROCESS | 14870 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.83 (3.4%) stddev-sans-first:1.83 06:10:49 INFO - PROCESS | 14870 | Values: 52.0 52.0 52.0 54.0 54.0 55.0 54.0 53.0 53.0 58.0 06:10:49 INFO - PROCESS | 14870 | 06:10:49 INFO - PROCESS | 14870 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 06:10:49 INFO - PROCESS | 14870 | Values: 63.0 63.0 61.0 62.0 63.0 63.0 62.0 63.0 62.0 63.0 06:10:49 INFO - PROCESS | 14870 | 06:10:49 INFO - PROCESS | 14870 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:82.50 stddev:3.47 (4.2%) stddev-sans-first:3.64 06:10:49 INFO - PROCESS | 14870 | Values: 82.0 87.0 83.0 82.0 83.0 82.0 80.0 82.0 82.0 92.0 06:10:49 INFO - PROCESS | 14870 | 06:10:49 INFO - PROCESS | 14870 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:137.50 stddev:15.34 (11.2%) stddev-sans-first:16.08 06:10:49 INFO - PROCESS | 14870 | Values: 135.0 133.0 133.0 148.0 137.0 135.0 138.0 143.0 183.0 132.0 06:10:49 INFO - PROCESS | 14870 | 06:10:49 INFO - PROCESS | 14870 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:169.50 stddev:3.56 (2.1%) stddev-sans-first:3.61 06:10:49 INFO - PROCESS | 14870 | Values: 167.0 176.0 173.0 165.0 170.0 169.0 169.0 175.0 168.0 168.0 06:10:49 INFO - PROCESS | 14870 | 06:10:49 INFO - PROCESS | 14870 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:2.30 (3.5%) stddev-sans-first:2.42 06:10:49 INFO - PROCESS | 14870 | Values: 65.0 66.0 65.0 66.0 68.0 71.0 66.0 64.0 64.0 63.0 06:10:49 INFO - PROCESS | 14870 | -------- Summary: end -------- 06:10:49 INFO - PROCESS | 14870 | 06:10:50 INFO - TEST-INFO | 14870: exit 0 06:10:50 INFO - TEST-OK | kraken | took 62629ms 06:10:50 INFO - SUITE-END | took 1179s 06:10:50 INFO - Completed test suite (00:19:39) 06:10:50 INFO - javascript benchmark 06:10:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7013.609977059274, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.2669722615183, 3138.9372212555736, 3162.3359094590137, 3179.2369831240494, 3183.4428974929388, 5351.384590772062, 5409.83770486886, 5443.428440013796, 5485.4788795064505, 5492.038893193685, 5407.621466497347, 5439.700816455093, 5525.475079867416, 5550.47270509302, 5557.499825015748, 4983.576396006344, 5008.6493945423745, 5054.974725126369, 5079.720615366154, 5119.4880511948695, 5021.497850214968, 5124.077666020134, 5153.922691159635, 5175.171972484403, 5215.843524694265, 4966.081274964107, 4967.180415231483, 5018.619879533121, 5021.748912554394, 5085.0592640361465, 5040.0, 5043.798248070073, 5047.873803154914, 5081.28861959326, 5099.923501147486, 4995.150824359831, 4999.475055119196, 5003.974980125113, 5016.297718319438, 5045.243213517965, 5431.701256430894, 5452.427495113036, 5466.781328746845, 5484.478974497456, 5549.890021995617, 5900.232969713953, 5921.0, 5934.762609495615, 5944.554158438134, 5956.344802071769, 5919.526437884959, 5975.790847320323, 5994.100884867261, 6005.489533389624, 6032.095185722133, 5490.560755139619, 5492.423295553989, 5498.670079795225, 5499.50504454601, 5500.4224556420995, 6017.578769486094, 6031.306399764083, 6055.061465472859, 6086.239220097488, 6088.847778805477, 5680.7727690892725, 5786.247787787561, 5811.070228763378, 5852.297724273115, 5853.94146058534, 5767.567432442584, 5774.0, 5872.0, 5913.970430147908, 5925.170476133345, 5827.388124246978, 5875.647461152259, 5943.227380440515, 5955.4640082391925, 6059.909101363483, 5701.515371193495, 5773.538116950634, 5971.5222782177325, 5985.012472942003, 5995.400459953969, 4506.864794056183, 4510.120526497301, 4527.275635898241, 4543.5910768031035, 4558.0655965526985, 4023.114914718757, 4035.414864844581, 4064.0, 4066.34938409853, 4095.9590404096175, 5615.775368985195, 5645.407232240637, 5647.830565083054, 5671.177679236487, 5690.800821971211, 5716.114002329646, 5758.107493338539, 5760.8190320984095, 5829.09649004405, 5973.731182096816, 5551.361593416808, 5563.304586926634, 5592.356878958891, 5605.411431799603, 5607.383187849333, 5032.446430892599, 5051.570616497639, 5089.160288552347, 5091.66904151229, 5159.0, 5922.970385148046, 5928.7845991572485, 6092.086187071975, 6095.512359011268, 6128.325884152829, 5824.0, 5840.386759390203, 5864.266966629171, 5871.882562348815, 5872.060470324727, 6081.179040829431, 6089.086637004308, 6092.0, 6097.4817140543555, 6130.141780150871, 5799.391063938226, 5811.56413269015, 5824.5631577631, 5833.241678581757, 5850.210221620197, 5760.0, 5805.8548536286935, 5816.389279125631, 5883.705814709333, 5899.4985426239255, 5783.8554036149435, 5835.620684655484, 5852.18069470283, 5890.293164820249, 5906.970465147647, 5634.464725851038, 5692.5730570208225, 5769.423057694197, 5868.149118377897, 5879.176915231786, 5697.003024470784, 5778.56660750437, 5796.913046304225, 5813.941860581509, 5836.649801011953, 5617.241672374177, 5912.260967379078, 5923.763049477972, 5936.079907614327, 5950.166976623363, 5564.19319198722, 5632.971835140798, 5660.801871934463, 5672.773089076556, 5738.282714660668], "value": 5444.7346249513175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.9465200805923, 570.5464155995983, 580.7793038645312, 590.6928397233436, 593.4095574902972, 40421.79789101054, 42008.579914200884, 42751.14497710044, 44757.0, 44924.77537612316, 42643.0, 43138.35292470615, 43160.33137183343, 43589.56410435903, 43650.563494365044, 8400.159984001597, 8446.324294056492, 8536.103709110546, 8586.398952073358, 8600.268977136951, 8412.1587841216, 8527.18991695788, 8577.52823594702, 8583.95708021459, 8607.139286071375, 8530.70142545011, 8595.95702021489, 8601.440906341068, 8619.741407757778, 8624.051354351017, 8522.190391912758, 8573.271271941892, 8594.183552562528, 8630.669719175787, 8631.913680863174, 8423.199796019368, 8500.192481714228, 8506.702265420681, 8513.787155321104, 8524.914750852475, 40166.59833401658, 40606.0, 40617.593824061674, 40650.18699626021, 40709.59290407088, 3106.08370530694, 3175.682431756829, 3343.281194543185, 3593.6226696196786, 3717.5538935327663, 29414.411711765857, 29626.111216663536, 29939.700602993908, 30456.54315185274, 30491.23771905698, 4040.4949381327333, 4079.363976536205, 4156.43888075109, 4172.436721042651, 4211.578842115795, 321171.0, 325189.0, 325821.3708931464, 325846.0, 326551.0, 53805.73097134489, 54167.45832541703, 54199.0, 54309.45690543123, 54549.0, 35963.28073438517, 37054.629453705114, 37082.25835483275, 38122.0, 38387.61612383896, 15140.0, 15163.090214586939, 15248.618784530476, 15316.846831531764, 15360.078395296094, 11354.772904542027, 11441.084713222923, 11492.138089643311, 11512.481938312796, 11512.654620361403, 18285.257211418393, 18317.717759756957, 18433.815661843477, 18438.35465758692, 18530.258789648262, 6942.375186233263, 6948.756793512304, 7142.964285178541, 7168.354848063699, 7211.531250468703, 986.4611206517856, 1022.3456987527989, 1051.574112484445, 1099.3294090604725, 1105.3423213188141, 30215.395692086036, 30641.38717225643, 31102.572735734866, 31140.377192456024, 31604.209894752814, 1042.166266986408, 1055.024102704995, 1057.7831544533353, 1112.2770199370311, 1132.4337831084458, 15521.844781552265, 15604.0, 15917.294060009826, 15961.680766384607, 16203.513894583182, 450980.0, 453059.0, 454069.0, 454456.92060032644, 454825.0, 55827.48776305076, 55902.440975590536, 56317.0, 56458.15312770312, 56478.0, 1307.3920626908343, 1313.4483516922915, 1329.8337707786334, 1341.2690083904295, 1354.3093022558369, 27080.32299192457, 28305.858470707513, 29373.11880643584, 29684.554731679473, 29911.55132673055, 47128.52871471241, 47503.762481187376, 47587.76206119086, 48238.59347427218, 48286.275705863736, 403834.0, 403940.0, 405644.0, 406169.0, 407597.0, 26937.191884243504, 27224.319392015357, 27247.591286130326, 27273.86363068172, 27392.315192120357, 43541.0, 44479.555204448836, 44955.10089798251, 45451.09097817959, 45467.31799022951, 37616.81191594025, 37947.81026094852, 38449.0, 38829.61170388373, 39561.60438395695, 38272.2345553093, 38422.423663645626, 38614.2277154461, 38629.42055869108, 39334.80332598319, 33653.66346336603, 34450.31099377948, 37865.0, 38736.0, 38957.41563876601, 28468.43063138767, 34050.829745852105, 35014.29971400608, 37110.62889371072, 37573.24853502969, 26184.214473565822, 26604.73646439681, 26628.733712662626, 26731.465370692087, 26913.192604221906], "value": 18846.48076523787, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.45702929956656, 395.7922090902274, 404.36312807328454, 410.16531358685074, 419.39816363518355, 17522.0, 19013.52466188346, 19169.32907348243, 19183.520411989706, 19814.405567832953, 18925.959072251022, 19096.236150553963, 19119.522011949673, 19278.421647350602, 19408.22367105314, 5425.810096646608, 5475.4524547545325, 5695.0, 5772.076467765159, 5794.768209271645, 5668.376478587352, 5779.393163717812, 5804.477597016267, 5807.186993820868, 5815.767369305223, 5738.684372359518, 6143.385661433866, 6202.883480973423, 6257.593256438339, 6269.717862696167, 5554.888902221933, 6253.687315634223, 6257.468115210213, 6289.402506761873, 6291.937080629226, 5591.692456914868, 5670.801521946753, 5706.686132262724, 5719.914201286984, 5721.656700597978, 15217.239138043164, 22371.0, 22679.433014174778, 22720.65919011216, 22813.885930570406, 2290.415943934303, 2295.91964281251, 2344.812415006795, 2603.2450589329073, 2787.010611233003, 9912.653057142965, 10020.94989525055, 10135.847962280572, 10670.573177072907, 10679.466026698712, 1849.6023354978745, 1868.8037756035556, 1917.424772568224, 1933.3426634944187, 1979.2379933725476, 79393.0, 83299.16700832975, 84634.99999999939, 84737.57631211866, 85827.57086214592, 10485.318454300446, 10956.945215273872, 11040.710657407086, 11069.280496767846, 11399.772004559862, 15505.534833955, 15531.611709707347, 15553.144577048144, 15559.144247066293, 15567.353549896545, 7398.519096258726, 7623.199564045806, 7699.0, 7715.035620547432, 7740.225977402328, 6844.691988860413, 7096.183938846995, 7135.036770035978, 7246.782596522113, 7258.673359698826, 4653.790579423934, 4680.297955306732, 4791.688540244873, 4823.083614113307, 4900.803967841318, 1891.8297353238274, 1951.5999220159833, 1973.6842105263088, 2022.8280596149198, 2052.2509284111193, 828.4408024583503, 947.3226642950186, 963.8650588917557, 986.7681094942683, 1056.487603512296, 17835.821641783674, 18135.274589016557, 18788.436346909613, 18946.810531894782, 19104.426867194008, 888.2183678362999, 954.379653225409, 960.5533426956359, 984.1487113646645, 992.5979978108877, 7819.530828150216, 10655.84016239757, 10702.571897124184, 10713.83929241062, 10750.78498430027, 436329.0, 439067.0, 468951.0, 474135.0, 477108.0, 91517.0, 95517.6568820088, 96584.51707741416, 97305.51347243218, 97618.0, 955.2358113509165, 968.8885778135464, 997.8104160209682, 1003.5684655598017, 1006.094514936563, 16057.598560036093, 17037.0, 17046.829531704523, 17082.0, 17548.2103305349, 42622.78688606537, 42753.931151720215, 43275.35086973635, 43426.914327142076, 43528.34707479327, 54237.72881135569, 54267.45732542624, 54814.0, 60836.391636084845, 62570.37429625646, 7502.21226771203, 7715.729949451742, 7886.605669716377, 8568.271696905833, 8798.988116366443, 9609.290931721527, 13021.283829389096, 13366.799498007733, 13383.665408364868, 13647.249401283025, 11764.70588235301, 11831.11266654987, 11856.940715296369, 12142.453589588666, 12237.388130593257, 11090.44547772592, 11177.161712871404, 11666.533338666359, 11780.234284771463, 12027.879721202677, 11201.271917325348, 11477.82783258235, 11863.940680296544, 12116.394180291127, 12144.696382590506, 7662.157162711986, 7792.961035194788, 7883.881741773764, 7897.68409263623, 8113.878291825746, 11277.32336059839, 11323.830142548033, 11352.943235284101, 11358.659240222807, 11506.367149806842], "value": 9115.085487070353, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.3920833645702, 1449.2463918762244, 1578.5027716269374, 1672.7323628219488, 1696.372342233373, 7966.362690984714, 8275.21385468381, 8508.574571271443, 8595.527246001475, 8621.051684314729, 8430.83138337233, 8650.524221167832, 8673.089325620798, 8714.477131372121, 8724.127587241273, 2310.1683393978155, 2354.564405584964, 2356.6818479505305, 2358.3043002314357, 2360.976390236093, 2310.9653355199684, 2340.8010319122895, 2371.490129622131, 2383.5232953409386, 2390.6653068570326, 2312.9653055204185, 2322.1640209524558, 2343.9648405273933, 2349.3891588187107, 2352.482453860148, 2235.6758270050914, 2261.6720575516624, 2266.61467550516, 2270.1713874435877, 2289.519200967799, 2276.5105502317083, 2291.4385975435957, 2296.2996286132725, 2299.367673889677, 2310.6996090508296, 8611.6985905493, 8646.65413383464, 8685.174908383693, 8714.0, 8726.996395414546, 5111.591072714174, 5235.73821308933, 5243.737813109367, 5255.054090263751, 5264.894702105975, 3023.3650933304034, 3134.968650313513, 3341.064501939461, 3362.277110421271, 3364.074879408158, 1065.6217042949797, 1076.9623063192828, 1082.3830416662506, 1089.493385575711, 1138.669785762128, 11494.942525287404, 11591.710207244801, 11638.94180529109, 11667.824982625267, 11694.532218711242, 4373.737575745466, 4553.658475614276, 4602.907941841145, 4638.675292729544, 4646.256598944153, 9284.675036373694, 9318.627254909728, 9321.72034838956, 9336.719898403058, 9363.297752668577, 5205.765740541685, 5235.188545775411, 5242.0302244084205, 5257.0274499217, 5260.868478288074, 4574.153781550423, 4591.931121033187, 4791.089692958327, 4806.831760888352, 4886.218205087169, 3654.2143439160177, 3778.3387907116694, 3810.237952409529, 3856.6143385661208, 3896.5518965318784, 1200.7598480303975, 1205.120262208575, 1217.117589747426, 1217.3365515793914, 1224.0085530720146, 889.4929889962789, 894.4990805149007, 899.4648184330313, 915.9542022898828, 916.3219217778795, 5711.914321285184, 5768.278965129359, 5863.941360586339, 5885.440883116097, 6074.726637301332, 440.8523144746546, 453.82300902647995, 464.96840599292426, 474.0944795440761, 480.8365155847029, 3697.6487233712755, 3820.980895095562, 3831.63599458051, 3861.343571592836, 3866.342721737255, 9790.608375664893, 10126.240531960133, 10144.188464922789, 10149.49252537385, 10156.23828212887, 9770.706878793648, 9927.15619172364, 10044.748881278027, 10119.595216191417, 10162.23783216247, 7776.416768742367, 7790.298873101448, 7866.567338796307, 7909.694900341494, 7942.0, 5673.631213971079, 5673.858153546194, 5709.771609135754, 5753.9136912945505, 5840.357560668238, 9131.863022054542, 9193.954030229806, 9226.031266716898, 9319.813603728024, 9323.953380233055, 9359.812803744024, 9411.10594493522, 9542.42745435276, 9708.660196893075, 9710.660126895526, 6932.896006559805, 7084.539504932163, 7116.181639111568, 7117.7152913882865, 7166.426685865223, 7644.579548124907, 7704.653290601825, 7715.22847715224, 7730.420218483524, 7731.690732370867, 7182.245864184186, 7183.173934997542, 7276.854462910606, 7376.4467664926415, 7485.288897554724, 7086.220515743161, 7126.251743567058, 7170.569765814068, 7198.964005179941, 7250.274972502708, 6568.8357791055605, 6683.498737594603, 6708.094407255153, 6725.293844146294, 6746.696398661974, 4823.397075365579, 4955.752212389294, 4983.327250821238, 5047.375364810205, 5106.565941894981, 4965.900681986413, 5009.273655319886, 5076.213186956028, 5098.209777484496, 5165.922511162411], "value": 4381.175412601901, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.5842696629214, 338.1762284920909, 347.334853755059, 348.4216201106163, 355.62481581931087, 5280.2343660169345, 5375.274337964373, 5479.780808767649, 5523.558115350772, 5581.748821303036, 5227.86930326742, 5332.173513105465, 5401.135818269077, 5412.377576578695, 5415.48552887476, 4253.532111467744, 4264.893377665568, 4283.97858010711, 4303.419038429819, 4308.6983911126235, 4226.154769046203, 4246.256905041605, 4274.487061552618, 4287.6569874410125, 4329.177456283312, 4241.533431322568, 4249.893752656178, 4259.446271984638, 4264.765437900915, 4275.935860962088, 4224.845328882261, 4269.0, 4276.166147601219, 4301.956980430187, 4312.870613881589, 3724.571674257468, 3798.753081049723, 3842.231553689245, 3848.461215429842, 3861.38217885137, 5291.947080529222, 5332.520073193393, 5349.946500535023, 5364.570834333244, 5387.595930305203, 4822.373091498082, 4839.104765618372, 4839.749516474821, 4840.806367745321, 4876.926846097312, 5468.863278418032, 5692.573057020699, 5699.632088298778, 5709.74306156224, 5713.315081633063, 4151.647109995623, 4153.8961525961795, 4170.311898536738, 4173.624373806372, 4205.432266643995, 5920.467157955804, 5939.970300148515, 5972.104184372379, 5982.431668991482, 5993.340732519419, 4090.402594352548, 4237.5168690958535, 4296.2696341621995, 4308.224519586442, 4317.07182955666, 4229.435109009686, 4294.506131794821, 4307.935380969288, 4307.9752516317285, 4309.095090031128, 4826.0, 4892.828750993698, 4896.926546101811, 4929.9014019720125, 4931.7040977541465, 5656.321241451053, 5785.942140578624, 5786.553361659585, 5812.273465816773, 5823.359430462646, 1444.732724445981, 1460.5983354577363, 1462.714770619719, 1465.2746890289375, 1473.1897456398938, 970.4662435660358, 1013.3717095400899, 1027.2244455436248, 1031.3657100883054, 1032.8450732390052, 5340.012097761926, 5360.303160589098, 5369.570434365241, 5389.326334208224, 5414.729263536808, 5702.173184888251, 5719.7426115824055, 5727.570432217517, 5773.913391299134, 5787.768489260467, 5239.716269513993, 5357.821279318544, 5375.6774593524515, 5564.972175139179, 5601.439856014447, 2971.376011037706, 2983.6573541906228, 2984.567237750514, 2985.940281194364, 3005.413944280888, 5590.679867854876, 5811.3316968548315, 5836.824895253149, 5865.794697185578, 5910.083936989773, 5705.71471426427, 5719.428057194331, 5740.191839570522, 5760.36635970043, 5771.903338365697, 5863.736131874076, 5889.411058894077, 5890.3226128994, 5891.410858914074, 5900.350961394243, 5382.596305277199, 5617.662940223599, 5631.239782629293, 5668.744906479301, 5672.461116193955, 5504.834854954358, 5537.529310008534, 5571.13647384656, 5578.888422231614, 5590.664560126405, 5815.539753846455, 5860.882782344244, 5901.350851406256, 5926.644401335933, 5953.9404605955115, 4014.799260036928, 4082.3264161413035, 4082.530508991504, 4083.6733061354425, 4084.3056680363816, 5725.971370143123, 5737.799177028784, 5744.770209191585, 5776.747068643316, 5799.998001379035, 5405.945940540544, 5552.0290296944, 5567.526760225426, 5590.720463976866, 5621.634593751393, 5607.971960140173, 5697.173909783141, 5774.653520788766, 5775.740091695968, 5790.913136303043, 5654.886902262014, 5696.003199440164, 5711.228984087261, 5747.195392645117, 5749.1663708762835, 5739.339975902658, 5760.769569217185, 5763.279590051244, 5788.942110578841, 5916.881662366643, 5652.745626446737, 5679.233303503974, 5689.345725241485, 5713.971430142823, 5719.8570035749435], "value": 4341.151663072808, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.8587317853483, 636.3954243468703, 673.8854394752891, 703.3072423662692, 732.5128789355077, 14173.220472873987, 15590.610234744137, 15625.29686164124, 15790.4473343433, 15896.602584935368, 13909.165450073002, 14108.012439129265, 14153.716925661507, 14222.0, 14421.206833624146, 785.3834739729299, 800.5636927874323, 801.1667865419956, 803.0644299391203, 805.8186907945724, 763.9961800190991, 776.8990031295924, 793.1513280789558, 794.7258195922426, 798.9280964713174, 827.896512935883, 837.1461109668135, 838.2120806441956, 839.1985653700732, 839.4207996482407, 830.4311546590604, 830.7507747675673, 832.2925513313666, 833.5957060825494, 833.7707130539089, 607.8237311179753, 610.7923306075911, 613.4601550635457, 614.1003429975108, 614.3978900677362, 14522.201278929655, 14528.564143075724, 14547.70904581913, 14561.053531520418, 14572.635684107876, 12230.327331996737, 12281.69295767604, 12400.689982750504, 12789.360531973458, 13137.73724525504, 11493.942530287379, 11607.709807254801, 11647.0, 11753.177277590572, 11784.292942423397, 4120.75275483472, 4125.91748165038, 4188.434561334242, 4261.4460120184485, 4307.289297265978, 62408.68795655993, 62643.686781566255, 62885.0, 63715.362846371405, 64437.355626443605, 9282.0, 9360.204382627553, 9517.809643807224, 9538.332316737762, 9619.0, 18171.182296796676, 18371.0, 18377.632447350978, 18490.44528664142, 18539.629207415775, 7244.0, 7383.372413344819, 7454.254574542502, 7635.083789945242, 7723.845523089507, 4296.484421869396, 4373.103513779667, 4415.801288942005, 4439.356293337448, 4450.888727781831, 3007.77441691874, 3090.5518699788854, 3090.6136732908385, 3090.8918187863765, 3096.148559146253, 539.5386944162684, 541.1179776963525, 549.4779959038929, 551.2337850387964, 556.7105105345198, 573.7848306884919, 585.5286494372072, 595.0984258847849, 599.0445239842444, 622.7633499270248, 7738.845223095506, 8265.545395003333, 8408.41141120128, 8423.904892364077, 8457.746267611981, 530.6550742017643, 556.8218170185502, 567.9403662615366, 625.4839757200328, 641.2177143884453, 3847.211321679049, 4095.086786737737, 4123.8969025773995, 4133.875983720493, 4249.723767955073, 64677.67661161664, 80290.59854700688, 84608.0, 85359.57320213359, 89341.0, 44606.776966114965, 49685.50314496881, 65688.0, 68329.31670683328, 75904.24095759082, 56399.71800140973, 68583.65708171527, 68637.0, 68782.31217687759, 68945.65527172331, 7831.334336581226, 7967.362610991223, 8052.798680033046, 8106.797330066795, 8192.67229310821, 46180.0, 47233.763831182, 47285.52714472811, 48056.759716201195, 48601.270980936024, 38762.41856372213, 51351.0, 62308.37691623207, 63432.68283658552, 64408.35591644211, 11294.717632059264, 11510.0, 11694.181407301747, 11722.561732995411, 11755.647330580096, 12937.094403391673, 13023.544175953795, 13210.207387556777, 13287.069905106937, 13505.189688618715, 12298.815517767061, 12405.379731013594, 12541.561045363733, 12961.351932403153, 13112.672183195496, 11355.489002995051, 11739.413029348669, 12037.157398981988, 12088.576899808464, 12505.624831254712, 11880.346580937785, 12234.204776689487, 12280.75438491243, 12630.0, 12826.358682066046, 9405.0, 9610.471424071464, 9618.711438656852, 9802.264830137625, 10075.496225188564, 10189.541470633987, 10512.947435262775, 10590.735231618963, 10643.09533689614, 10668.413237272025], "value": 6690.265361614413, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 113.0, 114.0, 115.0, 115.0, 113.0, 112.0, 114.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 127.0, 175.0, 127.0, 125.0, 126.0, 126.0, 175.0, 128.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 175.0, 171.0, 163.0, 164.0, 163.0, 164.0, 165.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 112.0, 77.0, 75.0, 77.0, 76.0, 101.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 112.0, 82.0, 83.0, 81.0, 100.0, 82.0, 81.0, 114.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 122.0, 117.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 148.0, 148.0, 147.0, 146.0, 148.0, 146.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 54.0, 54.0, 55.0, 54.0, 53.0, 53.0, 58.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 61.0, 62.0, 63.0, 63.0, 62.0, 63.0, 62.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 83.0, 82.0, 83.0, 82.0, 80.0, 82.0, 82.0, 92.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 133.0, 148.0, 137.0, 135.0, 138.0, 143.0, 183.0, 132.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 176.0, 173.0, 165.0, 170.0, 169.0, 169.0, 175.0, 168.0, 168.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 68.0, 71.0, 66.0, 64.0, 64.0, 63.0], "value": 65.8, "unit": "score"}]}]} 06:10:51 INFO - Return code: 0 06:10:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:10:51 ERROR - # TBPL SUCCESS # 06:10:51 INFO - Running post-action listener: _resource_record_post_action 06:10:51 INFO - [mozharness: 2016-11-20 14:10:51.145895Z] Finished run-tests step (success) 06:10:51 INFO - Running post-run listener: _resource_record_post_run 06:10:51 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408428544; Read time: 12; Write time: 241884 06:10:51 INFO - TinderboxPrint: CPU usage
13.4% 06:10:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:10:51 INFO - TinderboxPrint: I/O write bytes / time
408,428,544 / 241,884 06:10:51 INFO - TinderboxPrint: CPU idle
8,260.6 (86.5%) 06:10:51 INFO - TinderboxPrint: CPU user
1,225.1 (12.8%) 06:10:51 INFO - TinderboxPrint: Swap in / out
0 / 0 06:10:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120147968; Read time: 0; Write time: 65584 06:10:51 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288280576; Read time: 0; Write time: 176300 06:10:51 INFO - Running post-run listener: _upload_blobber_files 06:10:51 INFO - Blob upload gear active. 06:10:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:10:51 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 06:10:51 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:10:51 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:10:52 INFO - (blobuploader) - INFO - Open directory for files ... 06:10:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:10:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:10:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:52 INFO - (blobuploader) - INFO - Done attempting. 06:10:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:10:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:10:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:56 INFO - (blobuploader) - INFO - Done attempting. 06:10:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:10:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:10:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:56 INFO - (blobuploader) - INFO - Done attempting. 06:10:56 INFO - (blobuploader) - INFO - Iteration through files over. 06:10:56 INFO - Return code: 0 06:10:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:10:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:10:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44d270c65e6518016f3ddcc0b99d5f6103827f0bbc29ee2ae37467615184c9444662ba2c80ddc22c4170677e5e644e92b9c6938ef2bc7849f80ddb720b3c262d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32df29e378007de21eda04b41aa1110c749046aaf0b2e6b0126f28aae333906d2affa51b6ad3b188368007464ef79f7b038ab595fd1ab477a2d459a86bbd53f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30d27f9cc21a44d217c9a490ded0baff2facbff755e35356da0fc5cd98f1d6098f2768f0cde4f090d0d5737733ce5e101b2fd1426f3d09ffb3c2da2624d4b6e3"} 06:10:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:10:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:10:56 INFO - Contents: 06:10:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44d270c65e6518016f3ddcc0b99d5f6103827f0bbc29ee2ae37467615184c9444662ba2c80ddc22c4170677e5e644e92b9c6938ef2bc7849f80ddb720b3c262d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32df29e378007de21eda04b41aa1110c749046aaf0b2e6b0126f28aae333906d2affa51b6ad3b188368007464ef79f7b038ab595fd1ab477a2d459a86bbd53f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30d27f9cc21a44d217c9a490ded0baff2facbff755e35356da0fc5cd98f1d6098f2768f0cde4f090d0d5737733ce5e101b2fd1426f3d09ffb3c2da2624d4b6e3"} 06:10:56 INFO - Running post-run listener: copy_logs_to_upload_dir 06:10:56 INFO - Copying logs to upload dir... 06:10:56 INFO - mkdir: /builds/slave/test/build/upload/logs 06:10:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.498586 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-20 06:10:55.705226) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-20 06:10:55.709129) ========= 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=3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266 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/sha512/44d270c65e6518016f3ddcc0b99d5f6103827f0bbc29ee2ae37467615184c9444662ba2c80ddc22c4170677e5e644e92b9c6938ef2bc7849f80ddb720b3c262d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32df29e378007de21eda04b41aa1110c749046aaf0b2e6b0126f28aae333906d2affa51b6ad3b188368007464ef79f7b038ab595fd1ab477a2d459a86bbd53f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30d27f9cc21a44d217c9a490ded0baff2facbff755e35356da0fc5cd98f1d6098f2768f0cde4f090d0d5737733ce5e101b2fd1426f3d09ffb3c2da2624d4b6e3"} build_url:https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011640 build_url: 'https://queue.taskcluster.net/v1/task/E3kUG89zTM6Y-vYVv9zbNw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44d270c65e6518016f3ddcc0b99d5f6103827f0bbc29ee2ae37467615184c9444662ba2c80ddc22c4170677e5e644e92b9c6938ef2bc7849f80ddb720b3c262d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32df29e378007de21eda04b41aa1110c749046aaf0b2e6b0126f28aae333906d2affa51b6ad3b188368007464ef79f7b038ab595fd1ab477a2d459a86bbd53f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30d27f9cc21a44d217c9a490ded0baff2facbff755e35356da0fc5cd98f1d6098f2768f0cde4f090d0d5737733ce5e101b2fd1426f3d09ffb3c2da2624d4b6e3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-20 06:10:55.734474) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 06:10:55.734791) ========= 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=3a3620fb28aea1604ab609ef000001d2-1479647502.223626-550867266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 06:10:55.817781) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-20 06:10:55.818131) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-20 06:10:55.818427) ========= ========= Total master_lag: 0.15 =========