builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1485233047.41 results: success (0) buildid: 20170123180844 builduid: f90ba4415511428290bded78e98d4bd8 revision: 748ca6ea965cd7287affab431369809c751b462e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 20:44:07.414057) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 20:44:07.414497) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 20:44:07.414771) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 20:44:07.429642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:44:07.429981) ========= 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=df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-23 20:44:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2017-01-23 20:44:07 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.079827 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:44:07.525802) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:44:07.526355) ========= 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=df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015912 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:44:07.577019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:44:07.577391) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 748ca6ea965cd7287affab431369809c751b462e --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-beta --rev 748ca6ea965cd7287affab431369809c751b462e --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=df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-23 20:44:07,921 truncating revision to first 12 chars 2017-01-23 20:44:07,921 Setting DEBUG logging. 2017-01-23 20:44:07,921 attempt 1/10 2017-01-23 20:44:07,921 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/748ca6ea965c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-23 20:44:08,239 unpacking tar archive at: mozilla-beta-748ca6ea965c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654416 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:44:08.245224) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 20:44:08.245535) ========= script_repo_revision: 748ca6ea965cd7287affab431369809c751b462e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 20:44:08.245937) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 20:44:08.246206) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 20:44:08.256544) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-23 20:44:08.257234) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:44:08 INFO - MultiFileLogger online at 20170123 20:44:08 in /builds/slave/test 20:44:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 20:44:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:44:08 INFO - {'append_to_log': False, 20:44:08 INFO - 'base_work_dir': '/builds/slave/test', 20:44:08 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:44:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:44:08 INFO - 'branch': 'Mozilla-Beta', 20:44:08 INFO - 'buildbot_json_path': 'buildprops.json', 20:44:08 INFO - 'config_files': ('talos/linux_config.py',), 20:44:08 INFO - 'default_actions': ('clobber', 20:44:08 INFO - 'read-buildbot-config', 20:44:08 INFO - 'download-and-extract', 20:44:08 INFO - 'populate-webroot', 20:44:08 INFO - 'create-virtualenv', 20:44:08 INFO - 'install', 20:44:08 INFO - 'run-tests'), 20:44:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:44:08 INFO - 'download_minidump_stackwalk': True, 20:44:08 INFO - 'download_symbols': 'ondemand', 20:44:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:44:08 INFO - 'tooltool.py': '/tools/tooltool.py', 20:44:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:44:08 INFO - '/tools/misc-python/virtualenv.py')}, 20:44:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:44:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:44:08 INFO - 'installer_path': 'installer.exe', 20:44:08 INFO - 'log_level': 'info', 20:44:08 INFO - 'log_name': 'talos', 20:44:08 INFO - 'log_to_console': True, 20:44:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:44:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:44:08 INFO - 'opt_config_files': (), 20:44:08 INFO - 'pip_index': False, 20:44:08 INFO - 'sps_profile': False, 20:44:08 INFO - 'sps_profile_interval': 0, 20:44:08 INFO - 'suite': 'dromaeojs-e10s', 20:44:08 INFO - 'system_bits': '32', 20:44:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:44:08 INFO - 'title': 'talos-linux64-ix-021', 20:44:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:44:08 INFO - 'use_talos_json': True, 20:44:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:44:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:44:08 INFO - 'work_dir': 'build'} 20:44:08 INFO - [mozharness: 2017-01-24 04:44:08.705080Z] Running clobber step. 20:44:08 INFO - Running pre-action listener: _resource_record_pre_action 20:44:08 INFO - Running main action method: clobber 20:44:08 INFO - rmtree: /builds/slave/test/build 20:44:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:44:09 INFO - Running post-action listener: _resource_record_post_action 20:44:09 INFO - [mozharness: 2017-01-24 04:44:09.204583Z] Finished clobber step (success) 20:44:09 INFO - [mozharness: 2017-01-24 04:44:09.204683Z] Running read-buildbot-config step. 20:44:09 INFO - Running pre-action listener: _resource_record_pre_action 20:44:09 INFO - Running main action method: read_buildbot_config 20:44:09 INFO - Using buildbot properties: 20:44:09 INFO - { 20:44:09 INFO - "project": "", 20:44:09 INFO - "product": "firefox", 20:44:09 INFO - "script_repo_revision": "production", 20:44:09 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 20:44:09 INFO - "repository": "", 20:44:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 20:44:09 INFO - "buildid": "20170123180844", 20:44:09 INFO - "pgo_build": "True", 20:44:09 INFO - "basedir": "/builds/slave/test", 20:44:09 INFO - "buildnumber": 45, 20:44:09 INFO - "slavename": "talos-linux64-ix-021", 20:44:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:44:09 INFO - "platform": "ubuntu64_hw", 20:44:09 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 20:44:09 INFO - "branch": "mozilla-beta", 20:44:09 INFO - "repo_path": "releases/mozilla-beta", 20:44:09 INFO - "revision": "748ca6ea965cd7287affab431369809c751b462e", 20:44:09 INFO - "stage_platform": "linux64-pgo", 20:44:09 INFO - "builduid": "f90ba4415511428290bded78e98d4bd8", 20:44:09 INFO - "slavebuilddir": "test" 20:44:09 INFO - } 20:44:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 20:44:09 INFO - Running post-action listener: _resource_record_post_action 20:44:09 INFO - [mozharness: 2017-01-24 04:44:09.207149Z] Finished read-buildbot-config step (success) 20:44:09 INFO - [mozharness: 2017-01-24 04:44:09.207237Z] Running download-and-extract step. 20:44:09 INFO - Running pre-action listener: _resource_record_pre_action 20:44:09 INFO - Running main action method: download_and_extract 20:44:09 INFO - mkdir: /builds/slave/test/build/tests 20:44:09 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')]} 20:44:09 INFO - trying https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 20:44:09 INFO - Downloading https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 20:44:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:44:09 INFO - Downloaded 1327 bytes. 20:44:09 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 20:44:09 INFO - Using the following test package requirements: 20:44:09 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 20:44:09 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:44:09 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 20:44:09 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:44:09 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 20:44:09 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:44:09 INFO - u'jsshell-linux-x86_64.zip'], 20:44:09 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:44:09 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 20:44:09 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 20:44:09 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:44:09 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 20:44:09 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:44:09 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 20:44:09 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:44:09 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 20:44:09 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:44:09 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 20:44:09 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:44:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 20:44:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:44:09 INFO - Fetch https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 20:44:10 INFO - Http code: 200 20:44:10 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 20:44:10 INFO - x-amz-cf-id: geHYqVKlRlnVea82yb3X4ByB-A7hrD349pLUvlEWKJ88eL5ADMBUSg== 20:44:10 INFO - x-amz-version-id: EZ2lmPuKuIukChNhS3KTLKtbeaCCh5Aw 20:44:11 INFO - Expected file size: 21950205 20:44:11 INFO - Obtained file size: 21950205 20:44:15 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:44:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 20:44:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:44:15 INFO - Fetch https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 20:44:16 INFO - Http code: 200 20:44:16 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 20:44:16 INFO - x-amz-cf-id: y_GFPwyZZLFRcBK2n9ooYHBFE-udv75pRb4htRNFnDpHYFqmJPUMxA== 20:44:16 INFO - x-amz-version-id: EZ2lmPuKuIukChNhS3KTLKtbeaCCh5Aw 20:44:16 INFO - Expected file size: 21950205 20:44:16 INFO - Obtained file size: 21950205 20:44:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 20:44:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:44:21 INFO - Fetch https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 20:44:21 INFO - Http code: 200 20:44:21 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 20:44:21 INFO - x-amz-cf-id: j0J37gQM5-XGUv5MURvBlyH9SeCsQbBLzAZ5XGtXFVkN20WptQli-A== 20:44:21 INFO - x-amz-version-id: ZVYgZ2kHxTmINYN3mGtQanHeNhKzsFN0 20:44:22 INFO - Expected file size: 14402992 20:44:22 INFO - Obtained file size: 14402992 20:44: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')]} 20:44:23 INFO - trying https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 20:44:23 INFO - Downloading https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 20:44:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:44:25 INFO - Downloaded 57687235 bytes. 20:44:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 20:44:25 INFO - mkdir: /builds/slave/test/properties 20:44:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:44:25 INFO - Writing to file /builds/slave/test/properties/build_url 20:44:25 INFO - Contents: 20:44:25 INFO - build_url:https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 20:44:26 INFO - Running post-action listener: _resource_record_post_action 20:44:26 INFO - Running post-action listener: set_extra_try_arguments 20:44:26 INFO - [mozharness: 2017-01-24 04:44:26.086083Z] Finished download-and-extract step (success) 20:44:26 INFO - [mozharness: 2017-01-24 04:44:26.086310Z] Running populate-webroot step. 20:44:26 INFO - Running pre-action listener: _resource_record_pre_action 20:44:26 INFO - Running main action method: populate_webroot 20:44:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:44:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:44:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:44:26 INFO - '--tppagecycles', 20:44:26 INFO - '7'], 20:44:26 INFO - 'tests': ['tsvgm']}}, 20:44:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:44:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:44:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:44:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:44:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:44:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:44:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:44:26 INFO - 'talos_options': ['--disable-e10s'], 20:44:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:44:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:44:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:44:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:44:26 INFO - 'talos_options': ['--disable-e10s'], 20:44:26 INFO - 'tests': ['damp', 'tps']}, 20:44:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:44:26 INFO - 'tests': ['damp', 'tps']}, 20:44:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:44:26 INFO - 'tests': ['dromaeo_dom']}, 20:44:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:44:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:44:26 INFO - 'tests': ['basic_compositor_video']}, 20:44:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:44:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:44:26 INFO - 'tests': ['a11yr', 20:44:26 INFO - 'ts_paint', 20:44:26 INFO - 'tpaint', 20:44:26 INFO - 'sessionrestore', 20:44:26 INFO - 'sessionrestore_no_auto_restore', 20:44:26 INFO - 'tabpaint']}, 20:44:26 INFO - 'other-e10s': {'tests': ['a11yr', 20:44:26 INFO - 'ts_paint', 20:44:26 INFO - 'tpaint', 20:44:26 INFO - 'sessionrestore', 20:44:26 INFO - 'sessionrestore_no_auto_restore', 20:44:26 INFO - 'tabpaint']}, 20:44:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:44:26 INFO - 'ts_paint', 20:44:26 INFO - 'tpaint', 20:44:26 INFO - 'sessionrestore', 20:44:26 INFO - 'sessionrestore_no_auto_restore', 20:44:26 INFO - 'tabpaint']}, 20:44:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:44:26 INFO - 'ts_paint', 20:44:26 INFO - 'tpaint', 20:44:26 INFO - 'sessionrestore', 20:44:26 INFO - 'sessionrestore_no_auto_restore', 20:44:26 INFO - 'tabpaint']}, 20:44:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:44:26 INFO - 'tests': ['a11yr', 20:44:26 INFO - 'ts_paint', 20:44:26 INFO - 'tpaint', 20:44:26 INFO - 'sessionrestore', 20:44:26 INFO - 'sessionrestore_no_auto_restore', 20:44:26 INFO - 'tabpaint']}, 20:44:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:44:26 INFO - 'tests': ['a11yr', 20:44:26 INFO - 'ts_paint', 20:44:26 INFO - 'tpaint', 20:44:26 INFO - 'sessionrestore', 20:44:26 INFO - 'sessionrestore_no_auto_restore', 20:44:26 INFO - 'tabpaint']}, 20:44:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:44:26 INFO - 'tests': ['tsvgx', 20:44:26 INFO - 'tsvgr_opacity', 20:44:26 INFO - 'tart', 20:44:26 INFO - 'tscrollx', 20:44:26 INFO - 'cart']}, 20:44:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:44:26 INFO - 'tsvgr_opacity', 20:44:26 INFO - 'tart', 20:44:26 INFO - 'tscrollx', 20:44:26 INFO - 'cart']}, 20:44:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:44:26 INFO - 'talos_options': ['--disable-e10s'], 20:44:26 INFO - 'tests': ['tp5o']}, 20:44:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:44:26 INFO - 'tests': ['tp5o']}, 20:44:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:44:26 INFO - 'talos_options': ['--disable-e10s', 20:44:26 INFO - '--xperf_path', 20:44:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:44:26 INFO - 'tests': ['tp5n']}, 20:44:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:44:26 INFO - 'talos_options': ['--xperf_path', 20:44:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:44:26 INFO - 'tests': ['tp5n']}}, 20:44:26 INFO - 'talos.zip': {'path': '', 20:44:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:44:26 INFO - Running post-action listener: _resource_record_post_action 20:44:26 INFO - [mozharness: 2017-01-24 04:44:26.101644Z] Finished populate-webroot step (success) 20:44:26 INFO - [mozharness: 2017-01-24 04:44:26.101732Z] Running create-virtualenv step. 20:44:26 INFO - Running pre-action listener: _resource_record_pre_action 20:44:26 INFO - Running main action method: create_virtualenv 20:44:26 INFO - Creating virtualenv /builds/slave/test/build/venv 20:44:26 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 20:44:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:44:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:44:26 INFO - Using real prefix '/usr' 20:44:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:44:26 INFO - Installing distribute.............................................................................................................................................................................................done. 20:44:28 INFO - Installing pip.................done. 20:44:28 INFO - Return code: 0 20:44:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:44:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:44:28 INFO - Reading from file tmpfile_stdout 20:44:28 INFO - Output received: 20:44:28 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) 20:44:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:44: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')]} 20:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44: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')]} 20:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f032348cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194cf60>, '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 0x194dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194e1d0>, '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': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', '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 20:44: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', 'pip>=1.5'] in /builds/slave/test/build 20:44: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 pip>=1.5 20:44:28 INFO - Using env: {'DISPLAY': ':0', 20:44:28 INFO - 'HOME': '/home/cltbld', 20:44:28 INFO - 'LANG': 'en_US.UTF-8', 20:44:28 INFO - 'LANGUAGE': 'en_US:en', 20:44:28 INFO - 'LOGNAME': 'cltbld', 20:44:28 INFO - 'MAIL': '/var/mail/cltbld', 20:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:44:28 INFO - 'MOZ_NO_REMOTE': '1', 20:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:44:28 INFO - 'NO_EM_RESTART': '1', 20:44:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:44:28 INFO - 'PWD': '/builds/slave/test', 20:44:28 INFO - 'SHELL': '/bin/bash', 20:44:28 INFO - 'SHLVL': '1', 20:44:28 INFO - 'TERM': 'linux', 20:44:28 INFO - 'TMOUT': '86400', 20:44:28 INFO - 'USER': 'cltbld', 20:44:28 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', 20:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:44:28 INFO - '_': '/tools/buildbot/bin/python'} 20:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:44:29 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 20:44:29 INFO - Cleaning up... 20:44:29 INFO - Return code: 0 20:44:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:29 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 0x7f032348cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194cf60>, '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 0x194dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194e1d0>, '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': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', '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 20:44:29 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 20:44:29 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 20:44:29 INFO - Using env: {'DISPLAY': ':0', 20:44:29 INFO - 'HOME': '/home/cltbld', 20:44:29 INFO - 'LANG': 'en_US.UTF-8', 20:44:29 INFO - 'LANGUAGE': 'en_US:en', 20:44:29 INFO - 'LOGNAME': 'cltbld', 20:44:29 INFO - 'MAIL': '/var/mail/cltbld', 20:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:44:29 INFO - 'MOZ_NO_REMOTE': '1', 20:44:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:44:29 INFO - 'NO_EM_RESTART': '1', 20:44:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:44:29 INFO - 'PWD': '/builds/slave/test', 20:44:29 INFO - 'SHELL': '/bin/bash', 20:44:29 INFO - 'SHLVL': '1', 20:44:29 INFO - 'TERM': 'linux', 20:44:29 INFO - 'TMOUT': '86400', 20:44:29 INFO - 'USER': 'cltbld', 20:44:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', 20:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:44:29 INFO - '_': '/tools/buildbot/bin/python'} 20:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:44:29 INFO - Downloading/unpacking psutil>=3.1.1 20:44: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 20:44: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 20:44: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 20:44: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 20:44: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 20:44: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 20:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:44:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:44:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:44:31 INFO - Installing collected packages: psutil 20:44:31 INFO - Running setup.py install for psutil 20:44:31 INFO - building 'psutil._psutil_linux' extension 20:44:31 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 20:44:31 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 20:44:31 INFO - building 'psutil._psutil_posix' extension 20:44:31 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 20:44:31 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 20:44:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:44:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:44:32 INFO - Successfully installed psutil 20:44:32 INFO - Cleaning up... 20:44:32 INFO - Return code: 0 20:44:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f032348cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194cf60>, '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 0x194dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194e1d0>, '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': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', '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 20:44:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:44:32 INFO - Using env: {'DISPLAY': ':0', 20:44:32 INFO - 'HOME': '/home/cltbld', 20:44:32 INFO - 'LANG': 'en_US.UTF-8', 20:44:32 INFO - 'LANGUAGE': 'en_US:en', 20:44:32 INFO - 'LOGNAME': 'cltbld', 20:44:32 INFO - 'MAIL': '/var/mail/cltbld', 20:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:44:32 INFO - 'MOZ_NO_REMOTE': '1', 20:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:44:32 INFO - 'NO_EM_RESTART': '1', 20:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:44:32 INFO - 'PWD': '/builds/slave/test', 20:44:32 INFO - 'SHELL': '/bin/bash', 20:44:32 INFO - 'SHLVL': '1', 20:44:32 INFO - 'TERM': 'linux', 20:44:32 INFO - 'TMOUT': '86400', 20:44:32 INFO - 'USER': 'cltbld', 20:44:32 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', 20:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:44:32 INFO - '_': '/tools/buildbot/bin/python'} 20:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:44:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:44:32 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 20:44:32 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 20:44:32 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 20:44:32 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 20:44:32 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 20:44:32 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 20:44:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:44:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:44:34 INFO - Installing collected packages: mozsystemmonitor 20:44:34 INFO - Running setup.py install for mozsystemmonitor 20:44:34 INFO - Successfully installed mozsystemmonitor 20:44:34 INFO - Cleaning up... 20:44:34 INFO - Return code: 0 20:44:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f032348cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194cf60>, '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 0x194dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194e1d0>, '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': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', '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 20:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:44:34 INFO - Using env: {'DISPLAY': ':0', 20:44:34 INFO - 'HOME': '/home/cltbld', 20:44:34 INFO - 'LANG': 'en_US.UTF-8', 20:44:34 INFO - 'LANGUAGE': 'en_US:en', 20:44:34 INFO - 'LOGNAME': 'cltbld', 20:44:34 INFO - 'MAIL': '/var/mail/cltbld', 20:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:44:34 INFO - 'MOZ_NO_REMOTE': '1', 20:44:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:44:34 INFO - 'NO_EM_RESTART': '1', 20:44:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:44:34 INFO - 'PWD': '/builds/slave/test', 20:44:34 INFO - 'SHELL': '/bin/bash', 20:44:34 INFO - 'SHLVL': '1', 20:44:34 INFO - 'TERM': 'linux', 20:44:34 INFO - 'TMOUT': '86400', 20:44:34 INFO - 'USER': 'cltbld', 20:44:34 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', 20:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:44:34 INFO - '_': '/tools/buildbot/bin/python'} 20:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:44:34 INFO - Downloading/unpacking jsonschema==2.5.1 20:44: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 20:44: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 20:44: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 20:44: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 20:44: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 20:44: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 20:44:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:44:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:44:36 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 20:44:36 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 20:44:36 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 20:44:36 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 20:44:36 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 20:44:36 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 20:44:36 INFO - Downloading functools32-3.2.3-2.tar.gz 20:44:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:44:37 INFO - warning: no files found matching '*.txt' 20:44:37 INFO - no previously-included directories found matching 'build' 20:44:37 INFO - no previously-included directories found matching 'dist' 20:44:37 INFO - no previously-included directories found matching '.git*' 20:44:37 INFO - Installing collected packages: jsonschema, functools32 20:44:37 INFO - Running setup.py install for functools32 20:44:37 INFO - warning: no files found matching '*.txt' 20:44:37 INFO - no previously-included directories found matching 'build' 20:44:37 INFO - no previously-included directories found matching 'dist' 20:44:37 INFO - no previously-included directories found matching '.git*' 20:44:37 INFO - Successfully installed jsonschema functools32 20:44:37 INFO - Cleaning up... 20:44:37 INFO - Return code: 0 20:44:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f032348cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194cf60>, '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 0x194dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194e1d0>, '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': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', '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 20:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:44:37 INFO - Using env: {'DISPLAY': ':0', 20:44:37 INFO - 'HOME': '/home/cltbld', 20:44:37 INFO - 'LANG': 'en_US.UTF-8', 20:44:37 INFO - 'LANGUAGE': 'en_US:en', 20:44:37 INFO - 'LOGNAME': 'cltbld', 20:44:37 INFO - 'MAIL': '/var/mail/cltbld', 20:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:44:37 INFO - 'MOZ_NO_REMOTE': '1', 20:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:44:37 INFO - 'NO_EM_RESTART': '1', 20:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:44:37 INFO - 'PWD': '/builds/slave/test', 20:44:37 INFO - 'SHELL': '/bin/bash', 20:44:37 INFO - 'SHLVL': '1', 20:44:37 INFO - 'TERM': 'linux', 20:44:37 INFO - 'TMOUT': '86400', 20:44:37 INFO - 'USER': 'cltbld', 20:44:37 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', 20:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:44:37 INFO - '_': '/tools/buildbot/bin/python'} 20:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:44:37 INFO - Cleaning up... 20:44:37 INFO - Return code: 0 20:44:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f032348cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194cf60>, '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 0x194dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194e1d0>, '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': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', '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 20:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:44:37 INFO - Using env: {'DISPLAY': ':0', 20:44:37 INFO - 'HOME': '/home/cltbld', 20:44:37 INFO - 'LANG': 'en_US.UTF-8', 20:44:37 INFO - 'LANGUAGE': 'en_US:en', 20:44:37 INFO - 'LOGNAME': 'cltbld', 20:44:37 INFO - 'MAIL': '/var/mail/cltbld', 20:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:44:37 INFO - 'MOZ_NO_REMOTE': '1', 20:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:44:37 INFO - 'NO_EM_RESTART': '1', 20:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:44:37 INFO - 'PWD': '/builds/slave/test', 20:44:37 INFO - 'SHELL': '/bin/bash', 20:44:37 INFO - 'SHLVL': '1', 20:44:37 INFO - 'TERM': 'linux', 20:44:37 INFO - 'TMOUT': '86400', 20:44:37 INFO - 'USER': 'cltbld', 20:44:37 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', 20:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:44:37 INFO - '_': '/tools/buildbot/bin/python'} 20:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:44:37 INFO - Downloading/unpacking blobuploader==1.2.4 20:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:44:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:44:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:44:39 INFO - Downloading blobuploader-1.2.4.tar.gz 20:44:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:44:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:44:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:44:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:44:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:44:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:44: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 20:44: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 20:44: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 20:44: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 20:44: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 20:44: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 20:44:40 INFO - Downloading docopt-0.6.1.tar.gz 20:44:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:44:40 INFO - Installing collected packages: blobuploader, requests, docopt 20:44:40 INFO - Running setup.py install for blobuploader 20:44:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:44:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:44:40 INFO - Running setup.py install for requests 20:44:40 INFO - Running setup.py install for docopt 20:44:41 INFO - Successfully installed blobuploader requests docopt 20:44:41 INFO - Cleaning up... 20:44:41 INFO - Return code: 0 20:44:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:44:41 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')]} 20:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:44:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:41 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')]} 20:44:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:44:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:41 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 0x7f032348cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194cf60>, '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 0x194dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194e1d0>, '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': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', '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 20:44:41 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 20:44:41 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 20:44:41 INFO - Using env: {'DISPLAY': ':0', 20:44:41 INFO - 'HOME': '/home/cltbld', 20:44:41 INFO - 'LANG': 'en_US.UTF-8', 20:44:41 INFO - 'LANGUAGE': 'en_US:en', 20:44:41 INFO - 'LOGNAME': 'cltbld', 20:44:41 INFO - 'MAIL': '/var/mail/cltbld', 20:44:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:44:41 INFO - 'MOZ_NO_REMOTE': '1', 20:44:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:44:41 INFO - 'NO_EM_RESTART': '1', 20:44:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:44:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:44:41 INFO - 'PWD': '/builds/slave/test', 20:44:41 INFO - 'SHELL': '/bin/bash', 20:44:41 INFO - 'SHLVL': '1', 20:44:41 INFO - 'TERM': 'linux', 20:44:41 INFO - 'TMOUT': '86400', 20:44:41 INFO - 'USER': 'cltbld', 20:44:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', 20:44:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:44:41 INFO - '_': '/tools/buildbot/bin/python'} 20:44:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:44:41 INFO - Running setup.py (path:/tmp/pip-Yowduz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:44:41 INFO - Running setup.py (path:/tmp/pip-9uRexX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:44:41 INFO - Running setup.py (path:/tmp/pip-NLz0cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:44:41 INFO - Running setup.py (path:/tmp/pip-GYFyzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:44:41 INFO - Running setup.py (path:/tmp/pip-jhVhef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:44:41 INFO - Running setup.py (path:/tmp/pip-ap_fpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:44:41 INFO - Running setup.py (path:/tmp/pip-6UxZJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:44:41 INFO - Running setup.py (path:/tmp/pip-eUKPZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:44:41 INFO - Running setup.py (path:/tmp/pip-Y3U6fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:44:42 INFO - Running setup.py (path:/tmp/pip-OhNNA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:44:42 INFO - Running setup.py (path:/tmp/pip-9bRB8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:44:42 INFO - Running setup.py (path:/tmp/pip-bAmz4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:44:42 INFO - Running setup.py (path:/tmp/pip-785jBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:44:42 INFO - Running setup.py (path:/tmp/pip-qJSxaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:44:42 INFO - Running setup.py (path:/tmp/pip-sdRhgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:44:42 INFO - Running setup.py (path:/tmp/pip-PaTB2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:44:42 INFO - Running setup.py (path:/tmp/pip-ORXCHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:44:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:44:42 INFO - Running setup.py install for manifestparser 20:44:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:44:42 INFO - Running setup.py install for mozcrash 20:44:42 INFO - Running setup.py install for mozdebug 20:44:42 INFO - Running setup.py install for mozdevice 20:44:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:44:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:44:43 INFO - Running setup.py install for mozfile 20:44:43 INFO - Running setup.py install for mozhttpd 20:44:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:44:43 INFO - Running setup.py install for mozinfo 20:44:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:44:43 INFO - Running setup.py install for mozInstall 20:44:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:44:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:44:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:44:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:44:43 INFO - Running setup.py install for mozleak 20:44:43 INFO - Running setup.py install for mozlog 20:44:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:44:43 INFO - Running setup.py install for moznetwork 20:44:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:44:43 INFO - Running setup.py install for mozprocess 20:44:43 INFO - Running setup.py install for mozprofile 20:44:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:44:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:44:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:44:43 INFO - Running setup.py install for mozrunner 20:44:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:44:44 INFO - Running setup.py install for mozscreenshot 20:44:44 INFO - Running setup.py install for moztest 20:44:44 INFO - Running setup.py install for mozversion 20:44:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:44:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:44:44 INFO - Cleaning up... 20:44:44 INFO - Return code: 0 20:44:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:44 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 0x7f032348cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194cf60>, '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 0x194dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194e1d0>, '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': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', '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 20:44:44 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 20:44:44 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 20:44:44 INFO - Using env: {'DISPLAY': ':0', 20:44:44 INFO - 'HOME': '/home/cltbld', 20:44:44 INFO - 'LANG': 'en_US.UTF-8', 20:44:44 INFO - 'LANGUAGE': 'en_US:en', 20:44:44 INFO - 'LOGNAME': 'cltbld', 20:44:44 INFO - 'MAIL': '/var/mail/cltbld', 20:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:44:44 INFO - 'MOZ_NO_REMOTE': '1', 20:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:44:44 INFO - 'NO_EM_RESTART': '1', 20:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:44:44 INFO - 'PWD': '/builds/slave/test', 20:44:44 INFO - 'SHELL': '/bin/bash', 20:44:44 INFO - 'SHLVL': '1', 20:44:44 INFO - 'TERM': 'linux', 20:44:44 INFO - 'TMOUT': '86400', 20:44:44 INFO - 'USER': 'cltbld', 20:44:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', 20:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:44:44 INFO - '_': '/tools/buildbot/bin/python'} 20:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:44:44 INFO - Running setup.py (path:/tmp/pip-LHnZ_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:44:44 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)) 20:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:44:44 INFO - Running setup.py (path:/tmp/pip-smb0QX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:44:44 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)) 20:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:44:44 INFO - Running setup.py (path:/tmp/pip-4lewO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:44:44 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)) 20:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:44:44 INFO - Running setup.py (path:/tmp/pip-djtmpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:44:44 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)) 20:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:44:44 INFO - Running setup.py (path:/tmp/pip-hE8NN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:44:45 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)) 20:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:44:45 INFO - Running setup.py (path:/tmp/pip-oSAlbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:44:45 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)) 20:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:44:45 INFO - Running setup.py (path:/tmp/pip-jEJYz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:44:45 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)) 20:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:44:45 INFO - Running setup.py (path:/tmp/pip-nXI0x9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:44:45 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)) 20:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:44:45 INFO - Running setup.py (path:/tmp/pip-ArvmmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:44:45 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)) 20:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:44:45 INFO - Running setup.py (path:/tmp/pip-8EOztS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:44:45 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)) 20:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:44:45 INFO - Running setup.py (path:/tmp/pip-Rp52qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:44:45 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)) 20:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:44:45 INFO - Running setup.py (path:/tmp/pip-eS4o2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:44:45 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)) 20:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:44:45 INFO - Running setup.py (path:/tmp/pip-sDgQuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:44:45 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)) 20:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:44:45 INFO - Running setup.py (path:/tmp/pip-Qz68in-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:44:45 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)) 20:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:44:45 INFO - Running setup.py (path:/tmp/pip-Zn399P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:44:45 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)) 20:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:44:45 INFO - Running setup.py (path:/tmp/pip-1HuqeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 20:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:44:45 INFO - Running setup.py (path:/tmp/pip-Yo6jnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:44:45 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)) 20:44:45 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)) 20:44:45 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)) 20:44:45 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)) 20:44:45 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)) 20:44:45 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)) 20:44:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:44:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:44:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:44:47 INFO - Downloading blessings-1.6.tar.gz 20:44:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:44:48 INFO - Installing collected packages: blessings 20:44:48 INFO - Running setup.py install for blessings 20:44:48 INFO - Successfully installed blessings 20:44:48 INFO - Cleaning up... 20:44:48 INFO - Return code: 0 20:44:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:44:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:44:48 INFO - Reading from file tmpfile_stdout 20:44:48 INFO - Current package versions: 20:44:48 INFO - argparse == 1.2.1 20:44:48 INFO - blessings == 1.6 20:44:48 INFO - blobuploader == 1.2.4 20:44:48 INFO - docopt == 0.6.1 20:44:48 INFO - functools32 == 3.2.3-2 20:44:48 INFO - jsonschema == 2.5.1 20:44:48 INFO - manifestparser == 1.1 20:44:48 INFO - mozInstall == 1.12 20:44:48 INFO - mozcrash == 1.0 20:44:48 INFO - mozdebug == 0.1 20:44:48 INFO - mozdevice == 0.48 20:44:48 INFO - mozfile == 1.2 20:44:48 INFO - mozhttpd == 0.7 20:44:48 INFO - mozinfo == 0.9 20:44:48 INFO - mozleak == 0.1 20:44:48 INFO - mozlog == 3.4 20:44:48 INFO - moznetwork == 0.27 20:44:48 INFO - mozprocess == 0.23 20:44:48 INFO - mozprofile == 0.28 20:44:48 INFO - mozrunner == 6.13 20:44:48 INFO - mozscreenshot == 0.1 20:44:48 INFO - mozsystemmonitor == 0.3 20:44:48 INFO - moztest == 0.8 20:44:48 INFO - mozversion == 1.4 20:44:48 INFO - psutil == 3.1.1 20:44:48 INFO - requests == 1.2.3 20:44:48 INFO - wsgiref == 0.1.2 20:44:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:48 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 0x7f032348cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194cf60>, '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 0x194dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194e1d0>, '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': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', '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 20:44:48 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 20:44:48 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 20:44:48 INFO - Using env: {'DISPLAY': ':0', 20:44:48 INFO - 'HOME': '/home/cltbld', 20:44:48 INFO - 'LANG': 'en_US.UTF-8', 20:44:48 INFO - 'LANGUAGE': 'en_US:en', 20:44:48 INFO - 'LOGNAME': 'cltbld', 20:44:48 INFO - 'MAIL': '/var/mail/cltbld', 20:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:44:48 INFO - 'MOZ_NO_REMOTE': '1', 20:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:44:48 INFO - 'NO_EM_RESTART': '1', 20:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:44:48 INFO - 'PWD': '/builds/slave/test', 20:44:48 INFO - 'SHELL': '/bin/bash', 20:44:48 INFO - 'SHLVL': '1', 20:44:48 INFO - 'TERM': 'linux', 20:44:48 INFO - 'TMOUT': '86400', 20:44:48 INFO - 'USER': 'cltbld', 20:44:48 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', 20:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:44:48 INFO - '_': '/tools/buildbot/bin/python'} 20:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:44:48 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)) 20:44:48 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)) 20:44:48 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)) 20:44:48 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)) 20:44:48 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)) 20:44:48 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)) 20:44:48 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)) 20:44:48 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)) 20:44:48 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)) 20:44:48 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)) 20:44:48 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)) 20:44:48 INFO - Cleaning up... 20:44:48 INFO - Return code: 0 20:44:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:44:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f032348cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194cf60>, '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 0x194dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194e1d0>, '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': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', '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 20:44:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:44:48 INFO - Using env: {'DISPLAY': ':0', 20:44:48 INFO - 'HOME': '/home/cltbld', 20:44:48 INFO - 'LANG': 'en_US.UTF-8', 20:44:48 INFO - 'LANGUAGE': 'en_US:en', 20:44:48 INFO - 'LOGNAME': 'cltbld', 20:44:48 INFO - 'MAIL': '/var/mail/cltbld', 20:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:44:48 INFO - 'MOZ_NO_REMOTE': '1', 20:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:44:48 INFO - 'NO_EM_RESTART': '1', 20:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:44:48 INFO - 'PWD': '/builds/slave/test', 20:44:48 INFO - 'SHELL': '/bin/bash', 20:44:48 INFO - 'SHLVL': '1', 20:44:48 INFO - 'TERM': 'linux', 20:44:48 INFO - 'TMOUT': '86400', 20:44:48 INFO - 'USER': 'cltbld', 20:44:48 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', 20:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:44:48 INFO - '_': '/tools/buildbot/bin/python'} 20:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:44:48 INFO - Cleaning up... 20:44:48 INFO - Return code: 0 20:44:48 INFO - Running post-action listener: _resource_record_post_action 20:44:48 INFO - Running post-action listener: _start_resource_monitoring 20:44:48 INFO - Starting resource monitoring. 20:44:48 INFO - [mozharness: 2017-01-24 04:44:48.894025Z] Finished create-virtualenv step (success) 20:44:48 INFO - [mozharness: 2017-01-24 04:44:48.894523Z] Running install step. 20:44:48 INFO - Running pre-action listener: _resource_record_pre_action 20:44:48 INFO - Running main action method: install 20:44:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:44:49 INFO - Reading from file tmpfile_stdout 20:44:49 INFO - Detecting whether we're running mozinstall >=1.0... 20:44:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:44:49 INFO - Reading from file tmpfile_stdout 20:44:49 INFO - Output received: 20:44:49 INFO - Usage: mozinstall [options] installer 20:44:49 INFO - Options: 20:44:49 INFO - -h, --help show this help message and exit 20:44:49 INFO - -d DEST, --destination=DEST 20:44:49 INFO - Directory to install application into. [default: 20:44:49 INFO - "/builds/slave/test"] 20:44:49 INFO - --app=APP Application being installed. [default: firefox] 20:44:49 INFO - mkdir: /builds/slave/test/build/application 20:44:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:45:02 INFO - Reading from file tmpfile_stdout 20:45:02 INFO - Output received: 20:45:02 INFO - /builds/slave/test/build/application/firefox/firefox 20:45:02 INFO - Running post-action listener: _resource_record_post_action 20:45:02 INFO - [mozharness: 2017-01-24 04:45:02.829328Z] Finished install step (success) 20:45:02 INFO - [mozharness: 2017-01-24 04:45:02.829630Z] Running run-tests step. 20:45:02 INFO - Running pre-action listener: _resource_record_pre_action 20:45:02 INFO - Running main action method: run_tests 20:45:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:45:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:45:02 INFO - Python 2.7.3 20:45:02 INFO - Return code: 0 20:45:02 INFO - grabbing minidump binary from tooltool 20:45:02 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')]} 20:45:02 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 0x194cf60>, '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 0x194dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:45:02 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 20:45:02 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 20:45:02 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 20:45:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:45:02 INFO - Return code: 0 20:45:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:45:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:45:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:45:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:45:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:45:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 20:45:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 20:45:02 INFO - Using env: {'DISPLAY': ':0', 20:45:02 INFO - 'HOME': '/home/cltbld', 20:45:02 INFO - 'LANG': 'en_US.UTF-8', 20:45:02 INFO - 'LANGUAGE': 'en_US:en', 20:45:02 INFO - 'LOGNAME': 'cltbld', 20:45:02 INFO - 'MAIL': '/var/mail/cltbld', 20:45:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:45:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:02 INFO - 'MOZ_NO_REMOTE': '1', 20:45:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:45:02 INFO - 'NO_EM_RESTART': '1', 20:45:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:02 INFO - 'PWD': '/builds/slave/test', 20:45:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:45:02 INFO - 'SHELL': '/bin/bash', 20:45:02 INFO - 'SHLVL': '1', 20:45:02 INFO - 'TERM': 'linux', 20:45:02 INFO - 'TMOUT': '86400', 20:45:02 INFO - 'USER': 'cltbld', 20:45:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645', 20:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:02 INFO - '_': '/tools/buildbot/bin/python'} 20:45:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 20:45:03 INFO - mozversion application_buildid: 20170123180844 20:45:03 INFO - mozversion application_changeset: 748ca6ea965cd7287affab431369809c751b462e 20:45:03 INFO - mozversion application_display_name: Firefox 20:45:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:45:03 INFO - mozversion application_name: Firefox 20:45:03 INFO - mozversion application_remotingname: firefox 20:45:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:45:03 INFO - mozversion application_vendor: Mozilla 20:45:03 INFO - mozversion application_version: 52.0 20:45:03 INFO - mozversion platform_buildid: 20170123180844 20:45:03 INFO - mozversion platform_changeset: 748ca6ea965cd7287affab431369809c751b462e 20:45:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:45:03 INFO - mozversion platform_version: 52.0 20:45:03 INFO - using testdate: 1485233103 20:45:03 INFO - actual date: 1485233103 20:45:03 INFO - starting webserver on 'localhost:47598' 20:45:03 INFO - SUITE-START | Running 2 tests 20:45:03 INFO - TEST-START | dromaeo_css 20:45:03 INFO - operating with platform_type : linux_ 20:45:03 INFO - Initialising browser for dromaeo_css test... 20:45:03 INFO - TEST-INFO | started process 31729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Ak3ax/profile http://localhost:47598/getInfo.html) 20:45:07 INFO - PROCESS | 31729 | __metrics Screen width/height:1600/1200 20:45:07 INFO - PROCESS | 31729 | colorDepth:24 20:45:07 INFO - PROCESS | 31729 | Browser inner width/height: 1024/697 20:45:07 INFO - PROCESS | 31729 | __metrics 20:45:08 ERROR - PROCESS | 31729 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 20:45:09 INFO - TEST-INFO | 31729: exit 0 20:45:09 INFO - Browser initialized. 20:45:09 INFO - Running cycle 1/1 for dromaeo_css test... 20:45:09 INFO - TEST-INFO | started process 31862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Ak3ax/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:45:21 INFO - PROCESS | 31862 | RSS: Main: 148447232 20:45:21 INFO - PROCESS | 31862 | 20:48:20 INFO - PROCESS | 31862 | Cycle 1(1): loaded http://localhost:47598/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47598/tests/dromaeo/cssquery-ext.html) 20:48:21 INFO - PROCESS | 31862 | RSS: Main: 154574848 20:48:21 INFO - PROCESS | 31862 | 20:51:23 INFO - PROCESS | 31862 | Cycle 1(1): loaded http://localhost:47598/tests/dromaeo/cssquery-ext.html (next: http://localhost:47598/tests/dromaeo/cssquery-jquery.html) 20:51:24 INFO - PROCESS | 31862 | RSS: Main: 152485888 20:51:24 INFO - PROCESS | 31862 | 20:54:26 INFO - PROCESS | 31862 | Cycle 1(1): loaded http://localhost:47598/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47598/tests/dromaeo/cssquery-mootools.html) 20:54:26 INFO - PROCESS | 31862 | RSS: Main: 152166400 20:54:26 INFO - PROCESS | 31862 | 20:57:28 INFO - PROCESS | 31862 | Cycle 1(1): loaded http://localhost:47598/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47598/tests/dromaeo/cssquery-prototype.html) 20:57:29 INFO - PROCESS | 31862 | RSS: Main: 154169344 20:57:29 INFO - PROCESS | 31862 | 21:00:31 INFO - PROCESS | 31862 | Cycle 1(1): loaded http://localhost:47598/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47598/tests/dromaeo/cssquery-yui.html) 21:00:32 INFO - PROCESS | 31862 | RSS: Main: 154689536 21:00:32 INFO - PROCESS | 31862 | 21:03:34 INFO - PROCESS | 31862 | Cycle 1(1): loaded http://localhost:47598/tests/dromaeo/cssquery-yui.html (next: http://localhost:47598/tests/dromaeo/cssquery-dojo.html) 21:03:34 INFO - PROCESS | 31862 | RSS: Main: 155508736 21:03:34 INFO - PROCESS | 31862 | 21:03:34 INFO - PROCESS | 31862 | __start_tp_report 21:03:34 INFO - PROCESS | 31862 | _x_x_mozilla_page_load 21:03:34 INFO - PROCESS | 31862 | _x_x_mozilla_page_load_details 21:03:34 INFO - PROCESS | 31862 | |i|pagename|runs| 21:03:34 INFO - PROCESS | 31862 | |0;dojo.html;3190.473571860643;3236.595425571805;3250.674932506749;3252.056903497986;3256.1696767324356;5646.20953066571;5655.26481557397;5686.232358631583;5703.857403564908;5733.9999999999945;5719.685417302057;5767.077267637179;5789.3687044978515;5795.797147099853;5823.854403639911;5210.713410762416;5261.447548007462;5275.551578115865;5276.683398996053;5318.335208098988;5323.760430780624;5325.573954083664;5328.573714102862;5329.546988505962;5369.463053694619;5051.242313652963;5085.389753229618;5314.787408503656;5324.361076670805;5333.653312534692;5087.313212716292;5134.306868572732;5156.948430515703;5193.870153246161;5270.2358158067245;5123.666961647481;5200.8959820803375;5204.141316682742;5207.921881171786;5222.947770522284;5585.301837270341;5610.24261724666;5623.550115990711;5682.971585142048;5684.118961560965;5886.087656413263;5940.138679891392;5998.910016349714;6062.030075187949;6066.545009124334;6066.363031881633;6066.605670631395;6070.484008859252;6073.574849760518;6076.392360763933;5726.0838265877255;5728.570357223225;5740.339860915965;5741.224934633855;5768.278965129359;6081.6351018939;6092.116643086728;6132.325444201134;6132.93502613891;6226.40849119333;5882.411758824083;5930.466258036798;5933.406659334119;5944.7919322824355;5953.047512397996;6018.277806663228;6023.066424704178;6026.45761881424;6036.396360364016;6051.243594550681;5848.2689663792025;5911.9113213301835;5956.970215148983;5972.731227094704;5988.520918326523;5978.611390259706;6035.124906888476;6042.154098426224;6049.122877182784;6066.059760737093;4605.148047611203;4644.419447569054;4648.767561621906;4663.673542852036;4673.275642275453;4049.493813273341;4084.9795751021056;4086.9182616347507;4091.488563929509;4133.91732165355;5850.5612079094235;5883.970580147072;5887.882242355129;5896.351401345849;5918.171455996164;6095.116208149882;6151.72317245725;6161.075838624152;6167.352427995085;6176.722047507783;5659.434056594308;5701.087825947911;5723.627964182315;5756.0502517084215;5855.648661080349;5223.2948551945;5240.318758561362;5242.213667949762;5261.657992230493;5263.6841789492755;6181.907271390933;6211.440970312694;6221.097940798559;6230.127782110508;6232.719527621268;5909.8227053188475;5979.850503737442;6019.217501724747;6088.3911608840535;6107.572469927062;6127.647695153045;6262.311145774052;6278.623282603058;6280.685965701788;6291.685415729286;5897.852553686193;5997.460228579449;6000.399960004139;6011.924065158176;6059.0608455689435;5925.318588362394;5964.821055368346;6144.109104179958;6167.044108163242;6169.383061693974;5925.911111333419;5962.910556341745;5982.760689572368;6056.3035250946705;6075.058365953284;5956.166136740946;5976.491998180203;5983.042713165873;5999.790007349722;5999.850003749942;5901.026330655393;5969.283685957539;5970.044792833126;5980.37206093354;5982.222311099529;5750.942490575041;5870.823875283749;5928.4960778334325;5931.525477961666;5950.256217972754;5858.297004359504;5863.560232982629;5868.119782032729;5871.295444546682;5882.94117058841 21:03:34 INFO - PROCESS | 31862 | |1;ext.html;568.7696482924415;623.2707731953614;648.3743187823751;689.7137687859539;692.6779047742799;42039.78980105099;43251.351229731576;46211.537884621146;46576;46596.30105548415;46062.30906536405;46548;46778.29832552506;46850.29724554135;46854.765726171405;8687.652493900236;10666.520006599721;10949.616763413282;10958.56165753369;11229.887701123007;10614;10657.200709946746;10662.733431664194;10672.199585031114;10691.198160138021;10713.142948564097;10725.892741072606;10741;10761.946190269076;10808.02727754502;10675.19936004799;10781;10802.13582913369;10809.297395669295;10816.621418250323;10472.738181545446;10653.147748180205;10706.1435085193;10732;10759.3006454581;43120.78439607813;43492.565074349484;43536.78231608853;43542.56457435417;43754;3620.31214069326;3747.2505498900055;4378.233809083429;4416.293393057128;4419.895026243439;33465.83267083649;33722.49416258758;33900.83049584736;34378.82810585931;35280.294394111974;4247.68142389322;4278.693840896039;4319.308910574293;4337.587929146726;4379.474463064453;355908;358042;358492;358811;362229.1888540567;64276.357236427975;64361.67819160874;64379;64645;64770;68552.31447685459;68796;68945.31054689489;68980.6550967252;69066.65466672735;17577.736333955;17892.552686182687;18035.098245087695;18037.819621803876;18052.27790888376;13228.272445015424;13370.39833207508;13382.397792099378;13448.663783405298;13481.865181348257;20894.164233430798;21032;21110.894445527672;21263.574728505344;21301.14795408166;7730.994970653779;7776;7892.4080693947035;7906.486078404885;7956.164602716747;1053.167997282154;1135.27909777292;1149.2587281203578;1188.9702757431132;1191.4876603060768;32895.67104328926;33053.17367065843;33106.3378732424;33234.50148247778;33512;1156.375557199103;1183.1185766603935;1210.494276846936;1219.9146059775908;1234.4691782533416;17560.82439175592;17617;17677.911610441864;17751.289948402176;17821.10894455272;509123;511968;512061;512586;513483;61344;61812;61839.38160618426;61843.381566183765;61873.38126618676;1403.7052219034117;1423.9715205695827;1445.6169115184484;1466.596685911383;1472.506710252056;31727.841360793973;32326;32553.837230813693;32918.67081329156;33261.833690831394;53754.462455374945;53808;53850.999999998436;54005.10982115607;54145.45854541404;317902;319858;319878;320590;321231;30292.394152116394;30316.69683303227;30448.543271850496;31192.688073118978;33224;48714.26928596003;49655;49756.502434975184;50020.24969625531;50865.745671271405;42634.78682606691;42876;43600;44278.77860610676;44808.327875081246;41858.58141418547;42094.15811683688;42103.36844947389;42591.3611295837;43656.12687746164;42970.1405971885;43463.56536434595;43468;43763.12473750443;44040.55959440493;36358;37917.43123853199;38837.80581097076;39035.6096439032;39615.80192099021;28391;29175.85412073011;29515.778561888827;29544.556831647973;29712.70287297186 21:03:34 INFO - PROCESS | 31862 | |2;jquery.html;393.990150246244;400.34943217271933;418.43511259799277;425.4362969065986;428.25483658434325;18667.439976800702;19263.903680481577;20499.18003279869;20515.179392824288;20848;19711.408657740256;20052.899735501338;20125.194992200293;20265.797342026577;20374.694379584318;5661.575381846357;5793.768249270045;5834.299884013924;5844.970775146118;5856.76572937082;5653.717314134276;5742.712864356787;5781.508571771405;5837.153612726173;5848;5691.800786972457;5751.7986870459545;5756.539476841843;5767.048437007888;5778.653280803165;5568.276124103861;5748.109043098306;5758.9424105759035;5834.824955251349;5877.147813567009;5281.86795330116;5325.3077099977145;5330.92003619946;5342.813001544966;5350.0904846176245;23505;23695;24223.636645450333;24407.87796061026;24447.51104977908;2488.776010159076;2490.3774056485877;2502.2868482482586;2514.5222407742654;2944.0012739424114;15219.923900380427;15841.762373564407;15910.248344866835;16042.518724438285;16342.10118443485;1997.7502812148482;2009.849261305408;2033.2070492507933;2068.70003849441;2135.8252960871614;74976.62511687407;83651.58174209151;84145.57927210386;84864.15135848624;85488.57255713744;11547.307161570332;12034;12083.637490875288;12382.6285211442;12398.75202495945;17212.483625491255;17272.568185795455;17327;17331;17338.3064677414;8290.626921788413;8364.665413383396;8419.705310314232;8423.578821059045;8680.6527738891;8086.757397278091;8103.756887293391;8121.4721043132;8257.710980115668;8264.256216940505;4947.171663584385;5122.92315615266;5136.383633963948;5207.921881171786;5345.625806193529;2112.2818241797863;2125.9149634014775;2142.3572928121503;2151.5696860627936;2163.2644900733826;918.2470374293149;972.9708108756607;1015.5582321690089;1052.6368402900987;1056.144522936424;20294.898525507277;20501.17995280202;20540.589188216152;20601.48496287605;20631.896840515703;1038.9220808439397;1049.3796402411558;1057.3338796558119;1077.1275267033727;1097.8902109788958;10806.78386432267;11556.479958401893;11564.190506664452;11576.131790115607;11606.651800446;453233;454350;454472;460071;461261;86501;95478.04521954691;96034;97194;98689;1037.7353774787532;1038.190211634926;1066.6266806617778;1089.166787407618;1093.092733031582;18367.724484133018;18509.167087480826;18719;18833.058347082864;18951.90524047371;43680.56319436892;44299;44620;45252.321215182455;46253.30620040769;62193;64083.67958160179;64285;64547.35452645413;65105.67447162734;8682.262007729161;9059.4564326138;9108;9169;9215.354925155443;10302.587896484056;13483.662908426975;13623.18260904349;13747.960705857733;13832.446702132205;11973;12246.571370002008;12362.567310144103;12396.504139834306;12428.875711242772;11805.586804461802;11926.463309151282;11939.403029848647;12346.876531234573;12867.549635762703;12284.447199875849;12400.441980111096;12451.25292482454;12544.435500402322;12645.936770316457;9015.188633023059;9154.450732956044;9213.401128926598;11757.470913808727;11776.234544754563;11575.942120289345;11745.647630571097;12267.263964162179;12302.569410070604;12696.365181741061 21:03:34 INFO - PROCESS | 31862 | |3;mootools.html;1531.7319469092906;1534.186880953095;1685.5870311773617;1806.8193180681926;1809.231076792363;7870.370370370371;8164.020317561901;8666.653333866645;9289.860652090216;9295.814083718322;8545.529995850226;8881.067487913773;8885.955570222157;9214.631414743402;9289.581968811402;2403.4832511010086;2481.3424442522655;2484.7018357797087;2487.141936032066;2492.8628925409093;2491.638712386703;2536.0109557272676;2536.9492610147786;2541.7458254174526;2542.707588627313;2470.110760126353;2489.55188066148;2497.9750202498017;2500.7749302562765;2504.9749502505015;2415.0943396226503;2442.5481285962064;2465.29739024379;2469.444375015625;2470.7405722399158;2444.046821739523;2453.7300896901324;2454.631805229212;2475.405902583385;2478.1450399612104;9040.728778136667;9103.681371152044;9122.5438728064;9130.086991300883;9142.314326425545;5505.917411238835;5576.498115169654;5628.802991895305;5630.014747419185;5639.407862174454;3501.107217659506;3518.1732292911147;3565.4117070683305;3604.098975256186;3635.6184649832894;1221.102960505111;1223.1682455929963;1224.9816252756216;1266.1326991011188;1278.162803363789;12717.554885579053;12718.300493472856;12736.554220602235;12772.042096842773;12789.61631151067;4711.52884711533;4859.659823812299;4895.559399654048;4902.362692849907;5012.624053196025;10725.892741072645;10780.730481738019;10797;10809.67570972872;10815.242932994615;5522.116461366242;5575.581831362664;5578;5580.246666700024;5585.134304182858;4930.038642464757;5080.110980578384;5092.9236061459105;5131.153359695609;5214.061468935628;3983.7410568312966;4046.4537287466405;4102.958970410317;4129.463169787909;4141.068259641556;1279.072672312566;1285.9099863009499;1294.7734146524322;1295.520657356784;1298.3897568142959;991.1971303244395;1015.243643485608;1035.8446233065101;1036.404067661098;1037.8806437259661;6049.9802696316565;6170.10533472653;6175.104609831549;6257.468115210167;6343.302236753953;477.41039815827423;486.83204294518333;490.47029208454785;497.89544195719304;525.7844283843606;4302.397664326997;4318.568143185719;4327.415798867176;4373.956260437419;4388.890277743082;10957.671269861918;11233.943830280796;11323.433828308716;11346.262492937933;11414.88585114155;10561.524731386953;10990.890091099147;11007.944960275147;11303.378314192634;11332.43337833105;8389.99320081582;8541.95729021351;8595.441296315845;8602.483850968962;8613.440126391764;5865.472107510344;6224.595401298901;6271.3415091414745;6295.464885484785;6361.395667411589;10143.391396516232;10205.897941020496;10259.692209233735;10417.84373234387;10427.635032773816;10495.580176792842;10599.15206783471;10609.257351985596;10615.840762388416;10625.309354891908;7789.532628042336;8035.035795704553;8103.594820258845;8217.055038670629;8367.665293388196;8895.4662720237;8928.10718928102;8937;8952.373333866566;8955.41789783662;8114;8136.918630813616;8190.590470476572;8355.707550235713;8546.102659220942;8052.798680033046;8135.9186408135165;8157.06193787722;8243.9587802063;8408.957955210184;7187.748428804966;7195;7247.383972362408;7249.855002900018;7257.709691612276;5367;5534.142207957773;5577.721113944205;5631.2960879890015;5691.402402747652;5558.360788509373;5563.721813909207;5577.832665020056;5630.380658127685;5640.802571909963 21:03:34 INFO - PROCESS | 31862 | |4;prototype.html;355.28587539046526;360.9963900360996;364.87229469685616;368.8229649768113;373.14177391998396;5677.148427735841;5715.857103572413;5730.341010783761;5775.624584402011;5784.132380142981;5555.388907220203;5640.464155905182;5644.266245388104;5695.259616249892;5698.037020749218;4527.547245275479;4533.591976722094;4538.7503687297185;4586.243269860469;4593.1961906666365;4325.394444777734;4517.7289362638185;4553.68124231304;4588.541145885418;4620.468646105707;4468.932966005513;4483.843065492709;4488.8204471821255;4491.550844915515;4496.685232033759;4479.708818926776;4514.841980530666;4518.999999999984;4539.570035438859;4551.95448045522;3887;4026.577209393001;4068.3694027425795;4086.346184610478;4094.7747873866924;5491.983982963165;5493.615446918718;5496.7526461309335;5506.779728810843;5538.307711536058;5170.3278573785165;5185.455527169631;5195.454477279869;5199.350081239845;5220.92168617471;5725.914111288334;5991.340952495266;6011.144706264533;6021.849453763647;6032.426919442646;4460.174867649495;4461;4464.0402313502755;4471.004427033862;4471.642268618502;6179.876402471926;6182.474489668429;6227.252729672423;6239;6239.344868788758;4484.170428470743;4553.430821147356;4556.931646025312;4561.270196768501;4578.2903649934315;4630.490646028934;4641.74470404131;4653.53464653532;4656.4645065817185;4660.650451216173;5146.948530514722;5207.297014903015;5210.557102646242;5233.71214583194;5239.161734122522;5767.740451679684;5880.911786323209;5957.702114894325;5983.6708981005595;5991.730372133177;1546.481928553947;1569.9450519232;1572.2688949638243;1572.8505791949747;1579.5972027133007;1073.5974009746344;1088.8584484017026;1100.0979197058334;1104.2215238257008;1118.904893084097;5599.284347091657;5604.430759387378;5614.803481878196;5641.548676105902;5671.171958927707;5912.320083190488;5957.553183511167;5984.431479009487;5996.700164991733;6012.188354572077;5343.385510666245;5533.474319939599;5572.0527510323345;5600;5608.186812912187;3136.4511210538067;3153.4796758535044;3156.2582793043616;3161.2096975756062;3162.525621156799;5891.852703682356;6039.456448919618;6043.516518678495;6067.969660151671;6100.115483254903;5962.55280853929;5995.400459954057;6009.519238460913;6021.417256732238;6076.240469941257;5934.851628709231;5985.127138973317;6023.819285421357;6095.696743832805;6149.631022138686;5766.452187042224;5865.73604187804;5883.294004719461;5890.4993075587345;5911.7635294587735;5776.277965254343;5810.796622118206;5828.417158284137;5860.648361098348;5890.734916928663;5819;5940.910886336795;6014.398560143951;6068.4499567753355;6085.2393450818645;4414.426124603781;4414.536473670219;4429.557044295545;4445.1998640245065;4456.3511500744935;5896.204012458264;5979.402059793986;5993.400659933972;6033.637981721111;6224;6027.879442411215;6033.215681961317;6039.214902062704;6041.69791510414;6068.21113255274;5981.222441082631;6017.578769486269;6024.518038556817;6046.606970546901;6124.448799608057;5646.632968857011;5963.7912673056235;6005.378547791985;6010.789622363372;6021.969890150521;6042.909356359746;6064.363241859542;6082.878342433038;6095.573309868267;6159.599626024294;5684.687342196219;5894.587378883437;5905.173275741314;5961;6006.387221558636 21:03:34 INFO - PROCESS | 31862 | |5;yui.html;754.0423661949325;755.1391413788278;813.4793732011511;843.1989609870625;862.585958739805;15566.844331556695;16378.918105409486;16385.09881956492;16430.507084787445;16443.342266309348;14616.196109213988;14738.484153054646;14748.041377310466;14848.628784280398;14864.702705945874;840.1808236968952;852.7612268564811;854.6666799948025;856.8072183758667;862.017300277684;822.4243029879078;828.0808302783905;828.1263267253046;828.9844939948545;829.4318391901567;863.9136086391342;865.7965378136164;867.4101610904582;870.4603146049458;871.9171678690515;865.5715420866649;869.3306154261215;869.8390797702446;869.9391042627019;870.4037734152126;642.097852517214;642.8425035866196;643.0386572074732;643.3084434233218;645.07431835316;14139.858601413956;14156.221407822566;14161.150330980072;14161.716765664733;14173.29133543329;12165.817512737316;12454.564090256888;12768.936155319258;12984.87015129846;13470.730585388335;11304.095672346275;11325.773484530346;11382.430878456044;11500.424978751029;11502.137339699557;3854.325493038707;3911.6870650347905;3911.784851833148;3946.4277679736565;3965.345717956534;68540;69375;69532.60934781327;70077.29922700759;72388.63805680937;9549.045095490395;9610.135087842127;9690.854637180448;9752.951235243778;9877.506124693737;20210.696839547418;20235.392938211877;20244.392668219683;20331.898340508204;20335.389938301876;8246.299064579458;8563.314934805201;8867.600957956907;8875.911240887637;8876.167490288595;4575;4642.489326174118;4714.9209878503825;4785.736784476818;4857.53853383928;3550.467429885538;3638.43604241343;3680.2823449427106;3712.554493460802;3715.9442608360896;603.2881200183825;603.8852618002566;604.1240201707454;606.6966516741629;621.4065567383228;551.2475470982081;586.1471558881817;605.00174711726;678.2708588267632;694.2606124477416;8607.268382187583;9165.954170229106;9208.217301529312;9259.67591134307;9558.426494410358;652.3085529338916;652.3704625036862;677.9017042528806;692.2177938929078;695.3741632530763;4070.61329173728;4346.630536404441;4360.149770794728;4376.518582955872;4378.190034843564;91548.54225728962;92732;95659.52170239104;97990;98016.50991744996;50290.497095029314;61714.69142654258;78330.21669783343;79565;81233.59383203165;73249;73268.2673173272;73555.26444735484;74814.62592687002;76534.61732691301;8204.712835050745;8571.4000019998;8587.441816281922;8637.833892424442;8709.695160669346;50730.492695074056;50865.49134508608;50925.49074509207;51352.229716555026;52363.73818130885;42765.35851962285;46980;67592.32407676057;67777.32222677907;67933;10348.120409765253;10452.843207351743;10582.523786429476;10613.09788667972;11481.82777258325;11981.76036479283;12024.579139730067;12125.81811272814;12256.264624122581;12700.118939201708;10977.28647637901;11146.721331966766;11149.442527873736;11164.88835111671;11522.251053681484;10454.32046916948;10939.708135608336;10964.068054215162;10998.230123891251;11063.612773552886;11631.47658355393;11734.295942243492;11842.881571184178;12196.146269761386;12597.93701031489;9471.384360016576;9661.661841835783;9866.210703143588;9970.850437243302;10116.84824727615;8921.464712117293;9203.35576509638;9376.612551105454;9406.568810639517;9662.661806836726 21:03:34 INFO - PROCESS | 31862 | __end_tp_report 21:03:34 INFO - PROCESS | 31862 | __start_cc_report 21:03:34 INFO - PROCESS | 31862 | _x_x_mozilla_cycle_collect,310 21:03:34 INFO - PROCESS | 31862 | __end_cc_report 21:03:34 INFO - PROCESS | 31862 | __startTimestamp1485234214666__endTimestamp 21:03:34 INFO - PROCESS | 31862 | 21:03:34 INFO - PROCESS | 31862 | ------- Summary: start ------- 21:03:34 INFO - PROCESS | 31862 | Number of tests: 6 21:03:34 INFO - PROCESS | 31862 | 21:03:34 INFO - PROCESS | 31862 | [#0] dojo.html Cycles:165 Average:5648.53 Median:5887.88 stddev:635.37 (10.8%) stddev-sans-first:607.35 21:03:34 INFO - PROCESS | 31862 | Values: 3190.5 3236.6 3250.7 3252.1 3256.2 5646.2 5655.3 5686.2 5703.9 5734.0 5719.7 5767.1 5789.4 5795.8 5823.9 5210.7 5261.4 5275.6 5276.7 5318.3 5323.8 5325.6 5328.6 5329.5 5369.5 5051.2 5085.4 5314.8 5324.4 5333.7 5087.3 5134.3 5156.9 5193.9 5270.2 5123.7 5200.9 5204.1 5207.9 5222.9 5585.3 5610.2 5623.6 5683.0 5684.1 5886.1 5940.1 5998.9 6062.0 6066.5 6066.4 6066.6 6070.5 6073.6 6076.4 5726.1 5728.6 5740.3 5741.2 5768.3 6081.6 6092.1 6132.3 6132.9 6226.4 5882.4 5930.5 5933.4 5944.8 5953.0 6018.3 6023.1 6026.5 6036.4 6051.2 5848.3 5911.9 5957.0 5972.7 5988.5 5978.6 6035.1 6042.2 6049.1 6066.1 4605.1 4644.4 4648.8 4663.7 4673.3 4049.5 4085.0 4086.9 4091.5 4133.9 5850.6 5884.0 5887.9 5896.4 5918.2 6095.1 6151.7 6161.1 6167.4 6176.7 5659.4 5701.1 5723.6 5756.1 5855.6 5223.3 5240.3 5242.2 5261.7 5263.7 6181.9 6211.4 6221.1 6230.1 6232.7 5909.8 5979.9 6019.2 6088.4 6107.6 6127.6 6262.3 6278.6 6280.7 6291.7 5897.9 5997.5 6000.4 6011.9 6059.1 5925.3 5964.8 6144.1 6167.0 6169.4 5925.9 5962.9 5982.8 6056.3 6075.1 5956.2 5976.5 5983.0 5999.8 5999.9 5901.0 5969.3 5970.0 5980.4 5982.2 5750.9 5870.8 5928.5 5931.5 5950.3 5858.3 5863.6 5868.1 5871.3 5882.9 21:03:34 INFO - PROCESS | 31862 | 21:03:34 INFO - PROCESS | 31862 | [#1] ext.html Cycles:180 Average:58241.17 Median:358267.00 stddev:106914.72 (29.8%) stddev-sans-first:107126.96 21:03:34 INFO - PROCESS | 31862 | Values: 568.8 623.3 648.4 689.7 692.7 42039.8 43251.4 46211.5 46576.0 46596.3 46062.3 46548.0 46778.3 46850.3 46854.8 8687.7 10666.5 10949.6 10958.6 11229.9 10614.0 10657.2 10662.7 10672.2 10691.2 10713.1 10725.9 10741.0 10761.9 10808.0 10675.2 10781.0 10802.1 10809.3 10816.6 10472.7 10653.1 10706.1 10732.0 10759.3 43120.8 43492.6 43536.8 43542.6 43754.0 3620.3 3747.3 4378.2 4416.3 4419.9 33465.8 33722.5 33900.8 34378.8 35280.3 4247.7 4278.7 4319.3 4337.6 4379.5 355908.0 358042.0 358492.0 358811.0 362229.2 64276.4 64361.7 64379.0 64645.0 64770.0 68552.3 68796.0 68945.3 68980.7 69066.7 17577.7 17892.6 18035.1 18037.8 18052.3 13228.3 13370.4 13382.4 13448.7 13481.9 20894.2 21032.0 21110.9 21263.6 21301.1 7731.0 7776.0 7892.4 7906.5 7956.2 1053.2 1135.3 1149.3 1189.0 1191.5 32895.7 33053.2 33106.3 33234.5 33512.0 1156.4 1183.1 1210.5 1219.9 1234.5 17560.8 17617.0 17677.9 17751.3 17821.1 509123.0 511968.0 512061.0 512586.0 513483.0 61344.0 61812.0 61839.4 61843.4 61873.4 1403.7 1424.0 1445.6 1466.6 1472.5 31727.8 32326.0 32553.8 32918.7 33261.8 53754.5 53808.0 53851.0 54005.1 54145.5 317902.0 319858.0 319878.0 320590.0 321231.0 30292.4 30316.7 30448.5 31192.7 33224.0 48714.3 49655.0 49756.5 50020.2 50865.7 42634.8 42876.0 43600.0 44278.8 44808.3 41858.6 42094.2 42103.4 42591.4 43656.1 42970.1 43463.6 43468.0 43763.1 44040.6 36358.0 37917.4 38837.8 39035.6 39615.8 28391.0 29175.9 29515.8 29544.6 29712.7 21:03:34 INFO - PROCESS | 31862 | 21:03:34 INFO - PROCESS | 31862 | [#2] jquery.html Cycles:180 Average:29019.03 Median:23600.00 stddev:75577.76 (320.2%) stddev-sans-first:75759.22 21:03:34 INFO - PROCESS | 31862 | Values: 394.0 400.3 418.4 425.4 428.3 18667.4 19263.9 20499.2 20515.2 20848.0 19711.4 20052.9 20125.2 20265.8 20374.7 5661.6 5793.8 5834.3 5845.0 5856.8 5653.7 5742.7 5781.5 5837.2 5848.0 5691.8 5751.8 5756.5 5767.0 5778.7 5568.3 5748.1 5758.9 5834.8 5877.1 5281.9 5325.3 5330.9 5342.8 5350.1 23505.0 23695.0 24223.6 24407.9 24447.5 2488.8 2490.4 2502.3 2514.5 2944.0 15219.9 15841.8 15910.2 16042.5 16342.1 1997.8 2009.8 2033.2 2068.7 2135.8 74976.6 83651.6 84145.6 84864.2 85488.6 11547.3 12034.0 12083.6 12382.6 12398.8 17212.5 17272.6 17327.0 17331.0 17338.3 8290.6 8364.7 8419.7 8423.6 8680.7 8086.8 8103.8 8121.5 8257.7 8264.3 4947.2 5122.9 5136.4 5207.9 5345.6 2112.3 2125.9 2142.4 2151.6 2163.3 918.2 973.0 1015.6 1052.6 1056.1 20294.9 20501.2 20540.6 20601.5 20631.9 1038.9 1049.4 1057.3 1077.1 1097.9 10806.8 11556.5 11564.2 11576.1 11606.7 453233.0 454350.0 454472.0 460071.0 461261.0 86501.0 95478.0 96034.0 97194.0 98689.0 1037.7 1038.2 1066.6 1089.2 1093.1 18367.7 18509.2 18719.0 18833.1 18951.9 43680.6 44299.0 44620.0 45252.3 46253.3 62193.0 64083.7 64285.0 64547.4 65105.7 8682.3 9059.5 9108.0 9169.0 9215.4 10302.6 13483.7 13623.2 13748.0 13832.4 11973.0 12246.6 12362.6 12396.5 12428.9 11805.6 11926.5 11939.4 12346.9 12867.5 12284.4 12400.4 12451.3 12544.4 12645.9 9015.2 9154.5 9213.4 11757.5 11776.2 11575.9 11745.6 12267.3 12302.6 12696.4 21:03:34 INFO - PROCESS | 31862 | 21:03:34 INFO - PROCESS | 31862 | [#3] mootools.html Cycles:180 Average:6042.34 Median:2668.54 stddev:3399.87 (127.4%) stddev-sans-first:3392.51 21:03:34 INFO - PROCESS | 31862 | Values: 1531.7 1534.2 1685.6 1806.8 1809.2 7870.4 8164.0 8666.7 9289.9 9295.8 8545.5 8881.1 8886.0 9214.6 9289.6 2403.5 2481.3 2484.7 2487.1 2492.9 2491.6 2536.0 2536.9 2541.7 2542.7 2470.1 2489.6 2498.0 2500.8 2505.0 2415.1 2442.5 2465.3 2469.4 2470.7 2444.0 2453.7 2454.6 2475.4 2478.1 9040.7 9103.7 9122.5 9130.1 9142.3 5505.9 5576.5 5628.8 5630.0 5639.4 3501.1 3518.2 3565.4 3604.1 3635.6 1221.1 1223.2 1225.0 1266.1 1278.2 12717.6 12718.3 12736.6 12772.0 12789.6 4711.5 4859.7 4895.6 4902.4 5012.6 10725.9 10780.7 10797.0 10809.7 10815.2 5522.1 5575.6 5578.0 5580.2 5585.1 4930.0 5080.1 5092.9 5131.2 5214.1 3983.7 4046.5 4103.0 4129.5 4141.1 1279.1 1285.9 1294.8 1295.5 1298.4 991.2 1015.2 1035.8 1036.4 1037.9 6050.0 6170.1 6175.1 6257.5 6343.3 477.4 486.8 490.5 497.9 525.8 4302.4 4318.6 4327.4 4374.0 4388.9 10957.7 11233.9 11323.4 11346.3 11414.9 10561.5 10990.9 11007.9 11303.4 11332.4 8390.0 8542.0 8595.4 8602.5 8613.4 5865.5 6224.6 6271.3 6295.5 6361.4 10143.4 10205.9 10259.7 10417.8 10427.6 10495.6 10599.2 10609.3 10615.8 10625.3 7789.5 8035.0 8103.6 8217.1 8367.7 8895.5 8928.1 8937.0 8952.4 8955.4 8114.0 8136.9 8190.6 8355.7 8546.1 8052.8 8135.9 8157.1 8244.0 8409.0 7187.7 7195.0 7247.4 7249.9 7257.7 5367.0 5534.1 5577.7 5631.3 5691.4 5558.4 5563.7 5577.8 5630.4 5640.8 21:03:34 INFO - PROCESS | 31862 | 21:03:34 INFO - PROCESS | 31862 | [#4] prototype.html Cycles:180 Average:5018.84 Median:5642.91 stddev:1424.01 (25.2%) stddev-sans-first:1384.31 21:03:34 INFO - PROCESS | 31862 | Values: 355.3 361.0 364.9 368.8 373.1 5677.1 5715.9 5730.3 5775.6 5784.1 5555.4 5640.5 5644.3 5695.3 5698.0 4527.5 4533.6 4538.8 4586.2 4593.2 4325.4 4517.7 4553.7 4588.5 4620.5 4468.9 4483.8 4488.8 4491.6 4496.7 4479.7 4514.8 4519.0 4539.6 4552.0 3887.0 4026.6 4068.4 4086.3 4094.8 5492.0 5493.6 5496.8 5506.8 5538.3 5170.3 5185.5 5195.5 5199.4 5220.9 5725.9 5991.3 6011.1 6021.8 6032.4 4460.2 4461.0 4464.0 4471.0 4471.6 6179.9 6182.5 6227.3 6239.0 6239.3 4484.2 4553.4 4556.9 4561.3 4578.3 4630.5 4641.7 4653.5 4656.5 4660.7 5146.9 5207.3 5210.6 5233.7 5239.2 5767.7 5880.9 5957.7 5983.7 5991.7 1546.5 1569.9 1572.3 1572.9 1579.6 1073.6 1088.9 1100.1 1104.2 1118.9 5599.3 5604.4 5614.8 5641.5 5671.2 5912.3 5957.6 5984.4 5996.7 6012.2 5343.4 5533.5 5572.1 5600.0 5608.2 3136.5 3153.5 3156.3 3161.2 3162.5 5891.9 6039.5 6043.5 6068.0 6100.1 5962.6 5995.4 6009.5 6021.4 6076.2 5934.9 5985.1 6023.8 6095.7 6149.6 5766.5 5865.7 5883.3 5890.5 5911.8 5776.3 5810.8 5828.4 5860.6 5890.7 5819.0 5940.9 6014.4 6068.4 6085.2 4414.4 4414.5 4429.6 4445.2 4456.4 5896.2 5979.4 5993.4 6033.6 6224.0 6027.9 6033.2 6039.2 6041.7 6068.2 5981.2 6017.6 6024.5 6046.6 6124.4 5646.6 5963.8 6005.4 6010.8 6022.0 6042.9 6064.4 6082.9 6095.6 6159.6 5684.7 5894.6 5905.2 5961.0 6006.4 21:03:34 INFO - PROCESS | 31862 | 21:03:34 INFO - PROCESS | 31862 | [#5] yui.html Cycles:180 Average:17908.96 Median:31160.69 stddev:24695.70 (79.3%) stddev-sans-first:24731.39 21:03:34 INFO - PROCESS | 31862 | Values: 754.0 755.1 813.5 843.2 862.6 15566.8 16378.9 16385.1 16430.5 16443.3 14616.2 14738.5 14748.0 14848.6 14864.7 840.2 852.8 854.7 856.8 862.0 822.4 828.1 828.1 829.0 829.4 863.9 865.8 867.4 870.5 871.9 865.6 869.3 869.8 869.9 870.4 642.1 642.8 643.0 643.3 645.1 14139.9 14156.2 14161.2 14161.7 14173.3 12165.8 12454.6 12768.9 12984.9 13470.7 11304.1 11325.8 11382.4 11500.4 11502.1 3854.3 3911.7 3911.8 3946.4 3965.3 68540.0 69375.0 69532.6 70077.3 72388.6 9549.0 9610.1 9690.9 9753.0 9877.5 20210.7 20235.4 20244.4 20331.9 20335.4 8246.3 8563.3 8867.6 8875.9 8876.2 4575.0 4642.5 4714.9 4785.7 4857.5 3550.5 3638.4 3680.3 3712.6 3715.9 603.3 603.9 604.1 606.7 621.4 551.2 586.1 605.0 678.3 694.3 8607.3 9166.0 9208.2 9259.7 9558.4 652.3 652.4 677.9 692.2 695.4 4070.6 4346.6 4360.1 4376.5 4378.2 91548.5 92732.0 95659.5 97990.0 98016.5 50290.5 61714.7 78330.2 79565.0 81233.6 73249.0 73268.3 73555.3 74814.6 76534.6 8204.7 8571.4 8587.4 8637.8 8709.7 50730.5 50865.5 50925.5 51352.2 52363.7 42765.4 46980.0 67592.3 67777.3 67933.0 10348.1 10452.8 10582.5 10613.1 11481.8 11981.8 12024.6 12125.8 12256.3 12700.1 10977.3 11146.7 11149.4 11164.9 11522.3 10454.3 10939.7 10964.1 10998.2 11063.6 11631.5 11734.3 11842.9 12196.1 12597.9 9471.4 9661.7 9866.2 9970.9 10116.8 8921.5 9203.4 9376.6 9406.6 9662.7 21:03:34 INFO - PROCESS | 31862 | -------- Summary: end -------- 21:03:34 INFO - PROCESS | 31862 | 21:03:35 INFO - TEST-INFO | 31862: exit 0 21:03:35 INFO - TEST-OK | dromaeo_css | took 1112315ms 21:03:35 INFO - TEST-START | kraken 21:03:35 INFO - operating with platform_type : linux_ 21:03:35 INFO - Initialising browser for kraken test... 21:03:35 INFO - TEST-INFO | started process 32221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRY51wx/profile http://localhost:47598/getInfo.html) 21:03:40 INFO - PROCESS | 32221 | __metrics Screen width/height:1600/1200 21:03:40 INFO - PROCESS | 32221 | colorDepth:24 21:03:40 INFO - PROCESS | 32221 | Browser inner width/height: 1024/697 21:03:40 INFO - PROCESS | 32221 | __metrics 21:03:40 ERROR - PROCESS | 32221 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 21:03:41 INFO - TEST-INFO | 32221: exit 0 21:03:41 INFO - Browser initialized. 21:03:41 INFO - Running cycle 1/1 for kraken test... 21:03:41 INFO - TEST-INFO | started process 32350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRY51wx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:03:53 INFO - PROCESS | 32350 | RSS: Main: 148787200 21:03:53 INFO - PROCESS | 32350 | 21:03:56 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47598/tests/kraken/driver.html?testName=audio-beat-detection) 21:03:56 INFO - PROCESS | 32350 | RSS: Main: 154546176 21:03:56 INFO - PROCESS | 32350 | 21:03:59 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47598/tests/kraken/driver.html?testName=audio-dft) 21:04:00 INFO - PROCESS | 32350 | RSS: Main: 153055232 21:04:00 INFO - PROCESS | 32350 | 21:04:02 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47598/tests/kraken/driver.html?testName=audio-fft) 21:04:03 INFO - PROCESS | 32350 | RSS: Main: 153870336 21:04:03 INFO - PROCESS | 32350 | 21:04:05 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47598/tests/kraken/driver.html?testName=audio-oscillator) 21:04:06 INFO - PROCESS | 32350 | RSS: Main: 153522176 21:04:06 INFO - PROCESS | 32350 | 21:04:08 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47598/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:04:08 INFO - PROCESS | 32350 | RSS: Main: 153313280 21:04:08 INFO - PROCESS | 32350 | 21:04:11 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47598/tests/kraken/driver.html?testName=imaging-darkroom) 21:04:12 INFO - PROCESS | 32350 | RSS: Main: 156164096 21:04:12 INFO - PROCESS | 32350 | 21:04:15 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47598/tests/kraken/driver.html?testName=imaging-desaturate) 21:04:16 INFO - PROCESS | 32350 | RSS: Main: 156020736 21:04:16 INFO - PROCESS | 32350 | 21:04:19 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47598/tests/kraken/driver.html?testName=json-parse-financial) 21:04:19 INFO - PROCESS | 32350 | RSS: Main: 155803648 21:04:19 INFO - PROCESS | 32350 | 21:04:21 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47598/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:04:21 INFO - PROCESS | 32350 | RSS: Main: 155144192 21:04:21 INFO - PROCESS | 32350 | 21:04:23 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47598/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:04:24 INFO - PROCESS | 32350 | RSS: Main: 155217920 21:04:24 INFO - PROCESS | 32350 | 21:04:26 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47598/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:04:26 INFO - PROCESS | 32350 | RSS: Main: 155406336 21:04:26 INFO - PROCESS | 32350 | 21:04:29 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47598/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:04:30 INFO - PROCESS | 32350 | RSS: Main: 155987968 21:04:30 INFO - PROCESS | 32350 | 21:04:32 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47598/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:04:33 INFO - PROCESS | 32350 | RSS: Main: 156332032 21:04:33 INFO - PROCESS | 32350 | 21:04:35 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47598/tests/kraken/driver.html?testName=ai-astar) 21:04:35 INFO - PROCESS | 32350 | RSS: Main: 157523968 21:04:35 INFO - PROCESS | 32350 | 21:04:35 INFO - PROCESS | 32350 | __start_tp_report 21:04:35 INFO - PROCESS | 32350 | _x_x_mozilla_page_load 21:04:35 INFO - PROCESS | 32350 | _x_x_mozilla_page_load_details 21:04:35 INFO - PROCESS | 32350 | |i|pagename|runs| 21:04:35 INFO - PROCESS | 32350 | |0;ai-astar;101;111;112;111;112;113;112;112;112;112 21:04:35 INFO - PROCESS | 32350 | |1;audio-beat-detection;151;121;127;160;123;125;124;118;155;118 21:04:35 INFO - PROCESS | 32350 | |2;audio-dft;162;162;162;162;162;161;163;167;165;161 21:04:35 INFO - PROCESS | 32350 | |3;audio-fft;75;76;76;116;76;77;76;76;97;77 21:04:35 INFO - PROCESS | 32350 | |4;audio-oscillator;82;82;106;83;82;82;93;82;81;108 21:04:35 INFO - PROCESS | 32350 | |5;imaging-gaussian-blur;119;117;119;117;118;117;119;118;118;118 21:04:35 INFO - PROCESS | 32350 | |6;imaging-darkroom;147;148;147;148;147;146;147;148;147;147 21:04:35 INFO - PROCESS | 32350 | |7;imaging-desaturate;85;85;85;85;85;86;85;84;85;85 21:04:35 INFO - PROCESS | 32350 | |8;json-parse-financial;52;55;54;53;52;52;52;52;52;52 21:04:35 INFO - PROCESS | 32350 | |9;json-stringify-tinderbox;57;58;59;58;63;57;58;58;58;57 21:04:35 INFO - PROCESS | 32350 | |10;stanford-crypto-aes;75;81;78;88;74;74;74;75;75;79 21:04:35 INFO - PROCESS | 32350 | |11;stanford-crypto-ccm;145;135;122;122;129;128;121;133;165;125 21:04:35 INFO - PROCESS | 32350 | |12;stanford-crypto-pbkdf2;161;158;159;157;157;156;155;155;156;156 21:04:35 INFO - PROCESS | 32350 | |13;stanford-crypto-sha256-iterative;64;62;63;63;61;62;64;62;69;62 21:04:35 INFO - PROCESS | 32350 | __end_tp_report 21:04:35 INFO - PROCESS | 32350 | __start_cc_report 21:04:35 INFO - PROCESS | 32350 | _x_x_mozilla_cycle_collect,757 21:04:35 INFO - PROCESS | 32350 | __end_cc_report 21:04:35 INFO - PROCESS | 32350 | __startTimestamp1485234275353__endTimestamp 21:04:35 INFO - PROCESS | 32350 | 21:04:35 INFO - PROCESS | 32350 | ------- Summary: start ------- 21:04:35 INFO - PROCESS | 32350 | Number of tests: 14 21:04:35 INFO - PROCESS | 32350 | 21:04:35 INFO - PROCESS | 32350 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.49 (3.1%) stddev-sans-first:0.60 21:04:35 INFO - PROCESS | 32350 | Values: 101.0 111.0 112.0 111.0 112.0 113.0 112.0 112.0 112.0 112.0 21:04:35 INFO - PROCESS | 32350 | 21:04:35 INFO - PROCESS | 32350 | [#1] audio-beat-detection Cycles:10 Average:132.20 Median:126.00 stddev:16.35 (13.0%) stddev-sans-first:15.86 21:04:35 INFO - PROCESS | 32350 | Values: 151.0 121.0 127.0 160.0 123.0 125.0 124.0 118.0 155.0 118.0 21:04:35 INFO - PROCESS | 32350 | 21:04:35 INFO - PROCESS | 32350 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:1.89 (1.2%) stddev-sans-first:1.99 21:04:35 INFO - PROCESS | 32350 | Values: 162.0 162.0 162.0 162.0 162.0 161.0 163.0 167.0 165.0 161.0 21:04:35 INFO - PROCESS | 32350 | 21:04:35 INFO - PROCESS | 32350 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:13.58 (17.9%) stddev-sans-first:14.15 21:04:35 INFO - PROCESS | 32350 | Values: 75.0 76.0 76.0 116.0 76.0 77.0 76.0 76.0 97.0 77.0 21:04:35 INFO - PROCESS | 32350 | 21:04:35 INFO - PROCESS | 32350 | [#4] audio-oscillator Cycles:10 Average:88.10 Median:82.00 stddev:10.56 (12.9%) stddev-sans-first:10.96 21:04:35 INFO - PROCESS | 32350 | Values: 82.0 82.0 106.0 83.0 82.0 82.0 93.0 82.0 81.0 108.0 21:04:35 INFO - PROCESS | 32350 | 21:04:35 INFO - PROCESS | 32350 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 21:04:35 INFO - PROCESS | 32350 | Values: 119.0 117.0 119.0 117.0 118.0 117.0 119.0 118.0 118.0 118.0 21:04:35 INFO - PROCESS | 32350 | 21:04:35 INFO - PROCESS | 32350 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 21:04:35 INFO - PROCESS | 32350 | Values: 147.0 148.0 147.0 148.0 147.0 146.0 147.0 148.0 147.0 147.0 21:04:35 INFO - PROCESS | 32350 | 21:04:35 INFO - PROCESS | 32350 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.47 (0.6%) stddev-sans-first:0.50 21:04:35 INFO - PROCESS | 32350 | Values: 85.0 85.0 85.0 85.0 85.0 86.0 85.0 84.0 85.0 85.0 21:04:35 INFO - PROCESS | 32350 | 21:04:35 INFO - PROCESS | 32350 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:52.00 stddev:1.07 (2.1%) stddev-sans-first:1.12 21:04:35 INFO - PROCESS | 32350 | Values: 52.0 55.0 54.0 53.0 52.0 52.0 52.0 52.0 52.0 52.0 21:04:35 INFO - PROCESS | 32350 | 21:04:35 INFO - PROCESS | 32350 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:1.77 (3.0%) stddev-sans-first:1.81 21:04:35 INFO - PROCESS | 32350 | Values: 57.0 58.0 59.0 58.0 63.0 57.0 58.0 58.0 58.0 57.0 21:04:35 INFO - PROCESS | 32350 | 21:04:35 INFO - PROCESS | 32350 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:76.50 stddev:4.47 (5.8%) stddev-sans-first:4.67 21:04:35 INFO - PROCESS | 32350 | Values: 75.0 81.0 78.0 88.0 74.0 74.0 74.0 75.0 75.0 79.0 21:04:35 INFO - PROCESS | 32350 | 21:04:35 INFO - PROCESS | 32350 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:131.00 stddev:13.58 (10.4%) stddev-sans-first:13.63 21:04:35 INFO - PROCESS | 32350 | Values: 145.0 135.0 122.0 122.0 129.0 128.0 121.0 133.0 165.0 125.0 21:04:35 INFO - PROCESS | 32350 | 21:04:35 INFO - PROCESS | 32350 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:157.00 stddev:1.89 (1.2%) stddev-sans-first:1.33 21:04:35 INFO - PROCESS | 32350 | Values: 161.0 158.0 159.0 157.0 157.0 156.0 155.0 155.0 156.0 156.0 21:04:35 INFO - PROCESS | 32350 | 21:04:35 INFO - PROCESS | 32350 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:2.25 (3.6%) stddev-sans-first:2.37 21:04:35 INFO - PROCESS | 32350 | Values: 64.0 62.0 63.0 63.0 61.0 62.0 64.0 62.0 69.0 62.0 21:04:35 INFO - PROCESS | 32350 | -------- Summary: end -------- 21:04:35 INFO - PROCESS | 32350 | 21:04:36 INFO - TEST-INFO | 32350: exit 0 21:04:36 INFO - TEST-OK | kraken | took 61005ms 21:04:36 INFO - SUITE-END | took 1173s 21:04:36 INFO - Completed test suite (00:19:33) 21:04:36 INFO - javascript benchmark 21:04:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7513.397488948361, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3190.473571860643, 3236.595425571805, 3250.674932506749, 3252.056903497986, 3256.1696767324356, 5646.20953066571, 5655.26481557397, 5686.232358631583, 5703.857403564908, 5733.9999999999945, 5719.685417302057, 5767.077267637179, 5789.3687044978515, 5795.797147099853, 5823.854403639911, 5210.713410762416, 5261.447548007462, 5275.551578115865, 5276.683398996053, 5318.335208098988, 5323.760430780624, 5325.573954083664, 5328.573714102862, 5329.546988505962, 5369.463053694619, 5051.242313652963, 5085.389753229618, 5314.787408503656, 5324.361076670805, 5333.653312534692, 5087.313212716292, 5134.306868572732, 5156.948430515703, 5193.870153246161, 5270.2358158067245, 5123.666961647481, 5200.8959820803375, 5204.141316682742, 5207.921881171786, 5222.947770522284, 5585.301837270341, 5610.24261724666, 5623.550115990711, 5682.971585142048, 5684.118961560965, 5886.087656413263, 5940.138679891392, 5998.910016349714, 6062.030075187949, 6066.545009124334, 6066.363031881633, 6066.605670631395, 6070.484008859252, 6073.574849760518, 6076.392360763933, 5726.0838265877255, 5728.570357223225, 5740.339860915965, 5741.224934633855, 5768.278965129359, 6081.6351018939, 6092.116643086728, 6132.325444201134, 6132.93502613891, 6226.40849119333, 5882.411758824083, 5930.466258036798, 5933.406659334119, 5944.7919322824355, 5953.047512397996, 6018.277806663228, 6023.066424704178, 6026.45761881424, 6036.396360364016, 6051.243594550681, 5848.2689663792025, 5911.9113213301835, 5956.970215148983, 5972.731227094704, 5988.520918326523, 5978.611390259706, 6035.124906888476, 6042.154098426224, 6049.122877182784, 6066.059760737093, 4605.148047611203, 4644.419447569054, 4648.767561621906, 4663.673542852036, 4673.275642275453, 4049.493813273341, 4084.9795751021056, 4086.9182616347507, 4091.488563929509, 4133.91732165355, 5850.5612079094235, 5883.970580147072, 5887.882242355129, 5896.351401345849, 5918.171455996164, 6095.116208149882, 6151.72317245725, 6161.075838624152, 6167.352427995085, 6176.722047507783, 5659.434056594308, 5701.087825947911, 5723.627964182315, 5756.0502517084215, 5855.648661080349, 5223.2948551945, 5240.318758561362, 5242.213667949762, 5261.657992230493, 5263.6841789492755, 6181.907271390933, 6211.440970312694, 6221.097940798559, 6230.127782110508, 6232.719527621268, 5909.8227053188475, 5979.850503737442, 6019.217501724747, 6088.3911608840535, 6107.572469927062, 6127.647695153045, 6262.311145774052, 6278.623282603058, 6280.685965701788, 6291.685415729286, 5897.852553686193, 5997.460228579449, 6000.399960004139, 6011.924065158176, 6059.0608455689435, 5925.318588362394, 5964.821055368346, 6144.109104179958, 6167.044108163242, 6169.383061693974, 5925.911111333419, 5962.910556341745, 5982.760689572368, 6056.3035250946705, 6075.058365953284, 5956.166136740946, 5976.491998180203, 5983.042713165873, 5999.790007349722, 5999.850003749942, 5901.026330655393, 5969.283685957539, 5970.044792833126, 5980.37206093354, 5982.222311099529, 5750.942490575041, 5870.823875283749, 5928.4960778334325, 5931.525477961666, 5950.256217972754, 5858.297004359504, 5863.560232982629, 5868.119782032729, 5871.295444546682, 5882.94117058841], "value": 5605.114556082774, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.7696482924415, 623.2707731953614, 648.3743187823751, 689.7137687859539, 692.6779047742799, 42039.78980105099, 43251.351229731576, 46211.537884621146, 46576.0, 46596.30105548415, 46062.30906536405, 46548.0, 46778.29832552506, 46850.29724554135, 46854.765726171405, 8687.652493900236, 10666.520006599721, 10949.616763413282, 10958.56165753369, 11229.887701123007, 10614.0, 10657.200709946746, 10662.733431664194, 10672.199585031114, 10691.198160138021, 10713.142948564097, 10725.892741072606, 10741.0, 10761.946190269076, 10808.02727754502, 10675.19936004799, 10781.0, 10802.13582913369, 10809.297395669295, 10816.621418250323, 10472.738181545446, 10653.147748180205, 10706.1435085193, 10732.0, 10759.3006454581, 43120.78439607813, 43492.565074349484, 43536.78231608853, 43542.56457435417, 43754.0, 3620.31214069326, 3747.2505498900055, 4378.233809083429, 4416.293393057128, 4419.895026243439, 33465.83267083649, 33722.49416258758, 33900.83049584736, 34378.82810585931, 35280.294394111974, 4247.68142389322, 4278.693840896039, 4319.308910574293, 4337.587929146726, 4379.474463064453, 355908.0, 358042.0, 358492.0, 358811.0, 362229.1888540567, 64276.357236427975, 64361.67819160874, 64379.0, 64645.0, 64770.0, 68552.31447685459, 68796.0, 68945.31054689489, 68980.6550967252, 69066.65466672735, 17577.736333955, 17892.552686182687, 18035.098245087695, 18037.819621803876, 18052.27790888376, 13228.272445015424, 13370.39833207508, 13382.397792099378, 13448.663783405298, 13481.865181348257, 20894.164233430798, 21032.0, 21110.894445527672, 21263.574728505344, 21301.14795408166, 7730.994970653779, 7776.0, 7892.4080693947035, 7906.486078404885, 7956.164602716747, 1053.167997282154, 1135.27909777292, 1149.2587281203578, 1188.9702757431132, 1191.4876603060768, 32895.67104328926, 33053.17367065843, 33106.3378732424, 33234.50148247778, 33512.0, 1156.375557199103, 1183.1185766603935, 1210.494276846936, 1219.9146059775908, 1234.4691782533416, 17560.82439175592, 17617.0, 17677.911610441864, 17751.289948402176, 17821.10894455272, 509123.0, 511968.0, 512061.0, 512586.0, 513483.0, 61344.0, 61812.0, 61839.38160618426, 61843.381566183765, 61873.38126618676, 1403.7052219034117, 1423.9715205695827, 1445.6169115184484, 1466.596685911383, 1472.506710252056, 31727.841360793973, 32326.0, 32553.837230813693, 32918.67081329156, 33261.833690831394, 53754.462455374945, 53808.0, 53850.999999998436, 54005.10982115607, 54145.45854541404, 317902.0, 319858.0, 319878.0, 320590.0, 321231.0, 30292.394152116394, 30316.69683303227, 30448.543271850496, 31192.688073118978, 33224.0, 48714.26928596003, 49655.0, 49756.502434975184, 50020.24969625531, 50865.745671271405, 42634.78682606691, 42876.0, 43600.0, 44278.77860610676, 44808.327875081246, 41858.58141418547, 42094.15811683688, 42103.36844947389, 42591.3611295837, 43656.12687746164, 42970.1405971885, 43463.56536434595, 43468.0, 43763.12473750443, 44040.55959440493, 36358.0, 37917.43123853199, 38837.80581097076, 39035.6096439032, 39615.80192099021, 28391.0, 29175.85412073011, 29515.778561888827, 29544.556831647973, 29712.70287297186], "value": 21484.81236674261, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.990150246244, 400.34943217271933, 418.43511259799277, 425.4362969065986, 428.25483658434325, 18667.439976800702, 19263.903680481577, 20499.18003279869, 20515.179392824288, 20848.0, 19711.408657740256, 20052.899735501338, 20125.194992200293, 20265.797342026577, 20374.694379584318, 5661.575381846357, 5793.768249270045, 5834.299884013924, 5844.970775146118, 5856.76572937082, 5653.717314134276, 5742.712864356787, 5781.508571771405, 5837.153612726173, 5848.0, 5691.800786972457, 5751.7986870459545, 5756.539476841843, 5767.048437007888, 5778.653280803165, 5568.276124103861, 5748.109043098306, 5758.9424105759035, 5834.824955251349, 5877.147813567009, 5281.86795330116, 5325.3077099977145, 5330.92003619946, 5342.813001544966, 5350.0904846176245, 23505.0, 23695.0, 24223.636645450333, 24407.87796061026, 24447.51104977908, 2488.776010159076, 2490.3774056485877, 2502.2868482482586, 2514.5222407742654, 2944.0012739424114, 15219.923900380427, 15841.762373564407, 15910.248344866835, 16042.518724438285, 16342.10118443485, 1997.7502812148482, 2009.849261305408, 2033.2070492507933, 2068.70003849441, 2135.8252960871614, 74976.62511687407, 83651.58174209151, 84145.57927210386, 84864.15135848624, 85488.57255713744, 11547.307161570332, 12034.0, 12083.637490875288, 12382.6285211442, 12398.75202495945, 17212.483625491255, 17272.568185795455, 17327.0, 17331.0, 17338.3064677414, 8290.626921788413, 8364.665413383396, 8419.705310314232, 8423.578821059045, 8680.6527738891, 8086.757397278091, 8103.756887293391, 8121.4721043132, 8257.710980115668, 8264.256216940505, 4947.171663584385, 5122.92315615266, 5136.383633963948, 5207.921881171786, 5345.625806193529, 2112.2818241797863, 2125.9149634014775, 2142.3572928121503, 2151.5696860627936, 2163.2644900733826, 918.2470374293149, 972.9708108756607, 1015.5582321690089, 1052.6368402900987, 1056.144522936424, 20294.898525507277, 20501.17995280202, 20540.589188216152, 20601.48496287605, 20631.896840515703, 1038.9220808439397, 1049.3796402411558, 1057.3338796558119, 1077.1275267033727, 1097.8902109788958, 10806.78386432267, 11556.479958401893, 11564.190506664452, 11576.131790115607, 11606.651800446, 453233.0, 454350.0, 454472.0, 460071.0, 461261.0, 86501.0, 95478.04521954691, 96034.0, 97194.0, 98689.0, 1037.7353774787532, 1038.190211634926, 1066.6266806617778, 1089.166787407618, 1093.092733031582, 18367.724484133018, 18509.167087480826, 18719.0, 18833.058347082864, 18951.90524047371, 43680.56319436892, 44299.0, 44620.0, 45252.321215182455, 46253.30620040769, 62193.0, 64083.67958160179, 64285.0, 64547.35452645413, 65105.67447162734, 8682.262007729161, 9059.4564326138, 9108.0, 9169.0, 9215.354925155443, 10302.587896484056, 13483.662908426975, 13623.18260904349, 13747.960705857733, 13832.446702132205, 11973.0, 12246.571370002008, 12362.567310144103, 12396.504139834306, 12428.875711242772, 11805.586804461802, 11926.463309151282, 11939.403029848647, 12346.876531234573, 12867.549635762703, 12284.447199875849, 12400.441980111096, 12451.25292482454, 12544.435500402322, 12645.936770316457, 9015.188633023059, 9154.450732956044, 9213.401128926598, 11757.470913808727, 11776.234544754563, 11575.942120289345, 11745.647630571097, 12267.263964162179, 12302.569410070604, 12696.365181741061], "value": 9772.64365307207, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1531.7319469092906, 1534.186880953095, 1685.5870311773617, 1806.8193180681926, 1809.231076792363, 7870.370370370371, 8164.020317561901, 8666.653333866645, 9289.860652090216, 9295.814083718322, 8545.529995850226, 8881.067487913773, 8885.955570222157, 9214.631414743402, 9289.581968811402, 2403.4832511010086, 2481.3424442522655, 2484.7018357797087, 2487.141936032066, 2492.8628925409093, 2491.638712386703, 2536.0109557272676, 2536.9492610147786, 2541.7458254174526, 2542.707588627313, 2470.110760126353, 2489.55188066148, 2497.9750202498017, 2500.7749302562765, 2504.9749502505015, 2415.0943396226503, 2442.5481285962064, 2465.29739024379, 2469.444375015625, 2470.7405722399158, 2444.046821739523, 2453.7300896901324, 2454.631805229212, 2475.405902583385, 2478.1450399612104, 9040.728778136667, 9103.681371152044, 9122.5438728064, 9130.086991300883, 9142.314326425545, 5505.917411238835, 5576.498115169654, 5628.802991895305, 5630.014747419185, 5639.407862174454, 3501.107217659506, 3518.1732292911147, 3565.4117070683305, 3604.098975256186, 3635.6184649832894, 1221.102960505111, 1223.1682455929963, 1224.9816252756216, 1266.1326991011188, 1278.162803363789, 12717.554885579053, 12718.300493472856, 12736.554220602235, 12772.042096842773, 12789.61631151067, 4711.52884711533, 4859.659823812299, 4895.559399654048, 4902.362692849907, 5012.624053196025, 10725.892741072645, 10780.730481738019, 10797.0, 10809.67570972872, 10815.242932994615, 5522.116461366242, 5575.581831362664, 5578.0, 5580.246666700024, 5585.134304182858, 4930.038642464757, 5080.110980578384, 5092.9236061459105, 5131.153359695609, 5214.061468935628, 3983.7410568312966, 4046.4537287466405, 4102.958970410317, 4129.463169787909, 4141.068259641556, 1279.072672312566, 1285.9099863009499, 1294.7734146524322, 1295.520657356784, 1298.3897568142959, 991.1971303244395, 1015.243643485608, 1035.8446233065101, 1036.404067661098, 1037.8806437259661, 6049.9802696316565, 6170.10533472653, 6175.104609831549, 6257.468115210167, 6343.302236753953, 477.41039815827423, 486.83204294518333, 490.47029208454785, 497.89544195719304, 525.7844283843606, 4302.397664326997, 4318.568143185719, 4327.415798867176, 4373.956260437419, 4388.890277743082, 10957.671269861918, 11233.943830280796, 11323.433828308716, 11346.262492937933, 11414.88585114155, 10561.524731386953, 10990.890091099147, 11007.944960275147, 11303.378314192634, 11332.43337833105, 8389.99320081582, 8541.95729021351, 8595.441296315845, 8602.483850968962, 8613.440126391764, 5865.472107510344, 6224.595401298901, 6271.3415091414745, 6295.464885484785, 6361.395667411589, 10143.391396516232, 10205.897941020496, 10259.692209233735, 10417.84373234387, 10427.635032773816, 10495.580176792842, 10599.15206783471, 10609.257351985596, 10615.840762388416, 10625.309354891908, 7789.532628042336, 8035.035795704553, 8103.594820258845, 8217.055038670629, 8367.665293388196, 8895.4662720237, 8928.10718928102, 8937.0, 8952.373333866566, 8955.41789783662, 8114.0, 8136.918630813616, 8190.590470476572, 8355.707550235713, 8546.102659220942, 8052.798680033046, 8135.9186408135165, 8157.06193787722, 8243.9587802063, 8408.957955210184, 7187.748428804966, 7195.0, 7247.383972362408, 7249.855002900018, 7257.709691612276, 5367.0, 5534.142207957773, 5577.721113944205, 5631.2960879890015, 5691.402402747652, 5558.360788509373, 5563.721813909207, 5577.832665020056, 5630.380658127685, 5640.802571909963], "value": 4785.190055470151, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.28587539046526, 360.9963900360996, 364.87229469685616, 368.8229649768113, 373.14177391998396, 5677.148427735841, 5715.857103572413, 5730.341010783761, 5775.624584402011, 5784.132380142981, 5555.388907220203, 5640.464155905182, 5644.266245388104, 5695.259616249892, 5698.037020749218, 4527.547245275479, 4533.591976722094, 4538.7503687297185, 4586.243269860469, 4593.1961906666365, 4325.394444777734, 4517.7289362638185, 4553.68124231304, 4588.541145885418, 4620.468646105707, 4468.932966005513, 4483.843065492709, 4488.8204471821255, 4491.550844915515, 4496.685232033759, 4479.708818926776, 4514.841980530666, 4518.999999999984, 4539.570035438859, 4551.95448045522, 3887.0, 4026.577209393001, 4068.3694027425795, 4086.346184610478, 4094.7747873866924, 5491.983982963165, 5493.615446918718, 5496.7526461309335, 5506.779728810843, 5538.307711536058, 5170.3278573785165, 5185.455527169631, 5195.454477279869, 5199.350081239845, 5220.92168617471, 5725.914111288334, 5991.340952495266, 6011.144706264533, 6021.849453763647, 6032.426919442646, 4460.174867649495, 4461.0, 4464.0402313502755, 4471.004427033862, 4471.642268618502, 6179.876402471926, 6182.474489668429, 6227.252729672423, 6239.0, 6239.344868788758, 4484.170428470743, 4553.430821147356, 4556.931646025312, 4561.270196768501, 4578.2903649934315, 4630.490646028934, 4641.74470404131, 4653.53464653532, 4656.4645065817185, 4660.650451216173, 5146.948530514722, 5207.297014903015, 5210.557102646242, 5233.71214583194, 5239.161734122522, 5767.740451679684, 5880.911786323209, 5957.702114894325, 5983.6708981005595, 5991.730372133177, 1546.481928553947, 1569.9450519232, 1572.2688949638243, 1572.8505791949747, 1579.5972027133007, 1073.5974009746344, 1088.8584484017026, 1100.0979197058334, 1104.2215238257008, 1118.904893084097, 5599.284347091657, 5604.430759387378, 5614.803481878196, 5641.548676105902, 5671.171958927707, 5912.320083190488, 5957.553183511167, 5984.431479009487, 5996.700164991733, 6012.188354572077, 5343.385510666245, 5533.474319939599, 5572.0527510323345, 5600.0, 5608.186812912187, 3136.4511210538067, 3153.4796758535044, 3156.2582793043616, 3161.2096975756062, 3162.525621156799, 5891.852703682356, 6039.456448919618, 6043.516518678495, 6067.969660151671, 6100.115483254903, 5962.55280853929, 5995.400459954057, 6009.519238460913, 6021.417256732238, 6076.240469941257, 5934.851628709231, 5985.127138973317, 6023.819285421357, 6095.696743832805, 6149.631022138686, 5766.452187042224, 5865.73604187804, 5883.294004719461, 5890.4993075587345, 5911.7635294587735, 5776.277965254343, 5810.796622118206, 5828.417158284137, 5860.648361098348, 5890.734916928663, 5819.0, 5940.910886336795, 6014.398560143951, 6068.4499567753355, 6085.2393450818645, 4414.426124603781, 4414.536473670219, 4429.557044295545, 4445.1998640245065, 4456.3511500744935, 5896.204012458264, 5979.402059793986, 5993.400659933972, 6033.637981721111, 6224.0, 6027.879442411215, 6033.215681961317, 6039.214902062704, 6041.69791510414, 6068.21113255274, 5981.222441082631, 6017.578769486269, 6024.518038556817, 6046.606970546901, 6124.448799608057, 5646.632968857011, 5963.7912673056235, 6005.378547791985, 6010.789622363372, 6021.969890150521, 6042.909356359746, 6064.363241859542, 6082.878342433038, 6095.573309868267, 6159.599626024294, 5684.687342196219, 5894.587378883437, 5905.173275741314, 5961.0, 6006.387221558636], "value": 4570.820805832809, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.0423661949325, 755.1391413788278, 813.4793732011511, 843.1989609870625, 862.585958739805, 15566.844331556695, 16378.918105409486, 16385.09881956492, 16430.507084787445, 16443.342266309348, 14616.196109213988, 14738.484153054646, 14748.041377310466, 14848.628784280398, 14864.702705945874, 840.1808236968952, 852.7612268564811, 854.6666799948025, 856.8072183758667, 862.017300277684, 822.4243029879078, 828.0808302783905, 828.1263267253046, 828.9844939948545, 829.4318391901567, 863.9136086391342, 865.7965378136164, 867.4101610904582, 870.4603146049458, 871.9171678690515, 865.5715420866649, 869.3306154261215, 869.8390797702446, 869.9391042627019, 870.4037734152126, 642.097852517214, 642.8425035866196, 643.0386572074732, 643.3084434233218, 645.07431835316, 14139.858601413956, 14156.221407822566, 14161.150330980072, 14161.716765664733, 14173.29133543329, 12165.817512737316, 12454.564090256888, 12768.936155319258, 12984.87015129846, 13470.730585388335, 11304.095672346275, 11325.773484530346, 11382.430878456044, 11500.424978751029, 11502.137339699557, 3854.325493038707, 3911.6870650347905, 3911.784851833148, 3946.4277679736565, 3965.345717956534, 68540.0, 69375.0, 69532.60934781327, 70077.29922700759, 72388.63805680937, 9549.045095490395, 9610.135087842127, 9690.854637180448, 9752.951235243778, 9877.506124693737, 20210.696839547418, 20235.392938211877, 20244.392668219683, 20331.898340508204, 20335.389938301876, 8246.299064579458, 8563.314934805201, 8867.600957956907, 8875.911240887637, 8876.167490288595, 4575.0, 4642.489326174118, 4714.9209878503825, 4785.736784476818, 4857.53853383928, 3550.467429885538, 3638.43604241343, 3680.2823449427106, 3712.554493460802, 3715.9442608360896, 603.2881200183825, 603.8852618002566, 604.1240201707454, 606.6966516741629, 621.4065567383228, 551.2475470982081, 586.1471558881817, 605.00174711726, 678.2708588267632, 694.2606124477416, 8607.268382187583, 9165.954170229106, 9208.217301529312, 9259.67591134307, 9558.426494410358, 652.3085529338916, 652.3704625036862, 677.9017042528806, 692.2177938929078, 695.3741632530763, 4070.61329173728, 4346.630536404441, 4360.149770794728, 4376.518582955872, 4378.190034843564, 91548.54225728962, 92732.0, 95659.52170239104, 97990.0, 98016.50991744996, 50290.497095029314, 61714.69142654258, 78330.21669783343, 79565.0, 81233.59383203165, 73249.0, 73268.2673173272, 73555.26444735484, 74814.62592687002, 76534.61732691301, 8204.712835050745, 8571.4000019998, 8587.441816281922, 8637.833892424442, 8709.695160669346, 50730.492695074056, 50865.49134508608, 50925.49074509207, 51352.229716555026, 52363.73818130885, 42765.35851962285, 46980.0, 67592.32407676057, 67777.32222677907, 67933.0, 10348.120409765253, 10452.843207351743, 10582.523786429476, 10613.09788667972, 11481.82777258325, 11981.76036479283, 12024.579139730067, 12125.81811272814, 12256.264624122581, 12700.118939201708, 10977.28647637901, 11146.721331966766, 11149.442527873736, 11164.88835111671, 11522.251053681484, 10454.32046916948, 10939.708135608336, 10964.068054215162, 10998.230123891251, 11063.612773552886, 11631.47658355393, 11734.295942243492, 11842.881571184178, 12196.146269761386, 12597.93701031489, 9471.384360016576, 9661.661841835783, 9866.210703143588, 9970.850437243302, 10116.84824727615, 8921.464712117293, 9203.35576509638, 9376.612551105454, 9406.568810639517, 9662.661806836726], "value": 6988.008973551398, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1467.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 112.0, 111.0, 112.0, 113.0, 112.0, 112.0, 112.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 127.0, 160.0, 123.0, 125.0, 124.0, 118.0, 155.0, 118.0], "value": 132.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 161.0, 163.0, 167.0, 165.0, 161.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 116.0, 76.0, 77.0, 76.0, 76.0, 97.0, 77.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 106.0, 83.0, 82.0, 82.0, 93.0, 82.0, 81.0, 108.0], "value": 88.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 119.0, 117.0, 118.0, 117.0, 119.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 85.0, 84.0, 85.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 54.0, 53.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 59.0, 58.0, 63.0, 57.0, 58.0, 58.0, 58.0, 57.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 81.0, 78.0, 88.0, 74.0, 74.0, 74.0, 75.0, 75.0, 79.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 135.0, 122.0, 122.0, 129.0, 128.0, 121.0, 133.0, 165.0, 125.0], "value": 132.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 159.0, 157.0, 157.0, 156.0, 155.0, 155.0, 156.0, 156.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 63.0, 61.0, 62.0, 64.0, 62.0, 69.0, 62.0], "value": 63.2, "unit": "score"}]}]} 21:04:36 INFO - Return code: 0 21:04:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:04:36 ERROR - # TBPL SUCCESS # 21:04:36 INFO - Running post-action listener: _resource_record_post_action 21:04:36 INFO - [mozharness: 2017-01-24 05:04:36.678065Z] Finished run-tests step (success) 21:04:36 INFO - Running post-run listener: _resource_record_post_run 21:04:36 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 321069056; Read time: 16; Write time: 369576 21:04:36 INFO - TinderboxPrint: CPU usage
13.3% 21:04:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 21:04:36 INFO - TinderboxPrint: I/O write bytes / time
321,069,056 / 369,576 21:04:36 INFO - TinderboxPrint: CPU idle
8,213.9 (86.7%) 21:04:36 INFO - TinderboxPrint: CPU user
1,203.5 (12.7%) 21:04:36 INFO - TinderboxPrint: Swap in / out
0 / 0 21:04:36 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 97652736; Read time: 0; Write time: 199324 21:04:36 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 219021312; Read time: 16; Write time: 168060 21:04:37 INFO - Running post-run listener: _upload_blobber_files 21:04:37 INFO - Blob upload gear active. 21:04:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:04:37 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 21:04:37 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:04:37 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:04:37 INFO - (blobuploader) - INFO - Open directory for files ... 21:04:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:04:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:04:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:04:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:04:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:04:40 INFO - (blobuploader) - INFO - Done attempting. 21:04:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:04:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:04:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:04:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:04:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:04:41 INFO - (blobuploader) - INFO - Done attempting. 21:04:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:04:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:04:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:04:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:04:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:04:42 INFO - (blobuploader) - INFO - Done attempting. 21:04:42 INFO - (blobuploader) - INFO - Iteration through files over. 21:04:42 INFO - Return code: 0 21:04:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:04:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:04:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5388c4a4618cc7413f811e06e6923e7a4df955846a4822a67783c4ff6b525b307a41df94871cda0ec8a2147d578be4c6f0b3cb539145e901e0b4b05fba7ad1aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/959c94d2a8ab737da87b5b73ec890c569e2314f70ae07484a7c75f0745a429a2b8f0918c861306fb850d687fe0ec7fcf82d11d6ba6314d76d1b7c5ac8b389492", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14fcb228e9983d5dc303447b2e5302ea86a443465cfc7465efa6c9fe249dd32c417bf0b1359cb8323cedac22b335a3640f9e2a63751e7ed555593aac16810ae8"} 21:04:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:04:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:04:42 INFO - Contents: 21:04:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5388c4a4618cc7413f811e06e6923e7a4df955846a4822a67783c4ff6b525b307a41df94871cda0ec8a2147d578be4c6f0b3cb539145e901e0b4b05fba7ad1aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/959c94d2a8ab737da87b5b73ec890c569e2314f70ae07484a7c75f0745a429a2b8f0918c861306fb850d687fe0ec7fcf82d11d6ba6314d76d1b7c5ac8b389492", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14fcb228e9983d5dc303447b2e5302ea86a443465cfc7465efa6c9fe249dd32c417bf0b1359cb8323cedac22b335a3640f9e2a63751e7ed555593aac16810ae8"} 21:04:42 INFO - Running post-run listener: copy_logs_to_upload_dir 21:04:42 INFO - Copying logs to upload dir... 21:04:42 INFO - mkdir: /builds/slave/test/build/upload/logs 21:04:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.645680 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-23 21:04:41.918553) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 21:04:41.922414) ========= 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=df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645 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-Beta/sha512/5388c4a4618cc7413f811e06e6923e7a4df955846a4822a67783c4ff6b525b307a41df94871cda0ec8a2147d578be4c6f0b3cb539145e901e0b4b05fba7ad1aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/959c94d2a8ab737da87b5b73ec890c569e2314f70ae07484a7c75f0745a429a2b8f0918c861306fb850d687fe0ec7fcf82d11d6ba6314d76d1b7c5ac8b389492", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14fcb228e9983d5dc303447b2e5302ea86a443465cfc7465efa6c9fe249dd32c417bf0b1359cb8323cedac22b335a3640f9e2a63751e7ed555593aac16810ae8"} build_url:https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/D5n44etuRKGLSzQn762U6w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5388c4a4618cc7413f811e06e6923e7a4df955846a4822a67783c4ff6b525b307a41df94871cda0ec8a2147d578be4c6f0b3cb539145e901e0b4b05fba7ad1aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/959c94d2a8ab737da87b5b73ec890c569e2314f70ae07484a7c75f0745a429a2b8f0918c861306fb850d687fe0ec7fcf82d11d6ba6314d76d1b7c5ac8b389492", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14fcb228e9983d5dc303447b2e5302ea86a443465cfc7465efa6c9fe249dd32c417bf0b1359cb8323cedac22b335a3640f9e2a63751e7ed555593aac16810ae8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 21:04:41.947724) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 21:04:41.948084) ========= 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=df17445c3590ff7897617a0e00000225-1485233033.655551-1089370645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 21:04:42.032874) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 21:04:42.033209) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 21:04:42.033500) ========= ========= Total master_lag: 0.17 =========