builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1480439944.74 results: success (0) buildid: 20161129062927 builduid: 0da61bd7eb514695b9c47523cd39a1c8 revision: 55c4ba0e73cdae6e2cfc93f7d195273b15f2f56e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:04.743762) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:04.744143) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:04.744429) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:04.759063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:04.759353) ========= 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=c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-29 09:19:04-- 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% 40.4M=0s 2016-11-29 09:19:05 (40.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086698 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:04.859513) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:04.859828) ========= 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=c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017026 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:04.910105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:04.910801) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 55c4ba0e73cdae6e2cfc93f7d195273b15f2f56e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 55c4ba0e73cdae6e2cfc93f7d195273b15f2f56e --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=c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-29 09:19:05,154 truncating revision to first 12 chars 2016-11-29 09:19:05,154 Setting DEBUG logging. 2016-11-29 09:19:05,154 attempt 1/10 2016-11-29 09:19:05,154 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/55c4ba0e73cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 09:19:05,473 unpacking tar archive at: mozilla-aurora-55c4ba0e73cd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.696514 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:05.622462) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:05.622778) ========= script_repo_revision: 55c4ba0e73cdae6e2cfc93f7d195273b15f2f56e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:05.623179) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:05.623443) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:05.633548) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-29 09:19:05.633980) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:19:05 INFO - MultiFileLogger online at 20161129 09:19:05 in /builds/slave/test 09:19:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:19:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:19:05 INFO - {'append_to_log': False, 09:19:05 INFO - 'base_work_dir': '/builds/slave/test', 09:19:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:19:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:19:05 INFO - 'branch': 'Mozilla-Aurora', 09:19:05 INFO - 'buildbot_json_path': 'buildprops.json', 09:19:05 INFO - 'config_files': ('talos/linux_config.py',), 09:19:05 INFO - 'default_actions': ('clobber', 09:19:05 INFO - 'read-buildbot-config', 09:19:05 INFO - 'download-and-extract', 09:19:05 INFO - 'populate-webroot', 09:19:05 INFO - 'create-virtualenv', 09:19:05 INFO - 'install', 09:19:05 INFO - 'run-tests'), 09:19:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:19:05 INFO - 'download_minidump_stackwalk': True, 09:19:05 INFO - 'download_symbols': 'ondemand', 09:19:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:19:05 INFO - 'tooltool.py': '/tools/tooltool.py', 09:19:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:19:05 INFO - '/tools/misc-python/virtualenv.py')}, 09:19:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:19:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:19:05 INFO - 'installer_path': 'installer.exe', 09:19:05 INFO - 'log_level': 'info', 09:19:05 INFO - 'log_name': 'talos', 09:19:05 INFO - 'log_to_console': True, 09:19:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:19:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:19:05 INFO - 'opt_config_files': (), 09:19:05 INFO - 'pip_index': False, 09:19:05 INFO - 'sps_profile': False, 09:19:05 INFO - 'sps_profile_interval': 0, 09:19:05 INFO - 'suite': 'dromaeojs-e10s', 09:19:05 INFO - 'system_bits': '32', 09:19:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:19:05 INFO - 'title': 'talos-linux64-ix-004', 09:19:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:19:05 INFO - 'use_talos_json': True, 09:19:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:19:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:19:05 INFO - 'work_dir': 'build'} 09:19:05 INFO - [mozharness: 2016-11-29 17:19:05.965954Z] Running clobber step. 09:19:05 INFO - Running pre-action listener: _resource_record_pre_action 09:19:05 INFO - Running main action method: clobber 09:19:05 INFO - rmtree: /builds/slave/test/build 09:19:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:19:06 INFO - Running post-action listener: _resource_record_post_action 09:19:06 INFO - [mozharness: 2016-11-29 17:19:06.937810Z] Finished clobber step (success) 09:19:06 INFO - [mozharness: 2016-11-29 17:19:06.937908Z] Running read-buildbot-config step. 09:19:06 INFO - Running pre-action listener: _resource_record_pre_action 09:19:06 INFO - Running main action method: read_buildbot_config 09:19:06 INFO - Using buildbot properties: 09:19:06 INFO - { 09:19:06 INFO - "project": "", 09:19:06 INFO - "product": "firefox", 09:19:06 INFO - "script_repo_revision": "production", 09:19:06 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:19:06 INFO - "repository": "", 09:19:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:19:06 INFO - "buildid": "20161129062927", 09:19:06 INFO - "pgo_build": "True", 09:19:06 INFO - "basedir": "/builds/slave/test", 09:19:06 INFO - "buildnumber": 731, 09:19:06 INFO - "slavename": "talos-linux64-ix-004", 09:19:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:19:06 INFO - "platform": "ubuntu64_hw", 09:19:06 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:19:06 INFO - "branch": "mozilla-aurora", 09:19:06 INFO - "repo_path": "releases/mozilla-aurora", 09:19:06 INFO - "revision": "55c4ba0e73cdae6e2cfc93f7d195273b15f2f56e", 09:19:06 INFO - "stage_platform": "linux64-pgo", 09:19:06 INFO - "builduid": "0da61bd7eb514695b9c47523cd39a1c8", 09:19:06 INFO - "slavebuilddir": "test" 09:19:06 INFO - } 09:19:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:19:06 INFO - Running post-action listener: _resource_record_post_action 09:19:06 INFO - [mozharness: 2016-11-29 17:19:06.940320Z] Finished read-buildbot-config step (success) 09:19:06 INFO - [mozharness: 2016-11-29 17:19:06.940407Z] Running download-and-extract step. 09:19:06 INFO - Running pre-action listener: _resource_record_pre_action 09:19:06 INFO - Running main action method: download_and_extract 09:19:06 INFO - mkdir: /builds/slave/test/build/tests 09:19:06 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')]} 09:19:06 INFO - trying https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:19:06 INFO - Downloading https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:19:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:19:07 INFO - Downloaded 1361 bytes. 09:19:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:19:07 INFO - Using the following test package requirements: 09:19:07 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:19:07 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:19:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:19:07 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:19:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:19:07 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:19:07 INFO - u'jsshell-linux-x86_64.zip'], 09:19:07 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:19:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:19:07 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:19:07 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:19:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:19:07 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:19:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:19:07 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:19:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:19:07 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:19:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:19:07 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:19:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:19:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:19:07 INFO - Fetch https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:19:08 INFO - Http code: 200 09:19:08 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 09:19:08 INFO - x-amz-cf-id: IhPfAOu9tXUs0pUqU5BKUXuCTA9_Jrnj5jYRBZ59Ny730ea68leJAw== 09:19:08 INFO - x-amz-version-id: 5H.DJwryyoq008EuFVT7t2ldlEniuVJW 09:19:08 INFO - Expected file size: 21955864 09:19:08 INFO - Obtained file size: 21955864 09:19:12 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:19:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:19:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:19:12 INFO - Fetch https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:19:13 INFO - Http code: 200 09:19:13 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 09:19:13 INFO - x-amz-cf-id: r1QyLb3wiGVzbq0FToj2RG5WjVKSwd6Kh5hN7lfBt-_MveNgJ7T31Q== 09:19:13 INFO - x-amz-version-id: 5H.DJwryyoq008EuFVT7t2ldlEniuVJW 09:19:13 INFO - Expected file size: 21955864 09:19:13 INFO - Obtained file size: 21955864 09:19:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:19:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:19:17 INFO - Fetch https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:19:18 INFO - Http code: 200 09:19:18 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 09:19:18 INFO - x-amz-cf-id: dUjXW5LbjZg1Uxqjk6DJoa0qAGvRBLxUCpRZTFrbS2VQPuZxSwDOhA== 09:19:18 INFO - x-amz-version-id: G2lj_VQINAG.4Wces3zkscOlOw2AHWMl 09:19:18 INFO - Expected file size: 14409038 09:19:18 INFO - Obtained file size: 14409038 09:19:18 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')]} 09:19:18 INFO - trying https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:19:18 INFO - Downloading https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:19:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:19:19 INFO - Downloaded 63956415 bytes. 09:19:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:19:19 INFO - mkdir: /builds/slave/test/properties 09:19:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:19:19 INFO - Writing to file /builds/slave/test/properties/build_url 09:19:19 INFO - Contents: 09:19:19 INFO - build_url:https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:19:20 INFO - Running post-action listener: _resource_record_post_action 09:19:20 INFO - Running post-action listener: set_extra_try_arguments 09:19:20 INFO - [mozharness: 2016-11-29 17:19:20.583216Z] Finished download-and-extract step (success) 09:19:20 INFO - [mozharness: 2016-11-29 17:19:20.583443Z] Running populate-webroot step. 09:19:20 INFO - Running pre-action listener: _resource_record_pre_action 09:19:20 INFO - Running main action method: populate_webroot 09:19:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:19:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:19:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:19:20 INFO - '--tppagecycles', 09:19:20 INFO - '7'], 09:19:20 INFO - 'tests': ['tsvgm']}}, 09:19:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:19:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:19:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:19:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:19:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:19:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:19:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:20 INFO - 'talos_options': ['--disable-e10s'], 09:19:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:20 INFO - 'talos_options': ['--disable-e10s'], 09:19:20 INFO - 'tests': ['damp', 'tps']}, 09:19:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:20 INFO - 'tests': ['damp', 'tps']}, 09:19:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:19:20 INFO - 'tests': ['dromaeo_dom']}, 09:19:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:19:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:19:20 INFO - 'tests': ['basic_compositor_video']}, 09:19:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:19:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:19:20 INFO - 'tests': ['a11yr', 09:19:20 INFO - 'ts_paint', 09:19:20 INFO - 'tpaint', 09:19:20 INFO - 'sessionrestore', 09:19:20 INFO - 'sessionrestore_no_auto_restore', 09:19:20 INFO - 'tabpaint']}, 09:19:20 INFO - 'other-e10s': {'tests': ['a11yr', 09:19:20 INFO - 'ts_paint', 09:19:20 INFO - 'tpaint', 09:19:20 INFO - 'sessionrestore', 09:19:20 INFO - 'sessionrestore_no_auto_restore', 09:19:20 INFO - 'tabpaint']}, 09:19:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:19:20 INFO - 'ts_paint', 09:19:20 INFO - 'tpaint', 09:19:20 INFO - 'sessionrestore', 09:19:20 INFO - 'sessionrestore_no_auto_restore', 09:19:20 INFO - 'tabpaint']}, 09:19:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:19:20 INFO - 'ts_paint', 09:19:20 INFO - 'tpaint', 09:19:20 INFO - 'sessionrestore', 09:19:20 INFO - 'sessionrestore_no_auto_restore', 09:19:20 INFO - 'tabpaint']}, 09:19:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:19:20 INFO - 'tests': ['a11yr', 09:19:20 INFO - 'ts_paint', 09:19:20 INFO - 'tpaint', 09:19:20 INFO - 'sessionrestore', 09:19:20 INFO - 'sessionrestore_no_auto_restore', 09:19:20 INFO - 'tabpaint']}, 09:19:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:19:20 INFO - 'tests': ['a11yr', 09:19:20 INFO - 'ts_paint', 09:19:20 INFO - 'tpaint', 09:19:20 INFO - 'sessionrestore', 09:19:20 INFO - 'sessionrestore_no_auto_restore', 09:19:20 INFO - 'tabpaint']}, 09:19:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:19:20 INFO - 'tests': ['tsvgx', 09:19:20 INFO - 'tsvgr_opacity', 09:19:20 INFO - 'tart', 09:19:20 INFO - 'tscrollx', 09:19:20 INFO - 'cart']}, 09:19:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:19:20 INFO - 'tsvgr_opacity', 09:19:20 INFO - 'tart', 09:19:20 INFO - 'tscrollx', 09:19:20 INFO - 'cart']}, 09:19:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:20 INFO - 'talos_options': ['--disable-e10s'], 09:19:20 INFO - 'tests': ['tp5o']}, 09:19:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:20 INFO - 'tests': ['tp5o']}, 09:19:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:20 INFO - 'talos_options': ['--disable-e10s', 09:19:20 INFO - '--xperf_path', 09:19:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:20 INFO - 'tests': ['tp5n']}, 09:19:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:20 INFO - 'talos_options': ['--xperf_path', 09:19:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:20 INFO - 'tests': ['tp5n']}}, 09:19:20 INFO - 'talos.zip': {'path': '', 09:19:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:19:20 INFO - Running post-action listener: _resource_record_post_action 09:19:20 INFO - [mozharness: 2016-11-29 17:19:20.600519Z] Finished populate-webroot step (success) 09:19:20 INFO - [mozharness: 2016-11-29 17:19:20.600607Z] Running create-virtualenv step. 09:19:20 INFO - Running pre-action listener: _resource_record_pre_action 09:19:20 INFO - Running main action method: create_virtualenv 09:19:20 INFO - Creating virtualenv /builds/slave/test/build/venv 09:19:20 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 09:19:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:19:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:19:20 INFO - Using real prefix '/usr' 09:19:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:19:21 INFO - Installing distribute.............................................................................................................................................................................................done. 09:19:23 INFO - Installing pip.................done. 09:19:23 INFO - Return code: 0 09:19:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:19:23 INFO - Reading from file tmpfile_stdout 09:19:23 INFO - Output received: 09:19:23 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) 09:19:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:19:23 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')]} 09:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:23 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')]} 09:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:23 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 0x7f6c3ea18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555f60>, '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 0x2556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25571d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', '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 09:19:23 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 09:19:23 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 09:19:23 INFO - Using env: {'DISPLAY': ':0', 09:19:23 INFO - 'HOME': '/home/cltbld', 09:19:23 INFO - 'LANG': 'en_US.UTF-8', 09:19:23 INFO - 'LANGUAGE': 'en_US:en', 09:19:23 INFO - 'LOGNAME': 'cltbld', 09:19:23 INFO - 'MAIL': '/var/mail/cltbld', 09:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:23 INFO - 'MOZ_NO_REMOTE': '1', 09:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:23 INFO - 'NO_EM_RESTART': '1', 09:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:23 INFO - 'PWD': '/builds/slave/test', 09:19:23 INFO - 'SHELL': '/bin/bash', 09:19:23 INFO - 'SHLVL': '1', 09:19:23 INFO - 'TERM': 'linux', 09:19:23 INFO - 'TMOUT': '86400', 09:19:23 INFO - 'USER': 'cltbld', 09:19:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', 09:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:23 INFO - '_': '/tools/buildbot/bin/python'} 09:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:23 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 09:19:23 INFO - Cleaning up... 09:19:23 INFO - Return code: 0 09:19:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:19:23 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')]} 09:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:23 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')]} 09:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:23 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 0x7f6c3ea18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555f60>, '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 0x2556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25571d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', '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 09:19:23 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 09:19:23 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 09:19:23 INFO - Using env: {'DISPLAY': ':0', 09:19:23 INFO - 'HOME': '/home/cltbld', 09:19:23 INFO - 'LANG': 'en_US.UTF-8', 09:19:23 INFO - 'LANGUAGE': 'en_US:en', 09:19:23 INFO - 'LOGNAME': 'cltbld', 09:19:23 INFO - 'MAIL': '/var/mail/cltbld', 09:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:23 INFO - 'MOZ_NO_REMOTE': '1', 09:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:23 INFO - 'NO_EM_RESTART': '1', 09:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:23 INFO - 'PWD': '/builds/slave/test', 09:19:23 INFO - 'SHELL': '/bin/bash', 09:19:23 INFO - 'SHLVL': '1', 09:19:23 INFO - 'TERM': 'linux', 09:19:23 INFO - 'TMOUT': '86400', 09:19:23 INFO - 'USER': 'cltbld', 09:19:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', 09:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:23 INFO - '_': '/tools/buildbot/bin/python'} 09:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:23 INFO - Downloading/unpacking psutil>=3.1.1 09:19:23 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 09:19:23 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 09:19:23 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 09:19:23 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 09:19:23 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 09:19:23 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 09:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:19:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:25 INFO - Installing collected packages: psutil 09:19:25 INFO - Running setup.py install for psutil 09:19:26 INFO - building 'psutil._psutil_linux' extension 09:19:26 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 09:19:26 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 09:19:26 INFO - building 'psutil._psutil_posix' extension 09:19:26 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 09:19:26 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 09:19:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:26 INFO - Successfully installed psutil 09:19:26 INFO - Cleaning up... 09:19:26 INFO - Return code: 0 09:19:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:26 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 0x7f6c3ea18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555f60>, '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 0x2556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25571d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', '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 09:19:26 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 09:19:26 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 09:19:26 INFO - Using env: {'DISPLAY': ':0', 09:19:26 INFO - 'HOME': '/home/cltbld', 09:19:26 INFO - 'LANG': 'en_US.UTF-8', 09:19:26 INFO - 'LANGUAGE': 'en_US:en', 09:19:26 INFO - 'LOGNAME': 'cltbld', 09:19:26 INFO - 'MAIL': '/var/mail/cltbld', 09:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:26 INFO - 'MOZ_NO_REMOTE': '1', 09:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:26 INFO - 'NO_EM_RESTART': '1', 09:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:26 INFO - 'PWD': '/builds/slave/test', 09:19:26 INFO - 'SHELL': '/bin/bash', 09:19:26 INFO - 'SHLVL': '1', 09:19:26 INFO - 'TERM': 'linux', 09:19:26 INFO - 'TMOUT': '86400', 09:19:26 INFO - 'USER': 'cltbld', 09:19:26 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', 09:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:26 INFO - '_': '/tools/buildbot/bin/python'} 09:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:19:26 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 09:19:26 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 09:19:26 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 09:19:26 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 09:19:26 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 09:19:26 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 09:19:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:19:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:19:28 INFO - Installing collected packages: mozsystemmonitor 09:19:28 INFO - Running setup.py install for mozsystemmonitor 09:19:28 INFO - Successfully installed mozsystemmonitor 09:19:28 INFO - Cleaning up... 09:19:28 INFO - Return code: 0 09:19:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:28 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 0x7f6c3ea18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555f60>, '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 0x2556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25571d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', '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 09:19:28 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 09:19:28 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 09:19:28 INFO - Using env: {'DISPLAY': ':0', 09:19:28 INFO - 'HOME': '/home/cltbld', 09:19:28 INFO - 'LANG': 'en_US.UTF-8', 09:19:28 INFO - 'LANGUAGE': 'en_US:en', 09:19:28 INFO - 'LOGNAME': 'cltbld', 09:19:28 INFO - 'MAIL': '/var/mail/cltbld', 09:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:28 INFO - 'MOZ_NO_REMOTE': '1', 09:19:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:28 INFO - 'NO_EM_RESTART': '1', 09:19:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:28 INFO - 'PWD': '/builds/slave/test', 09:19:28 INFO - 'SHELL': '/bin/bash', 09:19:28 INFO - 'SHLVL': '1', 09:19:28 INFO - 'TERM': 'linux', 09:19:28 INFO - 'TMOUT': '86400', 09:19:28 INFO - 'USER': 'cltbld', 09:19:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', 09:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:28 INFO - '_': '/tools/buildbot/bin/python'} 09:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:29 INFO - Downloading/unpacking jsonschema==2.5.1 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 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 09:19:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:19:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:31 INFO - Downloading functools32-3.2.3-2.tar.gz 09:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:19:31 INFO - warning: no files found matching '*.txt' 09:19:31 INFO - no previously-included directories found matching 'build' 09:19:31 INFO - no previously-included directories found matching 'dist' 09:19:31 INFO - no previously-included directories found matching '.git*' 09:19:31 INFO - Installing collected packages: jsonschema, functools32 09:19:31 INFO - Running setup.py install for functools32 09:19:31 INFO - warning: no files found matching '*.txt' 09:19:31 INFO - no previously-included directories found matching 'build' 09:19:31 INFO - no previously-included directories found matching 'dist' 09:19:31 INFO - no previously-included directories found matching '.git*' 09:19:31 INFO - Successfully installed jsonschema functools32 09:19:31 INFO - Cleaning up... 09:19:31 INFO - Return code: 0 09:19:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:19:31 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')]} 09:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:31 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')]} 09:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:31 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 0x7f6c3ea18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555f60>, '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 0x2556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25571d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', '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 09:19:31 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 09:19:31 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 09:19:31 INFO - Using env: {'DISPLAY': ':0', 09:19:31 INFO - 'HOME': '/home/cltbld', 09:19:31 INFO - 'LANG': 'en_US.UTF-8', 09:19:31 INFO - 'LANGUAGE': 'en_US:en', 09:19:31 INFO - 'LOGNAME': 'cltbld', 09:19:31 INFO - 'MAIL': '/var/mail/cltbld', 09:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:31 INFO - 'MOZ_NO_REMOTE': '1', 09:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:31 INFO - 'NO_EM_RESTART': '1', 09:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:31 INFO - 'PWD': '/builds/slave/test', 09:19:31 INFO - 'SHELL': '/bin/bash', 09:19:31 INFO - 'SHLVL': '1', 09:19:31 INFO - 'TERM': 'linux', 09:19:31 INFO - 'TMOUT': '86400', 09:19:31 INFO - 'USER': 'cltbld', 09:19:31 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', 09:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:31 INFO - '_': '/tools/buildbot/bin/python'} 09:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:19:31 INFO - Cleaning up... 09:19:31 INFO - Return code: 0 09:19:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:19:31 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')]} 09:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:31 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')]} 09:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:31 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 0x7f6c3ea18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555f60>, '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 0x2556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25571d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', '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 09:19:31 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 09:19:31 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 09:19:31 INFO - Using env: {'DISPLAY': ':0', 09:19:31 INFO - 'HOME': '/home/cltbld', 09:19:31 INFO - 'LANG': 'en_US.UTF-8', 09:19:31 INFO - 'LANGUAGE': 'en_US:en', 09:19:31 INFO - 'LOGNAME': 'cltbld', 09:19:31 INFO - 'MAIL': '/var/mail/cltbld', 09:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:31 INFO - 'MOZ_NO_REMOTE': '1', 09:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:31 INFO - 'NO_EM_RESTART': '1', 09:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:31 INFO - 'PWD': '/builds/slave/test', 09:19:31 INFO - 'SHELL': '/bin/bash', 09:19:31 INFO - 'SHLVL': '1', 09:19:31 INFO - 'TERM': 'linux', 09:19:31 INFO - 'TMOUT': '86400', 09:19:31 INFO - 'USER': 'cltbld', 09:19:31 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', 09:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:31 INFO - '_': '/tools/buildbot/bin/python'} 09:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:31 INFO - Downloading/unpacking blobuploader==1.2.4 09:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:33 INFO - Downloading blobuploader-1.2.4.tar.gz 09:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:19:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:19:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19:34 INFO - Downloading docopt-0.6.1.tar.gz 09:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:19:34 INFO - Installing collected packages: blobuploader, requests, docopt 09:19:34 INFO - Running setup.py install for blobuploader 09:19:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:19:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:19:34 INFO - Running setup.py install for requests 09:19:35 INFO - Running setup.py install for docopt 09:19:35 INFO - Successfully installed blobuploader requests docopt 09:19:35 INFO - Cleaning up... 09:19:35 INFO - Return code: 0 09:19:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:35 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 0x7f6c3ea18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555f60>, '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 0x2556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25571d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', '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 09:19:35 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 09:19:35 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 09:19:35 INFO - Using env: {'DISPLAY': ':0', 09:19:35 INFO - 'HOME': '/home/cltbld', 09:19:35 INFO - 'LANG': 'en_US.UTF-8', 09:19:35 INFO - 'LANGUAGE': 'en_US:en', 09:19:35 INFO - 'LOGNAME': 'cltbld', 09:19:35 INFO - 'MAIL': '/var/mail/cltbld', 09:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:35 INFO - 'MOZ_NO_REMOTE': '1', 09:19:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:35 INFO - 'NO_EM_RESTART': '1', 09:19:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:35 INFO - 'PWD': '/builds/slave/test', 09:19:35 INFO - 'SHELL': '/bin/bash', 09:19:35 INFO - 'SHLVL': '1', 09:19:35 INFO - 'TERM': 'linux', 09:19:35 INFO - 'TMOUT': '86400', 09:19:35 INFO - 'USER': 'cltbld', 09:19:35 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', 09:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:35 INFO - '_': '/tools/buildbot/bin/python'} 09:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:35 INFO - Running setup.py (path:/tmp/pip-Q3bE_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:35 INFO - Running setup.py (path:/tmp/pip-G0LUJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:35 INFO - Running setup.py (path:/tmp/pip-XoQy5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:35 INFO - Running setup.py (path:/tmp/pip-5VpPcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:35 INFO - Running setup.py (path:/tmp/pip-vowEoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:35 INFO - Running setup.py (path:/tmp/pip-C_S3Qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:35 INFO - Running setup.py (path:/tmp/pip-wbGm22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:36 INFO - Running setup.py (path:/tmp/pip-NmiRpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:36 INFO - Running setup.py (path:/tmp/pip-hLmG3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:36 INFO - Running setup.py (path:/tmp/pip-1Wy8wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:36 INFO - Running setup.py (path:/tmp/pip-frw7_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:36 INFO - Running setup.py (path:/tmp/pip-gHKj4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:36 INFO - Running setup.py (path:/tmp/pip-AafSC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:36 INFO - Running setup.py (path:/tmp/pip-SoUNUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:36 INFO - Running setup.py (path:/tmp/pip-GuSfvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:36 INFO - Running setup.py (path:/tmp/pip-kitdpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:36 INFO - Running setup.py (path:/tmp/pip-RSz2F3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:19:36 INFO - Running setup.py install for manifestparser 09:19:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:19:36 INFO - Running setup.py install for mozcrash 09:19:36 INFO - Running setup.py install for mozdebug 09:19:37 INFO - Running setup.py install for mozdevice 09:19:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for mozfile 09:19:37 INFO - Running setup.py install for mozhttpd 09:19:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for mozinfo 09:19:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for mozInstall 09:19:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for mozleak 09:19:37 INFO - Running setup.py install for mozlog 09:19:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for moznetwork 09:19:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for mozprocess 09:19:38 INFO - Running setup.py install for mozprofile 09:19:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Running setup.py install for mozrunner 09:19:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Running setup.py install for mozscreenshot 09:19:38 INFO - Running setup.py install for moztest 09:19:38 INFO - Running setup.py install for mozversion 09:19:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:19:38 INFO - Cleaning up... 09:19:38 INFO - Return code: 0 09:19:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:38 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 0x7f6c3ea18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555f60>, '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 0x2556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25571d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', '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 09:19:38 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 09:19:38 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 09:19:38 INFO - Using env: {'DISPLAY': ':0', 09:19:38 INFO - 'HOME': '/home/cltbld', 09:19:38 INFO - 'LANG': 'en_US.UTF-8', 09:19:38 INFO - 'LANGUAGE': 'en_US:en', 09:19:38 INFO - 'LOGNAME': 'cltbld', 09:19:38 INFO - 'MAIL': '/var/mail/cltbld', 09:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:38 INFO - 'MOZ_NO_REMOTE': '1', 09:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:38 INFO - 'NO_EM_RESTART': '1', 09:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:38 INFO - 'PWD': '/builds/slave/test', 09:19:38 INFO - 'SHELL': '/bin/bash', 09:19:38 INFO - 'SHLVL': '1', 09:19:38 INFO - 'TERM': 'linux', 09:19:38 INFO - 'TMOUT': '86400', 09:19:38 INFO - 'USER': 'cltbld', 09:19:38 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', 09:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:38 INFO - '_': '/tools/buildbot/bin/python'} 09:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:38 INFO - Running setup.py (path:/tmp/pip-Dddm1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:38 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)) 09:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:38 INFO - Running setup.py (path:/tmp/pip-nEAfIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:38 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)) 09:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:38 INFO - Running setup.py (path:/tmp/pip-Ug3eRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:39 INFO - Running setup.py (path:/tmp/pip-AQO60j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:39 INFO - Running setup.py (path:/tmp/pip-Sw4ZRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:39 INFO - Running setup.py (path:/tmp/pip-JtuE0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:39 INFO - Running setup.py (path:/tmp/pip-3XFtKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:39 INFO - Running setup.py (path:/tmp/pip-mpcJhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:39 INFO - Running setup.py (path:/tmp/pip-npsbU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:39 INFO - Running setup.py (path:/tmp/pip-ICwXSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:39 INFO - Running setup.py (path:/tmp/pip-Yd2xjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:39 INFO - Running setup.py (path:/tmp/pip-_ElyNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:39 INFO - Running setup.py (path:/tmp/pip-JhkwOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:39 INFO - Running setup.py (path:/tmp/pip-18Tox_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:39 INFO - Running setup.py (path:/tmp/pip-cZmBdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:39 INFO - Running setup.py (path:/tmp/pip-L4mXnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:39 INFO - Running setup.py (path:/tmp/pip-sWNCHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:40 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)) 09:19:40 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)) 09:19:40 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)) 09:19:40 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)) 09:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:19:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:42 INFO - Downloading blessings-1.6.tar.gz 09:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:19:42 INFO - Installing collected packages: blessings 09:19:42 INFO - Running setup.py install for blessings 09:19:42 INFO - Successfully installed blessings 09:19:42 INFO - Cleaning up... 09:19:42 INFO - Return code: 0 09:19:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:19:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:42 INFO - Reading from file tmpfile_stdout 09:19:42 INFO - Current package versions: 09:19:42 INFO - argparse == 1.2.1 09:19:42 INFO - blessings == 1.6 09:19:42 INFO - blobuploader == 1.2.4 09:19:42 INFO - docopt == 0.6.1 09:19:42 INFO - functools32 == 3.2.3-2 09:19:42 INFO - jsonschema == 2.5.1 09:19:42 INFO - manifestparser == 1.1 09:19:42 INFO - mozInstall == 1.12 09:19:42 INFO - mozcrash == 1.0 09:19:42 INFO - mozdebug == 0.1 09:19:42 INFO - mozdevice == 0.48 09:19:42 INFO - mozfile == 1.2 09:19:42 INFO - mozhttpd == 0.7 09:19:42 INFO - mozinfo == 0.9 09:19:42 INFO - mozleak == 0.1 09:19:42 INFO - mozlog == 3.4 09:19:42 INFO - moznetwork == 0.27 09:19:42 INFO - mozprocess == 0.23 09:19:42 INFO - mozprofile == 0.28 09:19:42 INFO - mozrunner == 6.13 09:19:42 INFO - mozscreenshot == 0.1 09:19:42 INFO - mozsystemmonitor == 0.3 09:19:42 INFO - moztest == 0.7 09:19:42 INFO - mozversion == 1.4 09:19:42 INFO - psutil == 3.1.1 09:19:42 INFO - requests == 1.2.3 09:19:42 INFO - wsgiref == 0.1.2 09:19:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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')]} 09:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:42 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 0x7f6c3ea18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555f60>, '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 0x2556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25571d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', '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 09:19:42 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 09:19:42 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 09:19:42 INFO - Using env: {'DISPLAY': ':0', 09:19:42 INFO - 'HOME': '/home/cltbld', 09:19:42 INFO - 'LANG': 'en_US.UTF-8', 09:19:42 INFO - 'LANGUAGE': 'en_US:en', 09:19:42 INFO - 'LOGNAME': 'cltbld', 09:19:42 INFO - 'MAIL': '/var/mail/cltbld', 09:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:42 INFO - 'MOZ_NO_REMOTE': '1', 09:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:42 INFO - 'NO_EM_RESTART': '1', 09:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:42 INFO - 'PWD': '/builds/slave/test', 09:19:42 INFO - 'SHELL': '/bin/bash', 09:19:42 INFO - 'SHLVL': '1', 09:19:42 INFO - 'TERM': 'linux', 09:19:42 INFO - 'TMOUT': '86400', 09:19:42 INFO - 'USER': 'cltbld', 09:19:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', 09:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:42 INFO - '_': '/tools/buildbot/bin/python'} 09:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:42 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)) 09:19:42 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)) 09:19:42 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)) 09:19:42 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)) 09:19:42 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)) 09:19:42 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)) 09:19:42 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)) 09:19:42 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)) 09:19:42 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)) 09:19:42 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)) 09:19:42 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)) 09:19:42 INFO - Cleaning up... 09:19:42 INFO - Return code: 0 09:19:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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')]} 09:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c3ea18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2555f60>, '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 0x2556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25571d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', '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 09:19: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', 'jsonschema'] in /builds/slave/test/build 09:19: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 jsonschema 09:19:42 INFO - Using env: {'DISPLAY': ':0', 09:19:42 INFO - 'HOME': '/home/cltbld', 09:19:42 INFO - 'LANG': 'en_US.UTF-8', 09:19:42 INFO - 'LANGUAGE': 'en_US:en', 09:19:42 INFO - 'LOGNAME': 'cltbld', 09:19:42 INFO - 'MAIL': '/var/mail/cltbld', 09:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:42 INFO - 'MOZ_NO_REMOTE': '1', 09:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:42 INFO - 'NO_EM_RESTART': '1', 09:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:42 INFO - 'PWD': '/builds/slave/test', 09:19:42 INFO - 'SHELL': '/bin/bash', 09:19:42 INFO - 'SHLVL': '1', 09:19:42 INFO - 'TERM': 'linux', 09:19:42 INFO - 'TMOUT': '86400', 09:19:42 INFO - 'USER': 'cltbld', 09:19:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', 09:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:42 INFO - '_': '/tools/buildbot/bin/python'} 09:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:19:42 INFO - Cleaning up... 09:19:42 INFO - Return code: 0 09:19:42 INFO - Running post-action listener: _resource_record_post_action 09:19:42 INFO - Running post-action listener: _start_resource_monitoring 09:19:42 INFO - Starting resource monitoring. 09:19:42 INFO - [mozharness: 2016-11-29 17:19:42.964956Z] Finished create-virtualenv step (success) 09:19:42 INFO - [mozharness: 2016-11-29 17:19:42.965452Z] Running install step. 09:19:42 INFO - Running pre-action listener: _resource_record_pre_action 09:19:42 INFO - Running main action method: install 09:19:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:43 INFO - Reading from file tmpfile_stdout 09:19:43 INFO - Detecting whether we're running mozinstall >=1.0... 09:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:19:43 INFO - Reading from file tmpfile_stdout 09:19:43 INFO - Output received: 09:19:43 INFO - Usage: mozinstall [options] installer 09:19:43 INFO - Options: 09:19:43 INFO - -h, --help show this help message and exit 09:19:43 INFO - -d DEST, --destination=DEST 09:19:43 INFO - Directory to install application into. [default: 09:19:43 INFO - "/builds/slave/test"] 09:19:43 INFO - --app=APP Application being installed. [default: firefox] 09:19:43 INFO - mkdir: /builds/slave/test/build/application 09:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:19:59 INFO - Reading from file tmpfile_stdout 09:19:59 INFO - Output received: 09:19:59 INFO - /builds/slave/test/build/application/firefox/firefox 09:19:59 INFO - Running post-action listener: _resource_record_post_action 09:19:59 INFO - [mozharness: 2016-11-29 17:19:59.241746Z] Finished install step (success) 09:19:59 INFO - [mozharness: 2016-11-29 17:19:59.241988Z] Running run-tests step. 09:19:59 INFO - Running pre-action listener: _resource_record_pre_action 09:19:59 INFO - Running main action method: run_tests 09:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:19:59 INFO - Python 2.7.3 09:19:59 INFO - Return code: 0 09:19:59 INFO - grabbing minidump binary from tooltool 09:19:59 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')]} 09:19:59 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 0x2555f60>, '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 0x2556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25571d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:19:59 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 09:19:59 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 09:19:59 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 09:19:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:19:59 INFO - Return code: 0 09:19:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:19:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:19:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:19:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:19:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 09:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 09:19:59 INFO - Using env: {'DISPLAY': ':0', 09:19:59 INFO - 'HOME': '/home/cltbld', 09:19:59 INFO - 'LANG': 'en_US.UTF-8', 09:19:59 INFO - 'LANGUAGE': 'en_US:en', 09:19:59 INFO - 'LOGNAME': 'cltbld', 09:19:59 INFO - 'MAIL': '/var/mail/cltbld', 09:19:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:19:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:59 INFO - 'MOZ_NO_REMOTE': '1', 09:19:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:59 INFO - 'NO_EM_RESTART': '1', 09:19:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:59 INFO - 'PWD': '/builds/slave/test', 09:19:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:19:59 INFO - 'SHELL': '/bin/bash', 09:19:59 INFO - 'SHLVL': '1', 09:19:59 INFO - 'TERM': 'linux', 09:19:59 INFO - 'TMOUT': '86400', 09:19:59 INFO - 'USER': 'cltbld', 09:19:59 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693', 09:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:59 INFO - '_': '/tools/buildbot/bin/python'} 09:19:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 09:19:59 INFO - mozversion application_buildid: 20161129062927 09:19:59 INFO - mozversion application_changeset: 55c4ba0e73cdae6e2cfc93f7d195273b15f2f56e 09:19:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:19:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:19:59 INFO - mozversion application_name: Firefox 09:19:59 INFO - mozversion application_remotingname: firefox-dev 09:19:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:19:59 INFO - mozversion application_vendor: Mozilla 09:19:59 INFO - mozversion application_version: 52.0a2 09:19:59 INFO - mozversion platform_buildid: 20161129062927 09:19:59 INFO - mozversion platform_changeset: 55c4ba0e73cdae6e2cfc93f7d195273b15f2f56e 09:19:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:19:59 INFO - mozversion platform_version: 52.0a2 09:19:59 INFO - using testdate: 1480439999 09:19:59 INFO - actual date: 1480439999 09:19:59 INFO - starting webserver on 'localhost:49790' 09:19:59 INFO - SUITE-START | Running 2 tests 09:19:59 INFO - TEST-START | dromaeo_css 09:19:59 INFO - operating with platform_type : linux_ 09:19:59 INFO - Initialising browser for dromaeo_css test... 09:19:59 INFO - TEST-INFO | started process 12063 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_bQWZu/profile http://localhost:49790/getInfo.html) 09:20:04 INFO - PROCESS | 12063 | __metrics Screen width/height:1600/1200 09:20:04 INFO - PROCESS | 12063 | colorDepth:24 09:20:04 INFO - PROCESS | 12063 | Browser inner width/height: 1024/697 09:20:04 INFO - PROCESS | 12063 | __metrics 09:20:04 ERROR - PROCESS | 12063 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 09:20:05 INFO - TEST-INFO | 12063: exit 0 09:20:05 INFO - Browser initialized. 09:20:05 INFO - Running cycle 1/1 for dromaeo_css test... 09:20:05 INFO - TEST-INFO | started process 12196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_bQWZu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:17 INFO - PROCESS | 12196 | RSS: Main: 152330240 09:20:17 INFO - PROCESS | 12196 | 09:21:06 INFO - PROCESS | 12196 | 1480440066768 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] 09:23:17 INFO - PROCESS | 12196 | Cycle 1(1): loaded http://localhost:49790/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49790/tests/dromaeo/cssquery-ext.html) 09:23:18 INFO - PROCESS | 12196 | RSS: Main: 156975104 09:23:18 INFO - PROCESS | 12196 | 09:26:20 INFO - PROCESS | 12196 | Cycle 1(1): loaded http://localhost:49790/tests/dromaeo/cssquery-ext.html (next: http://localhost:49790/tests/dromaeo/cssquery-jquery.html) 09:26:21 INFO - PROCESS | 12196 | RSS: Main: 154710016 09:26:21 INFO - PROCESS | 12196 | 09:29:23 INFO - PROCESS | 12196 | Cycle 1(1): loaded http://localhost:49790/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49790/tests/dromaeo/cssquery-mootools.html) 09:29:23 INFO - PROCESS | 12196 | RSS: Main: 153751552 09:29:23 INFO - PROCESS | 12196 | 09:32:25 INFO - PROCESS | 12196 | Cycle 1(1): loaded http://localhost:49790/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49790/tests/dromaeo/cssquery-prototype.html) 09:32:26 INFO - PROCESS | 12196 | RSS: Main: 152625152 09:32:26 INFO - PROCESS | 12196 | 09:35:28 INFO - PROCESS | 12196 | Cycle 1(1): loaded http://localhost:49790/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49790/tests/dromaeo/cssquery-yui.html) 09:35:29 INFO - PROCESS | 12196 | RSS: Main: 155443200 09:35:29 INFO - PROCESS | 12196 | 09:38:31 INFO - PROCESS | 12196 | Cycle 1(1): loaded http://localhost:49790/tests/dromaeo/cssquery-yui.html (next: http://localhost:49790/tests/dromaeo/cssquery-dojo.html) 09:38:31 INFO - PROCESS | 12196 | RSS: Main: 156053504 09:38:31 INFO - PROCESS | 12196 | 09:38:31 INFO - PROCESS | 12196 | __start_tp_report 09:38:31 INFO - PROCESS | 12196 | _x_x_mozilla_page_load 09:38:31 INFO - PROCESS | 12196 | _x_x_mozilla_page_load_details 09:38:31 INFO - PROCESS | 12196 | |i|pagename|runs| 09:38:31 INFO - PROCESS | 12196 | |0;dojo.html;3276.0826968448832;3282.0810173151513;3288.013595921223;3302.5871766029245;3311.834408279585;5821.796237131696;5843.094320380348;5881.911771323428;5883.705814709264;5884.529237660988;5787.942120578793;5814.563907706928;5814.883702325951;5829.650220986744;5858.73635686394;5216.374035115791;5266.947330526684;5297.231901374298;5305.575553955674;5327.920081198785;5286.735663216843;5337.599680023995;5337.839864804062;5355.98236335095;5368.677879327252;5178.0679477694;5180.585553155738;5324.254604355393;5333.759980800874;5334;5221.530062294374;5237.240600112981;5261.210818377236;5280.524752772269;5306.522412982811;5182;5218.60860435465;5249.238860365225;5255.08036093682;5336.546393556552;5825.0679891217205;5881.264841894763;5893.14549390336;5919.260092488439;5944.613600116022;6125.845966769323;6147.262328520562;6169.043798211284;6246.156768836195;6250.499960003189;6236.01566245803;6307.211598550181;6309.526785491061;6310.495160387158;6319.526035547352;5706;5762.250907382014;5816.592838501307;5847.473727364558;5864.354920958691;6173.59871608344;6274.717637706314;6299.023651334051;6322.430981211713;6329.398707122816;6041.758329666764;6070.180525629072;6091.208142941389;6114.633122012693;6121.510279177655;6088.2694076710195;6187.628742275388;6211.81364559064;6215;6218.31598524162;5976.7908123215475;6036.879262414727;6045.183900173508;6102.267727872683;6119.2350956130485;6184.5980011299125;6214.471769899519;6216.627002379872;6217.409346112112;6238.532110091761;4730.053989202173;4739.905201896012;4749.145153872336;4750.12122757291;4781.880452988634;4161.313383291784;4165.354370072643;4192.790360481964;4208.642265407413;4230.725002874803;5926.67403292823;6012.699365031731;6022.789202377896;6040.7583696651645;6061.575689701678;6037.667928263988;6278.937210627927;6298.685065746786;6328.525360597973;6337.081123237105;5783.652980821164;5838.94161058384;5892.145638882424;5910.438508341701;5992.910106348409;5344.225087362311;5345.599080068932;5359.115745901882;5399.730013499309;5404.351477822686;6516.706748196248;6517.4134327910715;6534.509911756637;6537.215534135934;6539.019147127874;6112.959454150325;6118.771466972081;6153.2000839890525;6194.628322300677;6241.157443745036;6471.094046833353;6477.676116194078;6484.773032943825;6540.607563546202;6546.083548303337;6161.599496032743;6162.845928851814;6168.321484636596;6179.876402471836;6183.721732522137;6039.365866584121;6114.847128821815;6146.631202127886;6198.1012753149635;6290.465310448663;6126.761967422209;6128.142060111499;6134.693265336805;6157.784477543264;6162.414570615784;6072.635641861502;6092.177556030057;6120.418560236771;6128.4790792783115;6137.140800287874;5883.294004719461;5885.911711324419;5902.026165682614;5942.970285148546;6038.064100064497;6143.511877689543;6212.937870621236;6221;6249;6250.749970001149;6021.638084621308;6043.879122417615;6060.2424696912885;6080.331163571915;6100.877982440237 09:38:31 INFO - PROCESS | 12196 | |1;ext.html;609.0772479693264;625.9530535209859;662.6256165266624;672.1900110367009;694.5520139510013;39330.60669393305;43291.78354108229;43302;43345;43565;43013;43310.35034474485;43532.3470147948;43670;43878.561214387926;8601.182887625697;8710.47737135774;8751.693690720826;8761.737147885542;8804;8618.224359807617;8680.56597170142;8687.782805429852;8747.037825839152;8754.6935857245;8700.738977830675;8771.736847894574;8772.298216142724;8775.605097770616;8798.340124490656;8582.914170858305;8674.86987695185;8688;8751;8759.299256059563;8694.130586941319;8702.434341767828;8715.477071375737;8768.123187681245;8770.254528365096;40675.59324406777;40692.389614155814;40709.1858162838;40993.79503102465;41082.79458602718;3696.4270538066376;3802.2205447883116;3850.614938506155;4066.247744167309;4147.066909945268;32439.83780081108;32626.6737332626;32946.50580241298;32953.835230823934;33072.50391244133;4322.200392927319;4393.78031098447;4452.0873220989615;4463.843765468193;4530.8867278317975;344478;346267;346540;347526;348657.99999999744;58012.12981805277;58121.128183077286;58253;58462;58508.122378164364;61722.69138654278;61926.38073619206;61942.38057619456;61971.38028619656;62274.82038128644;17018.574535636708;17267.222974966156;17391.217395217245;17406.0426676534;17427.302907883797;13437.126586771828;13456.192628442324;13531.864681353258;13560.45758169662;13566.796498052538;15275.465358712392;15979.840201598068;16097.678046439005;16097.919510402373;16151.596210094607;6516.315786842408;6590.7693230736695;6611.834704132339;6711.590565981199;7007.754728584475;964.8903760675139;1152.2337645465839;1162.3839365136491;1201.4173126033866;1208.4109396144042;31984.680153198635;32086.35827283441;32403.35193296121;33167.66832331694;33424;1099.1316859680762;1113.2763703592568;1141.6175581180232;1159.7274640459486;1177.0995188680665;16984.49046528606;17086.231119599648;17397.391091311743;17459.65080698379;17502.82497175012;481921;481972;482828;485355;488183;58659;58702.412975869694;58774.70612646909;58849;58923.82152357014;1372.4373007067254;1392.4291040673274;1411.865872742088;1411.9223442710545;1422.239102080382;31111.222219444695;32274.193145171557;33010.66989330076;33015.50476742803;33387;50216.24675629941;50817.49182508128;50851.47445576639;51045;51146.232806507185;437956;438486;440567;441991;444144;40953.79523102365;41474.585254147074;41589;41769;42854;47409.762951185025;47674.76162619165;47769.76115119402;49168.50831491639;49277.26084108813;40082.19013718372;42009.78995105127;42084.57915420806;42510.1497970045;42746.358804618576;40203.59796401999;41138.38292425556;41583.37624935689;42686.78656606697;42795;41590.58409415988;41655.1668966625;41706;41744.582554175286;43454;34519.4822077674;36302;36735.448968266035;36838.26323473462;37063;28483.28791780222;28636;28747.425051498434;28778.856105719336;28881.42237155287 09:38:31 INFO - PROCESS | 12196 | |2;jquery.html;401.65457706372496;404.06257482640285;428.43874524373075;429.74000729558617;438.2790309940149;18588.907055464722;19175.32886348978;19209.71185432218;19350.225990960345;20072.297469588568;19704.60590788187;20178.59642807143;20304.695429568532;20321.085551150234;20776.8961155194;5463.235147079412;6043.728032238538;6060.818175454721;6078.240219972504;6099.756009759604;5777.42225777421;5936.673482958436;5983.970080149593;6012.3085845127935;6032.66820324882;5920.644761314314;5930.169776231331;5940.04959206527;5961.761529538813;5967.671778052206;5712.257406537145;5927;5953.077273022688;5959.165716799652;5968.582199246054;5425.403205647375;5430.972845135749;5437.184422336642;5438.483344082306;5478.315210598676;14720.558383248519;20443.38669839907;21638.891805540872;23897.163599274118;24047.15834945786;2223.132978138527;2541.5552278351215;2562.410645551515;3006.8573941901936;3084.8766049358;10699.946500267526;11052.613158539412;11142.220044596881;11397.487113079931;11709.590164344207;1995;2045.3761602711168;2078.6050650376533;2103.9368818935304;2113.323736404351;89302.55348723214;89718;91332;92016;92854.5357273216;11222.270552414067;12065.457054432572;12205;12395.62813115608;12962.28707421082;15179.468718594797;15261.313240904186;15322.310496027705;15375.538733838002;15477.303521341566;8186.345092392594;8282.674772036446;8301.709440169565;8492;8525.914740852637;7927.405444591679;8129.170936539232;8134.437652139557;8248.8350232995;8457.83084338322;4330.805113769888;4390.07808360248;4392.945693033713;4472.709273897186;4680.648951328664;1969.812867777559;2013.1242909334487;2023.6559784836613;2027.635025695389;2122.204173434962;909.6179604566098;934.8213485718826;976.916962058233;1017.8524114003428;1025.917926565873;19662.410127696192;20019.699704504445;20271.29050483226;20291.695624565644;20366;1004.2417974429259;1007.6825799873017;1009.1724785675675;1015.4059874973224;1020.7805321855836;11170.664880053611;11334.60328888485;11402.885971140347;11461.197716159955;11514.56067991501;478788;482513;487809;489167;491212;53790.19314710282;58151.41848581545;69667.65166174137;96876.51561742146;101421.99999999853;1011.4184344002081;1020.0564477857952;1033.5245786938092;1039.2309690828884;1052.563186277686;17691.911540442215;18093.90953045279;18164;18308.359207427675;18415.53961150982;31561.684383156793;38067.42898856575;41451.37822932598;43030.56969430391;44721.77639111783;59075;61047.08429373474;61176.082358763764;61512.38487615067;64924.675376622814;8478.364122690946;8741.650333986569;8776.780580485283;8886.111388861062;8894.42186257891;12863.935680321538;13552.661183470493;13699.863001369858;13777.655558611115;13856.237906915216;11266.549338026714;11331.603393881174;11381.943090284496;11493.82759258595;11518.712032198926;11726.530938762355;11787.646370608896;11841.940790296338;12013.579524716943;12209.938950305192;11123.944380278046;11669.183157178915;11945.940270298594;12206.81689774672;12210.6947326314;8507.361947854059;8520.062793092631;8729.912700873165;9021.729348119567;9315.906840931504;10224.64213752515;11747.88252117502;11896.524139034342;12254.4485498151;12285.078619103782 09:38:31 INFO - PROCESS | 12196 | |3;mootools.html;1525;1540.9383624655015;1656.4947690954255;1780.6883795335814;1784.1525275494141;7876.133625301212;8157.306628936548;8648.308135349173;9126.543672816366;9182.219511341544;8609.827803443928;8851.203391694746;8861.468311901273;9072.773180670487;9142.314326425512;2435.330284171849;2463.9260822175365;2466.5683505386573;2468.049800826686;2469.1975108089855;2427.490227052321;2473.4558397152596;2496.4383013821835;2500.949981000379;2513.183215454975;2419.721732000825;2430.3802530354824;2459.5449841779237;2461.7661322174363;2483.3667414809197;2355.9764402356013;2376.5959786836193;2407.265783935899;2420.862194768456;2436.3543660929868;2391.7129944406784;2410.301012706313;2417.504411595619;2421.782039616425;2423.9757602423924;8978.775530611721;9030.367874248805;9061.954690226572;9162.541872906328;9198.724038278862;5458.426865179139;5596.524295434893;5600.383957764642;5601.915971260434;5607.57943154261;3571.4464258040043;3576.2489877125836;3587.802670853102;3603.40543810271;3709.7959612221316;1161.2277835239556;1171.279663007253;1181.8417950408561;1196.9640910772691;1229.858566264882;12559.748805023939;12615.116941814076;12690.492380304777;12719.936400318033;12756.362181890869;4704.954658956448;4790.185668436374;4808;4852.126617208865;4884.340614017134;10483.47582620881;10507.684769456928;10527.420991845522;10532.526036328383;10561.947190264153;5508.641938274;5529.861753456195;5538.224648549206;5540.584456165723;5559.277293951841;4927.901441971212;4957.876053098701;5083.161278389024;5142.97428512855;5182.455842136596;4039.8384064637085;4070.2673518766314;4130.091379896418;4165.500139983222;4186.853460128942;1248.9125761196628;1259.5465632372338;1275.3686924972199;1276.712739633575;1287.2855565161237;839.2488722593367;961.293449314753;1015.939043657383;1028.9691309260734;1029.4029462911494;6124;6174.938250617436;6232.844178895564;6278.6546739929745;6432.871342573216;455.11025944278856;460.08672784522696;465.50191295313687;471.16603611607263;471.76176031104075;4047.9595204048173;4149.33610622299;4229.598188172119;4253.957460425418;4263.637590804817;11045.889541104647;11412.42937853104;11415.37215453158;11422.543098276143;11430.485628146753;11211.495482703298;11231.157663175294;11258.043066339453;11263.549458021751;11280.943595281971;8135.7152499662225;8438.662453501915;8483.236508714246;8549.957250213709;8630.568471576396;6207.410296021871;6273.592216505913;6433.131527243762;6468.676566171766;6601.966990165019;10228.335158214692;10346.948265258625;10430.165586753194;10532.21008424356;10569.471526423495;10206.6427675034;10402.947985260025;10434.321769084985;10529.57881684724;10592.947035265082;7896.249856263646;7978.680852765824;8043.6782528698195;8067.112617611941;8097.959510202411;8751.868721969304;8799.692010779592;8821;8846.513441760764;8895;7796.688132474637;7861.213878612093;7913.643886025257;7919.84160316802;7955.5226686399;7821.491603045783;7839.725609603636;7841.255080767318;7860.253275938777;8038.718644847402;7234.819129521594;7269.345758881726;7409.481336306622;7453.329200371993;7488.925110748823;5415.891682166413;5426.240326354393;5451.1005684063275;5480.150576660624;5585.1901474286815;5651.095824668198;5679.744411501575;5686.374498805046;5698.544116470755;5876.44173803488 09:38:31 INFO - PROCESS | 12196 | |4;prototype.html;351.4885841101198;361.36039210597244;363.5237838431654;370.28029126069015;370.6330732574752;5618.0449323614985;5703.317521331207;5735.512481439077;5837.970810145954;5838.737256823442;5423.403425623178;5534.169874518824;5609.5231905288;5616.494515493605;5619.269494965649;4496.460424749034;4506.819727210924;4511.165434394639;4526.321051842234;4532.5694059064335;4220.894477638053;4438.201123797715;4448.733076015449;4522.592966633002;4552.453705555321;4406.347619642634;4421.336799480072;4424.716832118682;4430.42719834459;4437.469073169751;4412.903870661442;4415.757133357664;4435.401220835178;4449.710768800018;4464.665150113755;3819.9045023874346;3911.2177564487215;3932.233214523169;3951.9012024699323;3955.208958208341;5542.251796007527;5543.861403464905;5551.639848237167;5568.331800184003;5584.21820945068;5113.130767769489;5122.795088196468;5127.974360128175;5128.794848206067;5135.948640513584;5746.655200687972;5863.4722874941035;5902.32123305821;5957.599964008455;5970.940290597082;4197.580241975808;4199.307114326163;4202.915941681149;4218.261804184286;4223.345381465878;6170.290416602058;6221.315655277871;6249.187865460561;6250;6274.152989346426;4278.037441575683;4316;4362.298703505636;4401.097774956126;4416.867493975186;4416.867493975186;4429.379886815848;4430.269005614102;4433.556644335541;4436.511983681792;5082.237664350303;5095.898082038412;5100.719460429637;5100.821471248489;5110.693358398508;5672.432756724294;5812.82561523155;5975.850603734942;5988.550858685616;6010.398960103955;1475.4393330534328;1485.9331330090172;1486.3682934752687;1489.9851001490063;1506.9397224111133;958.3387462650749;1018.5671089786811;1019.2559431614962;1036.3108532825586;1039.0544604409952;5499.340079190522;5545.72271386429;5551.723103686175;5600.52395546375;5684.261046063985;5883.705814709333;5966.820995370146;5967.910481342783;6032.728527216286;6105.603135796159;5506.669599824023;5532.585056120807;5580;5615.8596035098635;5685.204071430003;3159.76301777363;3165.7942233754734;3170.6670799565713;3180.7296379807976;3183.8248896310924;5904.546968439206;6000.819975400745;6124.601900876429;6144.539159563051;6163.722632481549;5983.491403230774;5999.250093738283;6005.129256257906;6005.459508644243;6073.210482637317;6163.506919446433;6215.34738852423;6224.906626400517;6253.561680813438;6258.718357673824;5777.8555536111935;5874.295084589877;5881.617694849821;5899.4985426239255;5950.256217972754;5823.912641310469;5847.94152058491;5861.267341582302;5888.440598143169;5895.233619629421;5926.288845338587;6106.45041946227;6171.728983638679;6277.874442511033;6311.24265088174;4249.298865687127;4260.595243451867;4266.360045993126;4267.50923643785;4303.203907277164;5955.285365756137;5992.340842507408;6011.098335249748;6024.61433870221;6189.597676151036;6023.969880150571;6026.849328766641;6033.125196846345;6046.969765151146;6048.667323297085;6013.579049466671;6025.0359942409;6050.788222412194;6050.848728781815;6098.627808742997;5695.487406133468;5938.821835344774;5964.538688021463;5965.135055417027;5976.402359763989;6069.666168360783;6126.785562505291;6127.877442451215;6129.387061294014;6131.264248290234;5614.214010038516;5762.596618236683;5813.180607405489;5955.761769529344;5966.105084237399 09:38:31 INFO - PROCESS | 12196 | |5;yui.html;760.9460302991274;771.4175797273059;807.1928071928072;824.6247957179484;853.7310747114662;13631.318434078294;13639.863601363983;13653.590392288248;13682.042257042023;14373.856261437382;14289.142651440921;14299.285035748224;14399;14404.351804168811;14453.855461445382;837.5644664774313;843.0515669871395;845.9323254139684;847.0132295875297;853.2235665544356;830.3564737328559;832.0389949608212;834.228338786623;844.1727107434717;845.4208866926175;883.1742320929919;887.0287035695935;888.7467071884514;893.6202114101513;895.2256298301954;878.5343767803074;879.2877769007092;881.4799268431624;882.0870399136894;882.7219425880827;645.4513663386131;646.321362569305;649.1917562634503;650.3593959949446;653.6470306034736;11891.94054029733;11950.462229199708;11956.222845515014;12004.459799309052;12108.21296615717;12511.687207819787;12707.618771436872;12997;13082.738345233138;13099.934500327532;10962.890371096266;11128.554857805679;11169.72075698106;11294;11455.427228638619;3751.9812400938094;3780.2439512097417;3790.962090379116;3796.0889386547306;3899.181171953893;47620.52379476195;53134;60816.391836081515;63965;64585;11297.71755706114;11342.829857552144;11360.261582997078;11484.94257528707;11766.235194712317;17667.55831104233;17686.204120814593;17834.37579684705;17862.374816881347;17925;7688.192739762357;7799.33705635016;7857.646405911748;8079.394045446615;8304.335653147733;4458.598726114666;4477.350784136282;4495.393121928498;4598.425196850394;4629.583337499641;3581.1763294442426;3631.3100510902846;3647.744657873923;3653.159773252167;3678.5953545110015;639.8272466434037;641.8395401149712;654.5908806995627;661.1273119482237;662.920449546048;649.4155260265704;730.9634518274065;740.6926125657792;745.1282000059942;749.7863109014014;9217;9345.20565751905;9452.621895124117;9697.224222062217;9740.75648108803;632.8797528469576;697.6616341074575;723.5405517496323;738.6284876928286;742.7289039500544;4502.459704835441;4571.885702857388;4594.356790049395;4599.448066232074;4624.745638989821;88920;89830;91765;93873;98015;52090.739546302786;69948;84456;84667;84692.57653711693;72986.63506682432;74534.62732686411;74661.62669186728;75632.62183689156;77088.22911770923;8901.910980890367;8917.55412229373;9074.137956894085;9103.544822758968;9174;50522.24216636827;51074.97850043052;51806.740966296435;52687.736561316946;52756.20865686941;66854.33145668481;70245.64877175786;71095;72100.27899720936;74259.62870185614;11390.25963312382;11510.654680359603;11591.18861679708;11600.245984011011;11839.526418943145;12114.636560903187;12154.209976351509;12159;12182.939085304517;12272.877271227531;11199.10407167441;11483.540658373571;11493.942530287295;11498.82751758741;11703.2978021319;11458.82811757841;11933.105017123924;11959.581414650445;12310.569130080405;12588.748225035264;12058.51765929388;12107.878921210675;12190.268583884996;12217.816732749194;12882.291473969022;9336.439813611205;9599.952000239955;9818.16545593604;9922.156616687662;9968.451735154345;10125.696229113139;10172.08451239392;10173.643922462677;10220.182385409298;10234.283600148216 09:38:31 INFO - PROCESS | 12196 | __end_tp_report 09:38:31 INFO - PROCESS | 12196 | __start_cc_report 09:38:31 INFO - PROCESS | 12196 | _x_x_mozilla_cycle_collect,305 09:38:31 INFO - PROCESS | 12196 | __end_cc_report 09:38:31 INFO - PROCESS | 12196 | __startTimestamp1480441111902__endTimestamp 09:38:31 INFO - PROCESS | 12196 | 09:38:31 INFO - PROCESS | 12196 | ------- Summary: start ------- 09:38:31 INFO - PROCESS | 12196 | Number of tests: 6 09:38:31 INFO - PROCESS | 12196 | 09:38:31 INFO - PROCESS | 12196 | [#0] dojo.html Cycles:165 Average:5782.60 Median:6039.37 stddev:672.70 (11.1%) stddev-sans-first:645.39 09:38:31 INFO - PROCESS | 12196 | Values: 3276.1 3282.1 3288.0 3302.6 3311.8 5821.8 5843.1 5881.9 5883.7 5884.5 5787.9 5814.6 5814.9 5829.7 5858.7 5216.4 5266.9 5297.2 5305.6 5327.9 5286.7 5337.6 5337.8 5356.0 5368.7 5178.1 5180.6 5324.3 5333.8 5334.0 5221.5 5237.2 5261.2 5280.5 5306.5 5182.0 5218.6 5249.2 5255.1 5336.5 5825.1 5881.3 5893.1 5919.3 5944.6 6125.8 6147.3 6169.0 6246.2 6250.5 6236.0 6307.2 6309.5 6310.5 6319.5 5706.0 5762.3 5816.6 5847.5 5864.4 6173.6 6274.7 6299.0 6322.4 6329.4 6041.8 6070.2 6091.2 6114.6 6121.5 6088.3 6187.6 6211.8 6215.0 6218.3 5976.8 6036.9 6045.2 6102.3 6119.2 6184.6 6214.5 6216.6 6217.4 6238.5 4730.1 4739.9 4749.1 4750.1 4781.9 4161.3 4165.4 4192.8 4208.6 4230.7 5926.7 6012.7 6022.8 6040.8 6061.6 6037.7 6278.9 6298.7 6328.5 6337.1 5783.7 5838.9 5892.1 5910.4 5992.9 5344.2 5345.6 5359.1 5399.7 5404.4 6516.7 6517.4 6534.5 6537.2 6539.0 6113.0 6118.8 6153.2 6194.6 6241.2 6471.1 6477.7 6484.8 6540.6 6546.1 6161.6 6162.8 6168.3 6179.9 6183.7 6039.4 6114.8 6146.6 6198.1 6290.5 6126.8 6128.1 6134.7 6157.8 6162.4 6072.6 6092.2 6120.4 6128.5 6137.1 5883.3 5885.9 5902.0 5943.0 6038.1 6143.5 6212.9 6221.0 6249.0 6250.7 6021.6 6043.9 6060.2 6080.3 6100.9 09:38:31 INFO - PROCESS | 12196 | 09:38:31 INFO - PROCESS | 12196 | [#1] ext.html Cycles:180 Average:59267.90 Median:42716.57 stddev:112987.98 (264.5%) stddev-sans-first:113219.10 09:38:31 INFO - PROCESS | 12196 | Values: 609.1 626.0 662.6 672.2 694.6 39330.6 43291.8 43302.0 43345.0 43565.0 43013.0 43310.4 43532.3 43670.0 43878.6 8601.2 8710.5 8751.7 8761.7 8804.0 8618.2 8680.6 8687.8 8747.0 8754.7 8700.7 8771.7 8772.3 8775.6 8798.3 8582.9 8674.9 8688.0 8751.0 8759.3 8694.1 8702.4 8715.5 8768.1 8770.3 40675.6 40692.4 40709.2 40993.8 41082.8 3696.4 3802.2 3850.6 4066.2 4147.1 32439.8 32626.7 32946.5 32953.8 33072.5 4322.2 4393.8 4452.1 4463.8 4530.9 344478.0 346267.0 346540.0 347526.0 348658.0 58012.1 58121.1 58253.0 58462.0 58508.1 61722.7 61926.4 61942.4 61971.4 62274.8 17018.6 17267.2 17391.2 17406.0 17427.3 13437.1 13456.2 13531.9 13560.5 13566.8 15275.5 15979.8 16097.7 16097.9 16151.6 6516.3 6590.8 6611.8 6711.6 7007.8 964.9 1152.2 1162.4 1201.4 1208.4 31984.7 32086.4 32403.4 33167.7 33424.0 1099.1 1113.3 1141.6 1159.7 1177.1 16984.5 17086.2 17397.4 17459.7 17502.8 481921.0 481972.0 482828.0 485355.0 488183.0 58659.0 58702.4 58774.7 58849.0 58923.8 1372.4 1392.4 1411.9 1411.9 1422.2 31111.2 32274.2 33010.7 33015.5 33387.0 50216.2 50817.5 50851.5 51045.0 51146.2 437956.0 438486.0 440567.0 441991.0 444144.0 40953.8 41474.6 41589.0 41769.0 42854.0 47409.8 47674.8 47769.8 49168.5 49277.3 40082.2 42009.8 42084.6 42510.1 42746.4 40203.6 41138.4 41583.4 42686.8 42795.0 41590.6 41655.2 41706.0 41744.6 43454.0 34519.5 36302.0 36735.4 36838.3 37063.0 28483.3 28636.0 28747.4 28778.9 28881.4 09:38:31 INFO - PROCESS | 12196 | 09:38:31 INFO - PROCESS | 12196 | [#2] jquery.html Cycles:180 Average:28927.78 Median:11931.01 stddev:80097.08 (671.3%) stddev-sans-first:80293.14 09:38:31 INFO - PROCESS | 12196 | Values: 401.7 404.1 428.4 429.7 438.3 18588.9 19175.3 19209.7 19350.2 20072.3 19704.6 20178.6 20304.7 20321.1 20776.9 5463.2 6043.7 6060.8 6078.2 6099.8 5777.4 5936.7 5984.0 6012.3 6032.7 5920.6 5930.2 5940.0 5961.8 5967.7 5712.3 5927.0 5953.1 5959.2 5968.6 5425.4 5431.0 5437.2 5438.5 5478.3 14720.6 20443.4 21638.9 23897.2 24047.2 2223.1 2541.6 2562.4 3006.9 3084.9 10699.9 11052.6 11142.2 11397.5 11709.6 1995.0 2045.4 2078.6 2103.9 2113.3 89302.6 89718.0 91332.0 92016.0 92854.5 11222.3 12065.5 12205.0 12395.6 12962.3 15179.5 15261.3 15322.3 15375.5 15477.3 8186.3 8282.7 8301.7 8492.0 8525.9 7927.4 8129.2 8134.4 8248.8 8457.8 4330.8 4390.1 4392.9 4472.7 4680.6 1969.8 2013.1 2023.7 2027.6 2122.2 909.6 934.8 976.9 1017.9 1025.9 19662.4 20019.7 20271.3 20291.7 20366.0 1004.2 1007.7 1009.2 1015.4 1020.8 11170.7 11334.6 11402.9 11461.2 11514.6 478788.0 482513.0 487809.0 489167.0 491212.0 53790.2 58151.4 69667.7 96876.5 101422.0 1011.4 1020.1 1033.5 1039.2 1052.6 17691.9 18093.9 18164.0 18308.4 18415.5 31561.7 38067.4 41451.4 43030.6 44721.8 59075.0 61047.1 61176.1 61512.4 64924.7 8478.4 8741.7 8776.8 8886.1 8894.4 12863.9 13552.7 13699.9 13777.7 13856.2 11266.5 11331.6 11381.9 11493.8 11518.7 11726.5 11787.6 11841.9 12013.6 12209.9 11123.9 11669.2 11945.9 12206.8 12210.7 8507.4 8520.1 8729.9 9021.7 9315.9 10224.6 11747.9 11896.5 12254.4 12285.1 09:38:31 INFO - PROCESS | 12196 | 09:38:31 INFO - PROCESS | 12196 | [#3] mootools.html Cycles:180 Average:6004.15 Median:2585.23 stddev:3392.12 (131.2%) stddev-sans-first:3384.93 09:38:31 INFO - PROCESS | 12196 | Values: 1525.0 1540.9 1656.5 1780.7 1784.2 7876.1 8157.3 8648.3 9126.5 9182.2 8609.8 8851.2 8861.5 9072.8 9142.3 2435.3 2463.9 2466.6 2468.0 2469.2 2427.5 2473.5 2496.4 2500.9 2513.2 2419.7 2430.4 2459.5 2461.8 2483.4 2356.0 2376.6 2407.3 2420.9 2436.4 2391.7 2410.3 2417.5 2421.8 2424.0 8978.8 9030.4 9062.0 9162.5 9198.7 5458.4 5596.5 5600.4 5601.9 5607.6 3571.4 3576.2 3587.8 3603.4 3709.8 1161.2 1171.3 1181.8 1197.0 1229.9 12559.7 12615.1 12690.5 12719.9 12756.4 4705.0 4790.2 4808.0 4852.1 4884.3 10483.5 10507.7 10527.4 10532.5 10561.9 5508.6 5529.9 5538.2 5540.6 5559.3 4927.9 4957.9 5083.2 5143.0 5182.5 4039.8 4070.3 4130.1 4165.5 4186.9 1248.9 1259.5 1275.4 1276.7 1287.3 839.2 961.3 1015.9 1029.0 1029.4 6124.0 6174.9 6232.8 6278.7 6432.9 455.1 460.1 465.5 471.2 471.8 4048.0 4149.3 4229.6 4254.0 4263.6 11045.9 11412.4 11415.4 11422.5 11430.5 11211.5 11231.2 11258.0 11263.5 11280.9 8135.7 8438.7 8483.2 8550.0 8630.6 6207.4 6273.6 6433.1 6468.7 6602.0 10228.3 10346.9 10430.2 10532.2 10569.5 10206.6 10402.9 10434.3 10529.6 10592.9 7896.2 7978.7 8043.7 8067.1 8098.0 8751.9 8799.7 8821.0 8846.5 8895.0 7796.7 7861.2 7913.6 7919.8 7955.5 7821.5 7839.7 7841.3 7860.3 8038.7 7234.8 7269.3 7409.5 7453.3 7488.9 5415.9 5426.2 5451.1 5480.2 5585.2 5651.1 5679.7 5686.4 5698.5 5876.4 09:38:31 INFO - PROCESS | 12196 | 09:38:31 INFO - PROCESS | 12196 | [#4] prototype.html Cycles:180 Average:4984.68 Median:5616.18 stddev:1456.55 (25.9%) stddev-sans-first:1418.51 09:38:31 INFO - PROCESS | 12196 | Values: 351.5 361.4 363.5 370.3 370.6 5618.0 5703.3 5735.5 5838.0 5838.7 5423.4 5534.2 5609.5 5616.5 5619.3 4496.5 4506.8 4511.2 4526.3 4532.6 4220.9 4438.2 4448.7 4522.6 4552.5 4406.3 4421.3 4424.7 4430.4 4437.5 4412.9 4415.8 4435.4 4449.7 4464.7 3819.9 3911.2 3932.2 3951.9 3955.2 5542.3 5543.9 5551.6 5568.3 5584.2 5113.1 5122.8 5128.0 5128.8 5135.9 5746.7 5863.5 5902.3 5957.6 5970.9 4197.6 4199.3 4202.9 4218.3 4223.3 6170.3 6221.3 6249.2 6250.0 6274.2 4278.0 4316.0 4362.3 4401.1 4416.9 4416.9 4429.4 4430.3 4433.6 4436.5 5082.2 5095.9 5100.7 5100.8 5110.7 5672.4 5812.8 5975.9 5988.6 6010.4 1475.4 1485.9 1486.4 1490.0 1506.9 958.3 1018.6 1019.3 1036.3 1039.1 5499.3 5545.7 5551.7 5600.5 5684.3 5883.7 5966.8 5967.9 6032.7 6105.6 5506.7 5532.6 5580.0 5615.9 5685.2 3159.8 3165.8 3170.7 3180.7 3183.8 5904.5 6000.8 6124.6 6144.5 6163.7 5983.5 5999.3 6005.1 6005.5 6073.2 6163.5 6215.3 6224.9 6253.6 6258.7 5777.9 5874.3 5881.6 5899.5 5950.3 5823.9 5847.9 5861.3 5888.4 5895.2 5926.3 6106.5 6171.7 6277.9 6311.2 4249.3 4260.6 4266.4 4267.5 4303.2 5955.3 5992.3 6011.1 6024.6 6189.6 6024.0 6026.8 6033.1 6047.0 6048.7 6013.6 6025.0 6050.8 6050.8 6098.6 5695.5 5938.8 5964.5 5965.1 5976.4 6069.7 6126.8 6127.9 6129.4 6131.3 5614.2 5762.6 5813.2 5955.8 5966.1 09:38:31 INFO - PROCESS | 12196 | 09:38:31 INFO - PROCESS | 12196 | [#5] yui.html Cycles:180 Average:17953.26 Median:52721.97 stddev:24803.10 (47.0%) stddev-sans-first:24839.08 09:38:31 INFO - PROCESS | 12196 | Values: 760.9 771.4 807.2 824.6 853.7 13631.3 13639.9 13653.6 13682.0 14373.9 14289.1 14299.3 14399.0 14404.4 14453.9 837.6 843.1 845.9 847.0 853.2 830.4 832.0 834.2 844.2 845.4 883.2 887.0 888.7 893.6 895.2 878.5 879.3 881.5 882.1 882.7 645.5 646.3 649.2 650.4 653.6 11891.9 11950.5 11956.2 12004.5 12108.2 12511.7 12707.6 12997.0 13082.7 13099.9 10962.9 11128.6 11169.7 11294.0 11455.4 3752.0 3780.2 3791.0 3796.1 3899.2 47620.5 53134.0 60816.4 63965.0 64585.0 11297.7 11342.8 11360.3 11484.9 11766.2 17667.6 17686.2 17834.4 17862.4 17925.0 7688.2 7799.3 7857.6 8079.4 8304.3 4458.6 4477.4 4495.4 4598.4 4629.6 3581.2 3631.3 3647.7 3653.2 3678.6 639.8 641.8 654.6 661.1 662.9 649.4 731.0 740.7 745.1 749.8 9217.0 9345.2 9452.6 9697.2 9740.8 632.9 697.7 723.5 738.6 742.7 4502.5 4571.9 4594.4 4599.4 4624.7 88920.0 89830.0 91765.0 93873.0 98015.0 52090.7 69948.0 84456.0 84667.0 84692.6 72986.6 74534.6 74661.6 75632.6 77088.2 8901.9 8917.6 9074.1 9103.5 9174.0 50522.2 51075.0 51806.7 52687.7 52756.2 66854.3 70245.6 71095.0 72100.3 74259.6 11390.3 11510.7 11591.2 11600.2 11839.5 12114.6 12154.2 12159.0 12182.9 12272.9 11199.1 11483.5 11493.9 11498.8 11703.3 11458.8 11933.1 11959.6 12310.6 12588.7 12058.5 12107.9 12190.3 12217.8 12882.3 9336.4 9600.0 9818.2 9922.2 9968.5 10125.7 10172.1 10173.6 10220.2 10234.3 09:38:31 INFO - PROCESS | 12196 | -------- Summary: end -------- 09:38:31 INFO - PROCESS | 12196 | 09:38:32 INFO - TEST-INFO | 12196: exit 0 09:38:32 INFO - TEST-OK | dromaeo_css | took 1113126ms 09:38:32 INFO - TEST-START | kraken 09:38:32 INFO - operating with platform_type : linux_ 09:38:32 INFO - Initialising browser for kraken test... 09:38:32 INFO - TEST-INFO | started process 12565 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpukvDp7/profile http://localhost:49790/getInfo.html) 09:38:37 INFO - PROCESS | 12565 | __metrics Screen width/height:1600/1200 09:38:37 INFO - PROCESS | 12565 | colorDepth:24 09:38:37 INFO - PROCESS | 12565 | Browser inner width/height: 1024/697 09:38:37 INFO - PROCESS | 12565 | __metrics 09:38:37 ERROR - PROCESS | 12565 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 09:38:38 INFO - TEST-INFO | 12565: exit 0 09:38:38 INFO - Browser initialized. 09:38:38 INFO - Running cycle 1/1 for kraken test... 09:38:38 INFO - TEST-INFO | started process 12698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpukvDp7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:50 INFO - PROCESS | 12698 | RSS: Main: 152551424 09:38:50 INFO - PROCESS | 12698 | 09:38:52 INFO - PROCESS | 12698 | Cycle 1(1): loaded http://localhost:49790/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49790/tests/kraken/driver.html?testName=audio-beat-detection) 09:38:53 INFO - PROCESS | 12698 | RSS: Main: 157835264 09:38:53 INFO - PROCESS | 12698 | 09:38:56 INFO - PROCESS | 12698 | Cycle 1(1): loaded http://localhost:49790/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49790/tests/kraken/driver.html?testName=audio-dft) 09:38:56 INFO - PROCESS | 12698 | RSS: Main: 155676672 09:38:56 INFO - PROCESS | 12698 | 09:38:59 INFO - PROCESS | 12698 | Cycle 1(1): loaded http://localhost:49790/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49790/tests/kraken/driver.html?testName=audio-fft) 09:39:00 INFO - PROCESS | 12698 | RSS: Main: 156327936 09:39:00 INFO - PROCESS | 12698 | 09:39:02 INFO - PROCESS | 12698 | Cycle 1(1): loaded http://localhost:49790/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49790/tests/kraken/driver.html?testName=audio-oscillator) 09:39:03 INFO - PROCESS | 12698 | RSS: Main: 155504640 09:39:03 INFO - PROCESS | 12698 | 09:39:05 INFO - PROCESS | 12698 | Cycle 1(1): loaded http://localhost:49790/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49790/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:39:05 INFO - PROCESS | 12698 | RSS: Main: 155746304 09:39:05 INFO - PROCESS | 12698 | 09:39:08 INFO - PROCESS | 12698 | Cycle 1(1): loaded http://localhost:49790/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49790/tests/kraken/driver.html?testName=imaging-darkroom) 09:39:09 INFO - PROCESS | 12698 | RSS: Main: 159154176 09:39:09 INFO - PROCESS | 12698 | 09:39:12 INFO - PROCESS | 12698 | Cycle 1(1): loaded http://localhost:49790/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49790/tests/kraken/driver.html?testName=imaging-desaturate) 09:39:13 INFO - PROCESS | 12698 | RSS: Main: 159666176 09:39:13 INFO - PROCESS | 12698 | 09:39:16 INFO - PROCESS | 12698 | Cycle 1(1): loaded http://localhost:49790/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49790/tests/kraken/driver.html?testName=json-parse-financial) 09:39:16 INFO - PROCESS | 12698 | RSS: Main: 159338496 09:39:16 INFO - PROCESS | 12698 | 09:39:18 INFO - PROCESS | 12698 | Cycle 1(1): loaded http://localhost:49790/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49790/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:39:18 INFO - PROCESS | 12698 | RSS: Main: 158572544 09:39:18 INFO - PROCESS | 12698 | 09:39:20 INFO - PROCESS | 12698 | Cycle 1(1): loaded http://localhost:49790/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49790/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:39:21 INFO - PROCESS | 12698 | RSS: Main: 158449664 09:39:21 INFO - PROCESS | 12698 | 09:39:23 INFO - PROCESS | 12698 | Cycle 1(1): loaded http://localhost:49790/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49790/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:39:23 INFO - PROCESS | 12698 | RSS: Main: 158687232 09:39:23 INFO - PROCESS | 12698 | 09:39:26 INFO - PROCESS | 12698 | Cycle 1(1): loaded http://localhost:49790/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49790/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:39:27 INFO - PROCESS | 12698 | RSS: Main: 158793728 09:39:27 INFO - PROCESS | 12698 | 09:39:29 INFO - PROCESS | 12698 | Cycle 1(1): loaded http://localhost:49790/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49790/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:39:30 INFO - PROCESS | 12698 | RSS: Main: 158769152 09:39:30 INFO - PROCESS | 12698 | 09:39:32 INFO - PROCESS | 12698 | Cycle 1(1): loaded http://localhost:49790/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49790/tests/kraken/driver.html?testName=ai-astar) 09:39:32 INFO - PROCESS | 12698 | RSS: Main: 160559104 09:39:32 INFO - PROCESS | 12698 | 09:39:32 INFO - PROCESS | 12698 | __start_tp_report 09:39:32 INFO - PROCESS | 12698 | _x_x_mozilla_page_load 09:39:32 INFO - PROCESS | 12698 | _x_x_mozilla_page_load_details 09:39:32 INFO - PROCESS | 12698 | |i|pagename|runs| 09:39:32 INFO - PROCESS | 12698 | |0;ai-astar;105;111;113;112;113;113;112;112;112;114 09:39:32 INFO - PROCESS | 12698 | |1;audio-beat-detection;155;127;126;161;125;124;123;127;147;121 09:39:32 INFO - PROCESS | 12698 | |2;audio-dft;161;163;164;162;166;162;162;162;160;163 09:39:32 INFO - PROCESS | 12698 | |3;audio-fft;74;77;76;112;76;76;75;75;113;75 09:39:32 INFO - PROCESS | 12698 | |4;audio-oscillator;84;82;109;82;83;84;110;83;82;113 09:39:32 INFO - PROCESS | 12698 | |5;imaging-gaussian-blur;118;117;117;118;117;118;118;118;118;117 09:39:32 INFO - PROCESS | 12698 | |6;imaging-darkroom;148;148;146;148;148;147;147;147;148;148 09:39:32 INFO - PROCESS | 12698 | |7;imaging-desaturate;85;85;87;85;86;86;84;85;85;86 09:39:32 INFO - PROCESS | 12698 | |8;json-parse-financial;54;51;52;51;53;56;53;51;52;53 09:39:32 INFO - PROCESS | 12698 | |9;json-stringify-tinderbox;60;59;59;59;60;60;60;60;60;59 09:39:32 INFO - PROCESS | 12698 | |10;stanford-crypto-aes;76;75;76;76;76;76;78;76;76;83 09:39:32 INFO - PROCESS | 12698 | |11;stanford-crypto-ccm;134;127;129;144;150;137;126;134;166;138 09:39:32 INFO - PROCESS | 12698 | |12;stanford-crypto-pbkdf2;162;160;156;156;156;160;156;154;158;156 09:39:32 INFO - PROCESS | 12698 | |13;stanford-crypto-sha256-iterative;68;66;63;62;62;64;61;61;68;62 09:39:32 INFO - PROCESS | 12698 | __end_tp_report 09:39:32 INFO - PROCESS | 12698 | __start_cc_report 09:39:32 INFO - PROCESS | 12698 | _x_x_mozilla_cycle_collect,800 09:39:32 INFO - PROCESS | 12698 | __end_cc_report 09:39:32 INFO - PROCESS | 12698 | __startTimestamp1480441172486__endTimestamp 09:39:32 INFO - PROCESS | 12698 | 09:39:32 INFO - PROCESS | 12698 | ------- Summary: start ------- 09:39:32 INFO - PROCESS | 12698 | Number of tests: 14 09:39:32 INFO - PROCESS | 12698 | 09:39:32 INFO - PROCESS | 12698 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:2.50 (2.2%) stddev-sans-first:0.88 09:39:32 INFO - PROCESS | 12698 | Values: 105.0 111.0 113.0 112.0 113.0 113.0 112.0 112.0 112.0 114.0 09:39:32 INFO - PROCESS | 12698 | 09:39:32 INFO - PROCESS | 12698 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:127.00 stddev:14.80 (11.7%) stddev-sans-first:13.52 09:39:32 INFO - PROCESS | 12698 | Values: 155.0 127.0 126.0 161.0 125.0 124.0 123.0 127.0 147.0 121.0 09:39:32 INFO - PROCESS | 12698 | 09:39:32 INFO - PROCESS | 12698 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.65 (1.0%) stddev-sans-first:1.66 09:39:32 INFO - PROCESS | 12698 | Values: 161.0 163.0 164.0 162.0 166.0 162.0 162.0 162.0 160.0 163.0 09:39:32 INFO - PROCESS | 12698 | 09:39:32 INFO - PROCESS | 12698 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.50 stddev:15.62 (20.7%) stddev-sans-first:16.24 09:39:32 INFO - PROCESS | 12698 | Values: 74.0 77.0 76.0 112.0 76.0 76.0 75.0 75.0 113.0 75.0 09:39:32 INFO - PROCESS | 12698 | 09:39:32 INFO - PROCESS | 12698 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.50 stddev:13.49 (16.4%) stddev-sans-first:14.05 09:39:32 INFO - PROCESS | 12698 | Values: 84.0 82.0 109.0 82.0 83.0 84.0 110.0 83.0 82.0 113.0 09:39:32 INFO - PROCESS | 12698 | 09:39:32 INFO - PROCESS | 12698 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:39:32 INFO - PROCESS | 12698 | Values: 118.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 117.0 09:39:32 INFO - PROCESS | 12698 | 09:39:32 INFO - PROCESS | 12698 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 09:39:32 INFO - PROCESS | 12698 | Values: 148.0 148.0 146.0 148.0 148.0 147.0 147.0 147.0 148.0 148.0 09:39:32 INFO - PROCESS | 12698 | 09:39:32 INFO - PROCESS | 12698 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:0.84 (1.0%) stddev-sans-first:0.88 09:39:32 INFO - PROCESS | 12698 | Values: 85.0 85.0 87.0 85.0 86.0 86.0 84.0 85.0 85.0 86.0 09:39:32 INFO - PROCESS | 12698 | 09:39:32 INFO - PROCESS | 12698 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:1.58 (3.0%) stddev-sans-first:1.59 09:39:32 INFO - PROCESS | 12698 | Values: 54.0 51.0 52.0 51.0 53.0 56.0 53.0 51.0 52.0 53.0 09:39:32 INFO - PROCESS | 12698 | 09:39:32 INFO - PROCESS | 12698 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 09:39:32 INFO - PROCESS | 12698 | Values: 60.0 59.0 59.0 59.0 60.0 60.0 60.0 60.0 60.0 59.0 09:39:32 INFO - PROCESS | 12698 | 09:39:32 INFO - PROCESS | 12698 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.00 stddev:2.30 (3.0%) stddev-sans-first:2.42 09:39:32 INFO - PROCESS | 12698 | Values: 76.0 75.0 76.0 76.0 76.0 76.0 78.0 76.0 76.0 83.0 09:39:32 INFO - PROCESS | 12698 | 09:39:32 INFO - PROCESS | 12698 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:137.50 stddev:12.20 (8.9%) stddev-sans-first:12.84 09:39:32 INFO - PROCESS | 12698 | Values: 134.0 127.0 129.0 144.0 150.0 137.0 126.0 134.0 166.0 138.0 09:39:32 INFO - PROCESS | 12698 | 09:39:32 INFO - PROCESS | 12698 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:157.00 stddev:2.50 (1.6%) stddev-sans-first:2.03 09:39:32 INFO - PROCESS | 12698 | Values: 162.0 160.0 156.0 156.0 156.0 160.0 156.0 154.0 158.0 156.0 09:39:32 INFO - PROCESS | 12698 | 09:39:32 INFO - PROCESS | 12698 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:2.71 (4.3%) stddev-sans-first:2.39 09:39:32 INFO - PROCESS | 12698 | Values: 68.0 66.0 63.0 62.0 62.0 64.0 61.0 61.0 68.0 62.0 09:39:32 INFO - PROCESS | 12698 | -------- Summary: end -------- 09:39:32 INFO - PROCESS | 12698 | 09:39:33 INFO - TEST-INFO | 12698: exit 0 09:39:33 INFO - TEST-OK | kraken | took 60908ms 09:39:33 INFO - SUITE-END | took 1174s 09:39:33 INFO - Completed test suite (00:19:34) 09:39:33 INFO - javascript benchmark 09:39:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7417.141734607432, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3276.0826968448832, 3282.0810173151513, 3288.013595921223, 3302.5871766029245, 3311.834408279585, 5821.796237131696, 5843.094320380348, 5881.911771323428, 5883.705814709264, 5884.529237660988, 5787.942120578793, 5814.563907706928, 5814.883702325951, 5829.650220986744, 5858.73635686394, 5216.374035115791, 5266.947330526684, 5297.231901374298, 5305.575553955674, 5327.920081198785, 5286.735663216843, 5337.599680023995, 5337.839864804062, 5355.98236335095, 5368.677879327252, 5178.0679477694, 5180.585553155738, 5324.254604355393, 5333.759980800874, 5334.0, 5221.530062294374, 5237.240600112981, 5261.210818377236, 5280.524752772269, 5306.522412982811, 5182.0, 5218.60860435465, 5249.238860365225, 5255.08036093682, 5336.546393556552, 5825.0679891217205, 5881.264841894763, 5893.14549390336, 5919.260092488439, 5944.613600116022, 6125.845966769323, 6147.262328520562, 6169.043798211284, 6246.156768836195, 6250.499960003189, 6236.01566245803, 6307.211598550181, 6309.526785491061, 6310.495160387158, 6319.526035547352, 5706.0, 5762.250907382014, 5816.592838501307, 5847.473727364558, 5864.354920958691, 6173.59871608344, 6274.717637706314, 6299.023651334051, 6322.430981211713, 6329.398707122816, 6041.758329666764, 6070.180525629072, 6091.208142941389, 6114.633122012693, 6121.510279177655, 6088.2694076710195, 6187.628742275388, 6211.81364559064, 6215.0, 6218.31598524162, 5976.7908123215475, 6036.879262414727, 6045.183900173508, 6102.267727872683, 6119.2350956130485, 6184.5980011299125, 6214.471769899519, 6216.627002379872, 6217.409346112112, 6238.532110091761, 4730.053989202173, 4739.905201896012, 4749.145153872336, 4750.12122757291, 4781.880452988634, 4161.313383291784, 4165.354370072643, 4192.790360481964, 4208.642265407413, 4230.725002874803, 5926.67403292823, 6012.699365031731, 6022.789202377896, 6040.7583696651645, 6061.575689701678, 6037.667928263988, 6278.937210627927, 6298.685065746786, 6328.525360597973, 6337.081123237105, 5783.652980821164, 5838.94161058384, 5892.145638882424, 5910.438508341701, 5992.910106348409, 5344.225087362311, 5345.599080068932, 5359.115745901882, 5399.730013499309, 5404.351477822686, 6516.706748196248, 6517.4134327910715, 6534.509911756637, 6537.215534135934, 6539.019147127874, 6112.959454150325, 6118.771466972081, 6153.2000839890525, 6194.628322300677, 6241.157443745036, 6471.094046833353, 6477.676116194078, 6484.773032943825, 6540.607563546202, 6546.083548303337, 6161.599496032743, 6162.845928851814, 6168.321484636596, 6179.876402471836, 6183.721732522137, 6039.365866584121, 6114.847128821815, 6146.631202127886, 6198.1012753149635, 6290.465310448663, 6126.761967422209, 6128.142060111499, 6134.693265336805, 6157.784477543264, 6162.414570615784, 6072.635641861502, 6092.177556030057, 6120.418560236771, 6128.4790792783115, 6137.140800287874, 5883.294004719461, 5885.911711324419, 5902.026165682614, 5942.970285148546, 6038.064100064497, 6143.511877689543, 6212.937870621236, 6221.0, 6249.0, 6250.749970001149, 6021.638084621308, 6043.879122417615, 6060.2424696912885, 6080.331163571915, 6100.877982440237], "value": 5735.456892215758, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.0772479693264, 625.9530535209859, 662.6256165266624, 672.1900110367009, 694.5520139510013, 39330.60669393305, 43291.78354108229, 43302.0, 43345.0, 43565.0, 43013.0, 43310.35034474485, 43532.3470147948, 43670.0, 43878.561214387926, 8601.182887625697, 8710.47737135774, 8751.693690720826, 8761.737147885542, 8804.0, 8618.224359807617, 8680.56597170142, 8687.782805429852, 8747.037825839152, 8754.6935857245, 8700.738977830675, 8771.736847894574, 8772.298216142724, 8775.605097770616, 8798.340124490656, 8582.914170858305, 8674.86987695185, 8688.0, 8751.0, 8759.299256059563, 8694.130586941319, 8702.434341767828, 8715.477071375737, 8768.123187681245, 8770.254528365096, 40675.59324406777, 40692.389614155814, 40709.1858162838, 40993.79503102465, 41082.79458602718, 3696.4270538066376, 3802.2205447883116, 3850.614938506155, 4066.247744167309, 4147.066909945268, 32439.83780081108, 32626.6737332626, 32946.50580241298, 32953.835230823934, 33072.50391244133, 4322.200392927319, 4393.78031098447, 4452.0873220989615, 4463.843765468193, 4530.8867278317975, 344478.0, 346267.0, 346540.0, 347526.0, 348657.99999999744, 58012.12981805277, 58121.128183077286, 58253.0, 58462.0, 58508.122378164364, 61722.69138654278, 61926.38073619206, 61942.38057619456, 61971.38028619656, 62274.82038128644, 17018.574535636708, 17267.222974966156, 17391.217395217245, 17406.0426676534, 17427.302907883797, 13437.126586771828, 13456.192628442324, 13531.864681353258, 13560.45758169662, 13566.796498052538, 15275.465358712392, 15979.840201598068, 16097.678046439005, 16097.919510402373, 16151.596210094607, 6516.315786842408, 6590.7693230736695, 6611.834704132339, 6711.590565981199, 7007.754728584475, 964.8903760675139, 1152.2337645465839, 1162.3839365136491, 1201.4173126033866, 1208.4109396144042, 31984.680153198635, 32086.35827283441, 32403.35193296121, 33167.66832331694, 33424.0, 1099.1316859680762, 1113.2763703592568, 1141.6175581180232, 1159.7274640459486, 1177.0995188680665, 16984.49046528606, 17086.231119599648, 17397.391091311743, 17459.65080698379, 17502.82497175012, 481921.0, 481972.0, 482828.0, 485355.0, 488183.0, 58659.0, 58702.412975869694, 58774.70612646909, 58849.0, 58923.82152357014, 1372.4373007067254, 1392.4291040673274, 1411.865872742088, 1411.9223442710545, 1422.239102080382, 31111.222219444695, 32274.193145171557, 33010.66989330076, 33015.50476742803, 33387.0, 50216.24675629941, 50817.49182508128, 50851.47445576639, 51045.0, 51146.232806507185, 437956.0, 438486.0, 440567.0, 441991.0, 444144.0, 40953.79523102365, 41474.585254147074, 41589.0, 41769.0, 42854.0, 47409.762951185025, 47674.76162619165, 47769.76115119402, 49168.50831491639, 49277.26084108813, 40082.19013718372, 42009.78995105127, 42084.57915420806, 42510.1497970045, 42746.358804618576, 40203.59796401999, 41138.38292425556, 41583.37624935689, 42686.78656606697, 42795.0, 41590.58409415988, 41655.1668966625, 41706.0, 41744.582554175286, 43454.0, 34519.4822077674, 36302.0, 36735.448968266035, 36838.26323473462, 37063.0, 28483.28791780222, 28636.0, 28747.425051498434, 28778.856105719336, 28881.42237155287], "value": 20418.7720654824, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.65457706372496, 404.06257482640285, 428.43874524373075, 429.74000729558617, 438.2790309940149, 18588.907055464722, 19175.32886348978, 19209.71185432218, 19350.225990960345, 20072.297469588568, 19704.60590788187, 20178.59642807143, 20304.695429568532, 20321.085551150234, 20776.8961155194, 5463.235147079412, 6043.728032238538, 6060.818175454721, 6078.240219972504, 6099.756009759604, 5777.42225777421, 5936.673482958436, 5983.970080149593, 6012.3085845127935, 6032.66820324882, 5920.644761314314, 5930.169776231331, 5940.04959206527, 5961.761529538813, 5967.671778052206, 5712.257406537145, 5927.0, 5953.077273022688, 5959.165716799652, 5968.582199246054, 5425.403205647375, 5430.972845135749, 5437.184422336642, 5438.483344082306, 5478.315210598676, 14720.558383248519, 20443.38669839907, 21638.891805540872, 23897.163599274118, 24047.15834945786, 2223.132978138527, 2541.5552278351215, 2562.410645551515, 3006.8573941901936, 3084.8766049358, 10699.946500267526, 11052.613158539412, 11142.220044596881, 11397.487113079931, 11709.590164344207, 1995.0, 2045.3761602711168, 2078.6050650376533, 2103.9368818935304, 2113.323736404351, 89302.55348723214, 89718.0, 91332.0, 92016.0, 92854.5357273216, 11222.270552414067, 12065.457054432572, 12205.0, 12395.62813115608, 12962.28707421082, 15179.468718594797, 15261.313240904186, 15322.310496027705, 15375.538733838002, 15477.303521341566, 8186.345092392594, 8282.674772036446, 8301.709440169565, 8492.0, 8525.914740852637, 7927.405444591679, 8129.170936539232, 8134.437652139557, 8248.8350232995, 8457.83084338322, 4330.805113769888, 4390.07808360248, 4392.945693033713, 4472.709273897186, 4680.648951328664, 1969.812867777559, 2013.1242909334487, 2023.6559784836613, 2027.635025695389, 2122.204173434962, 909.6179604566098, 934.8213485718826, 976.916962058233, 1017.8524114003428, 1025.917926565873, 19662.410127696192, 20019.699704504445, 20271.29050483226, 20291.695624565644, 20366.0, 1004.2417974429259, 1007.6825799873017, 1009.1724785675675, 1015.4059874973224, 1020.7805321855836, 11170.664880053611, 11334.60328888485, 11402.885971140347, 11461.197716159955, 11514.56067991501, 478788.0, 482513.0, 487809.0, 489167.0, 491212.0, 53790.19314710282, 58151.41848581545, 69667.65166174137, 96876.51561742146, 101421.99999999853, 1011.4184344002081, 1020.0564477857952, 1033.5245786938092, 1039.2309690828884, 1052.563186277686, 17691.911540442215, 18093.90953045279, 18164.0, 18308.359207427675, 18415.53961150982, 31561.684383156793, 38067.42898856575, 41451.37822932598, 43030.56969430391, 44721.77639111783, 59075.0, 61047.08429373474, 61176.082358763764, 61512.38487615067, 64924.675376622814, 8478.364122690946, 8741.650333986569, 8776.780580485283, 8886.111388861062, 8894.42186257891, 12863.935680321538, 13552.661183470493, 13699.863001369858, 13777.655558611115, 13856.237906915216, 11266.549338026714, 11331.603393881174, 11381.943090284496, 11493.82759258595, 11518.712032198926, 11726.530938762355, 11787.646370608896, 11841.940790296338, 12013.579524716943, 12209.938950305192, 11123.944380278046, 11669.183157178915, 11945.940270298594, 12206.81689774672, 12210.6947326314, 8507.361947854059, 8520.062793092631, 8729.912700873165, 9021.729348119567, 9315.906840931504, 10224.64213752515, 11747.88252117502, 11896.524139034342, 12254.4485498151, 12285.078619103782], "value": 9414.781540032765, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1525.0, 1540.9383624655015, 1656.4947690954255, 1780.6883795335814, 1784.1525275494141, 7876.133625301212, 8157.306628936548, 8648.308135349173, 9126.543672816366, 9182.219511341544, 8609.827803443928, 8851.203391694746, 8861.468311901273, 9072.773180670487, 9142.314326425512, 2435.330284171849, 2463.9260822175365, 2466.5683505386573, 2468.049800826686, 2469.1975108089855, 2427.490227052321, 2473.4558397152596, 2496.4383013821835, 2500.949981000379, 2513.183215454975, 2419.721732000825, 2430.3802530354824, 2459.5449841779237, 2461.7661322174363, 2483.3667414809197, 2355.9764402356013, 2376.5959786836193, 2407.265783935899, 2420.862194768456, 2436.3543660929868, 2391.7129944406784, 2410.301012706313, 2417.504411595619, 2421.782039616425, 2423.9757602423924, 8978.775530611721, 9030.367874248805, 9061.954690226572, 9162.541872906328, 9198.724038278862, 5458.426865179139, 5596.524295434893, 5600.383957764642, 5601.915971260434, 5607.57943154261, 3571.4464258040043, 3576.2489877125836, 3587.802670853102, 3603.40543810271, 3709.7959612221316, 1161.2277835239556, 1171.279663007253, 1181.8417950408561, 1196.9640910772691, 1229.858566264882, 12559.748805023939, 12615.116941814076, 12690.492380304777, 12719.936400318033, 12756.362181890869, 4704.954658956448, 4790.185668436374, 4808.0, 4852.126617208865, 4884.340614017134, 10483.47582620881, 10507.684769456928, 10527.420991845522, 10532.526036328383, 10561.947190264153, 5508.641938274, 5529.861753456195, 5538.224648549206, 5540.584456165723, 5559.277293951841, 4927.901441971212, 4957.876053098701, 5083.161278389024, 5142.97428512855, 5182.455842136596, 4039.8384064637085, 4070.2673518766314, 4130.091379896418, 4165.500139983222, 4186.853460128942, 1248.9125761196628, 1259.5465632372338, 1275.3686924972199, 1276.712739633575, 1287.2855565161237, 839.2488722593367, 961.293449314753, 1015.939043657383, 1028.9691309260734, 1029.4029462911494, 6124.0, 6174.938250617436, 6232.844178895564, 6278.6546739929745, 6432.871342573216, 455.11025944278856, 460.08672784522696, 465.50191295313687, 471.16603611607263, 471.76176031104075, 4047.9595204048173, 4149.33610622299, 4229.598188172119, 4253.957460425418, 4263.637590804817, 11045.889541104647, 11412.42937853104, 11415.37215453158, 11422.543098276143, 11430.485628146753, 11211.495482703298, 11231.157663175294, 11258.043066339453, 11263.549458021751, 11280.943595281971, 8135.7152499662225, 8438.662453501915, 8483.236508714246, 8549.957250213709, 8630.568471576396, 6207.410296021871, 6273.592216505913, 6433.131527243762, 6468.676566171766, 6601.966990165019, 10228.335158214692, 10346.948265258625, 10430.165586753194, 10532.21008424356, 10569.471526423495, 10206.6427675034, 10402.947985260025, 10434.321769084985, 10529.57881684724, 10592.947035265082, 7896.249856263646, 7978.680852765824, 8043.6782528698195, 8067.112617611941, 8097.959510202411, 8751.868721969304, 8799.692010779592, 8821.0, 8846.513441760764, 8895.0, 7796.688132474637, 7861.213878612093, 7913.643886025257, 7919.84160316802, 7955.5226686399, 7821.491603045783, 7839.725609603636, 7841.255080767318, 7860.253275938777, 8038.718644847402, 7234.819129521594, 7269.345758881726, 7409.481336306622, 7453.329200371993, 7488.925110748823, 5415.891682166413, 5426.240326354393, 5451.1005684063275, 5480.150576660624, 5585.1901474286815, 5651.095824668198, 5679.744411501575, 5686.374498805046, 5698.544116470755, 5876.44173803488], "value": 4733.797045674905, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.4885841101198, 361.36039210597244, 363.5237838431654, 370.28029126069015, 370.6330732574752, 5618.0449323614985, 5703.317521331207, 5735.512481439077, 5837.970810145954, 5838.737256823442, 5423.403425623178, 5534.169874518824, 5609.5231905288, 5616.494515493605, 5619.269494965649, 4496.460424749034, 4506.819727210924, 4511.165434394639, 4526.321051842234, 4532.5694059064335, 4220.894477638053, 4438.201123797715, 4448.733076015449, 4522.592966633002, 4552.453705555321, 4406.347619642634, 4421.336799480072, 4424.716832118682, 4430.42719834459, 4437.469073169751, 4412.903870661442, 4415.757133357664, 4435.401220835178, 4449.710768800018, 4464.665150113755, 3819.9045023874346, 3911.2177564487215, 3932.233214523169, 3951.9012024699323, 3955.208958208341, 5542.251796007527, 5543.861403464905, 5551.639848237167, 5568.331800184003, 5584.21820945068, 5113.130767769489, 5122.795088196468, 5127.974360128175, 5128.794848206067, 5135.948640513584, 5746.655200687972, 5863.4722874941035, 5902.32123305821, 5957.599964008455, 5970.940290597082, 4197.580241975808, 4199.307114326163, 4202.915941681149, 4218.261804184286, 4223.345381465878, 6170.290416602058, 6221.315655277871, 6249.187865460561, 6250.0, 6274.152989346426, 4278.037441575683, 4316.0, 4362.298703505636, 4401.097774956126, 4416.867493975186, 4416.867493975186, 4429.379886815848, 4430.269005614102, 4433.556644335541, 4436.511983681792, 5082.237664350303, 5095.898082038412, 5100.719460429637, 5100.821471248489, 5110.693358398508, 5672.432756724294, 5812.82561523155, 5975.850603734942, 5988.550858685616, 6010.398960103955, 1475.4393330534328, 1485.9331330090172, 1486.3682934752687, 1489.9851001490063, 1506.9397224111133, 958.3387462650749, 1018.5671089786811, 1019.2559431614962, 1036.3108532825586, 1039.0544604409952, 5499.340079190522, 5545.72271386429, 5551.723103686175, 5600.52395546375, 5684.261046063985, 5883.705814709333, 5966.820995370146, 5967.910481342783, 6032.728527216286, 6105.603135796159, 5506.669599824023, 5532.585056120807, 5580.0, 5615.8596035098635, 5685.204071430003, 3159.76301777363, 3165.7942233754734, 3170.6670799565713, 3180.7296379807976, 3183.8248896310924, 5904.546968439206, 6000.819975400745, 6124.601900876429, 6144.539159563051, 6163.722632481549, 5983.491403230774, 5999.250093738283, 6005.129256257906, 6005.459508644243, 6073.210482637317, 6163.506919446433, 6215.34738852423, 6224.906626400517, 6253.561680813438, 6258.718357673824, 5777.8555536111935, 5874.295084589877, 5881.617694849821, 5899.4985426239255, 5950.256217972754, 5823.912641310469, 5847.94152058491, 5861.267341582302, 5888.440598143169, 5895.233619629421, 5926.288845338587, 6106.45041946227, 6171.728983638679, 6277.874442511033, 6311.24265088174, 4249.298865687127, 4260.595243451867, 4266.360045993126, 4267.50923643785, 4303.203907277164, 5955.285365756137, 5992.340842507408, 6011.098335249748, 6024.61433870221, 6189.597676151036, 6023.969880150571, 6026.849328766641, 6033.125196846345, 6046.969765151146, 6048.667323297085, 6013.579049466671, 6025.0359942409, 6050.788222412194, 6050.848728781815, 6098.627808742997, 5695.487406133468, 5938.821835344774, 5964.538688021463, 5965.135055417027, 5976.402359763989, 6069.666168360783, 6126.785562505291, 6127.877442451215, 6129.387061294014, 6131.264248290234, 5614.214010038516, 5762.596618236683, 5813.180607405489, 5955.761769529344, 5966.105084237399], "value": 4521.539770583887, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.9460302991274, 771.4175797273059, 807.1928071928072, 824.6247957179484, 853.7310747114662, 13631.318434078294, 13639.863601363983, 13653.590392288248, 13682.042257042023, 14373.856261437382, 14289.142651440921, 14299.285035748224, 14399.0, 14404.351804168811, 14453.855461445382, 837.5644664774313, 843.0515669871395, 845.9323254139684, 847.0132295875297, 853.2235665544356, 830.3564737328559, 832.0389949608212, 834.228338786623, 844.1727107434717, 845.4208866926175, 883.1742320929919, 887.0287035695935, 888.7467071884514, 893.6202114101513, 895.2256298301954, 878.5343767803074, 879.2877769007092, 881.4799268431624, 882.0870399136894, 882.7219425880827, 645.4513663386131, 646.321362569305, 649.1917562634503, 650.3593959949446, 653.6470306034736, 11891.94054029733, 11950.462229199708, 11956.222845515014, 12004.459799309052, 12108.21296615717, 12511.687207819787, 12707.618771436872, 12997.0, 13082.738345233138, 13099.934500327532, 10962.890371096266, 11128.554857805679, 11169.72075698106, 11294.0, 11455.427228638619, 3751.9812400938094, 3780.2439512097417, 3790.962090379116, 3796.0889386547306, 3899.181171953893, 47620.52379476195, 53134.0, 60816.391836081515, 63965.0, 64585.0, 11297.71755706114, 11342.829857552144, 11360.261582997078, 11484.94257528707, 11766.235194712317, 17667.55831104233, 17686.204120814593, 17834.37579684705, 17862.374816881347, 17925.0, 7688.192739762357, 7799.33705635016, 7857.646405911748, 8079.394045446615, 8304.335653147733, 4458.598726114666, 4477.350784136282, 4495.393121928498, 4598.425196850394, 4629.583337499641, 3581.1763294442426, 3631.3100510902846, 3647.744657873923, 3653.159773252167, 3678.5953545110015, 639.8272466434037, 641.8395401149712, 654.5908806995627, 661.1273119482237, 662.920449546048, 649.4155260265704, 730.9634518274065, 740.6926125657792, 745.1282000059942, 749.7863109014014, 9217.0, 9345.20565751905, 9452.621895124117, 9697.224222062217, 9740.75648108803, 632.8797528469576, 697.6616341074575, 723.5405517496323, 738.6284876928286, 742.7289039500544, 4502.459704835441, 4571.885702857388, 4594.356790049395, 4599.448066232074, 4624.745638989821, 88920.0, 89830.0, 91765.0, 93873.0, 98015.0, 52090.739546302786, 69948.0, 84456.0, 84667.0, 84692.57653711693, 72986.63506682432, 74534.62732686411, 74661.62669186728, 75632.62183689156, 77088.22911770923, 8901.910980890367, 8917.55412229373, 9074.137956894085, 9103.544822758968, 9174.0, 50522.24216636827, 51074.97850043052, 51806.740966296435, 52687.736561316946, 52756.20865686941, 66854.33145668481, 70245.64877175786, 71095.0, 72100.27899720936, 74259.62870185614, 11390.25963312382, 11510.654680359603, 11591.18861679708, 11600.245984011011, 11839.526418943145, 12114.636560903187, 12154.209976351509, 12159.0, 12182.939085304517, 12272.877271227531, 11199.10407167441, 11483.540658373571, 11493.942530287295, 11498.82751758741, 11703.2978021319, 11458.82811757841, 11933.105017123924, 11959.581414650445, 12310.569130080405, 12588.748225035264, 12058.51765929388, 12107.878921210675, 12190.268583884996, 12217.816732749194, 12882.291473969022, 9336.439813611205, 9599.952000239955, 9818.16545593604, 9922.156616687662, 9968.451735154345, 10125.696229113139, 10172.08451239392, 10173.643922462677, 10220.182385409298, 10234.283600148216], "value": 7054.633292849361, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1481.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 113.0, 112.0, 113.0, 113.0, 112.0, 112.0, 112.0, 114.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 126.0, 161.0, 125.0, 124.0, 123.0, 127.0, 147.0, 121.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 164.0, 162.0, 166.0, 162.0, 162.0, 162.0, 160.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 112.0, 76.0, 76.0, 75.0, 75.0, 113.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 109.0, 82.0, 83.0, 84.0, 110.0, 83.0, 82.0, 113.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 87.0, 85.0, 86.0, 86.0, 84.0, 85.0, 85.0, 86.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 52.0, 51.0, 53.0, 56.0, 53.0, 51.0, 52.0, 53.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 76.0, 76.0, 76.0, 78.0, 76.0, 76.0, 83.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 127.0, 129.0, 144.0, 150.0, 137.0, 126.0, 134.0, 166.0, 138.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 156.0, 156.0, 156.0, 160.0, 156.0, 154.0, 158.0, 156.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 63.0, 62.0, 62.0, 64.0, 61.0, 61.0, 68.0, 62.0], "value": 63.7, "unit": "score"}]}]} 09:39:33 INFO - Return code: 0 09:39:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:39:33 ERROR - # TBPL SUCCESS # 09:39:33 INFO - Running post-action listener: _resource_record_post_action 09:39:33 INFO - [mozharness: 2016-11-29 17:39:33.788071Z] Finished run-tests step (success) 09:39:33 INFO - Running post-run listener: _resource_record_post_run 09:39:33 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 371478528; Read time: 8; Write time: 225748 09:39:33 INFO - TinderboxPrint: CPU usage
13.3% 09:39:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:39:33 INFO - TinderboxPrint: I/O write bytes / time
371,478,528 / 225,748 09:39:33 INFO - TinderboxPrint: CPU idle
8,226.2 (86.6%) 09:39:33 INFO - TinderboxPrint: CPU user
1,210.7 (12.8%) 09:39:33 INFO - TinderboxPrint: Swap in / out
0 / 0 09:39:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124256256; Read time: 0; Write time: 74192 09:39:33 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 246661120; Read time: 0; Write time: 151528 09:39:34 INFO - Running post-run listener: _upload_blobber_files 09:39:34 INFO - Blob upload gear active. 09:39:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:39:34 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 09:39:34 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:39:34 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:39:34 INFO - (blobuploader) - INFO - Open directory for files ... 09:39:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:39:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:39:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:35 INFO - (blobuploader) - INFO - Done attempting. 09:39:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:39:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:39:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:36 INFO - (blobuploader) - INFO - Done attempting. 09:39:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:39:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:39:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:39 INFO - (blobuploader) - INFO - Done attempting. 09:39:39 INFO - (blobuploader) - INFO - Iteration through files over. 09:39:39 INFO - Return code: 0 09:39:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:39:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:39:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d31b732e2f0f5777a975475d8bd38f64fa3c15c34e82dce7649bbe24df6af4934ed9af0af05f356158906ba4ace2e0b5b2109e3f0f3ebfa57e6105654c90a735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f54ddfa2739f69ebf936127230c77e076951ca8c49a59fc230d2f45e42579303053993dd6c19ee89789ec891e21f5f79042278bd55356ba3ac2699cfbf139499", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49222b6a2f811aa9dd2060d923c8eb736b752add7e0bf68025d8f8772bbe3d0b0b4f27bbb797b7a13d4de31dda6d23921c8d13c013d3276ef07c21615557e39a"} 09:39:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:39:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:39:39 INFO - Contents: 09:39:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d31b732e2f0f5777a975475d8bd38f64fa3c15c34e82dce7649bbe24df6af4934ed9af0af05f356158906ba4ace2e0b5b2109e3f0f3ebfa57e6105654c90a735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f54ddfa2739f69ebf936127230c77e076951ca8c49a59fc230d2f45e42579303053993dd6c19ee89789ec891e21f5f79042278bd55356ba3ac2699cfbf139499", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49222b6a2f811aa9dd2060d923c8eb736b752add7e0bf68025d8f8772bbe3d0b0b4f27bbb797b7a13d4de31dda6d23921c8d13c013d3276ef07c21615557e39a"} 09:39:39 INFO - Running post-run listener: copy_logs_to_upload_dir 09:39:39 INFO - Copying logs to upload dir... 09:39:39 INFO - mkdir: /builds/slave/test/build/upload/logs 09:39:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.103282 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-29 09:39:39.749018) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 09:39:39.753057) ========= 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=c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693 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/Mozilla-Aurora/sha512/d31b732e2f0f5777a975475d8bd38f64fa3c15c34e82dce7649bbe24df6af4934ed9af0af05f356158906ba4ace2e0b5b2109e3f0f3ebfa57e6105654c90a735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f54ddfa2739f69ebf936127230c77e076951ca8c49a59fc230d2f45e42579303053993dd6c19ee89789ec891e21f5f79042278bd55356ba3ac2699cfbf139499", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49222b6a2f811aa9dd2060d923c8eb736b752add7e0bf68025d8f8772bbe3d0b0b4f27bbb797b7a13d4de31dda6d23921c8d13c013d3276ef07c21615557e39a"} build_url:https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d31b732e2f0f5777a975475d8bd38f64fa3c15c34e82dce7649bbe24df6af4934ed9af0af05f356158906ba4ace2e0b5b2109e3f0f3ebfa57e6105654c90a735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f54ddfa2739f69ebf936127230c77e076951ca8c49a59fc230d2f45e42579303053993dd6c19ee89789ec891e21f5f79042278bd55356ba3ac2699cfbf139499", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49222b6a2f811aa9dd2060d923c8eb736b752add7e0bf68025d8f8772bbe3d0b0b4f27bbb797b7a13d4de31dda6d23921c8d13c013d3276ef07c21615557e39a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 09:39:39.778226) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:39:39.778550) ========= 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=c6927cf182745ad25b1d38b9000001fe-1480433553.944649-762545693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:39:39.863668) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 09:39:39.863997) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 09:39:39.864486) ========= ========= Total master_lag: 0.17 =========