builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1485572490.13 results: success (0) buildid: 20170127170820 builduid: 310438fba06a4f61b195b4506f3fbd00 revision: 23ca52f77b78bbb221a786c96def039dffd1da69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 19:01:30.127619) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 19:01:30.128268) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 19:01:30.128733) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 19:01:30.146975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 19:01:30.147582) ========= 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=6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-27 19:01:30-- 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% 40.0M=0s 2017-01-27 19:01:30 (40.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121688 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 19:01:30.283572) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 19:01:30.283882) ========= 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=6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018596 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 19:01:30.332982) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 19:01:30.333337) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 23ca52f77b78bbb221a786c96def039dffd1da69 --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 23ca52f77b78bbb221a786c96def039dffd1da69 --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=6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-27 19:01:30,405 truncating revision to first 12 chars 2017-01-27 19:01:30,405 Setting DEBUG logging. 2017-01-27 19:01:30,405 attempt 1/10 2017-01-27 19:01:30,405 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/23ca52f77b78?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-27 19:01:30,754 unpacking tar archive at: mozilla-beta-23ca52f77b78/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659593 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 19:01:31.006231) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 19:01:31.006574) ========= script_repo_revision: 23ca52f77b78bbb221a786c96def039dffd1da69 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 19:01:31.006969) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 19:01:31.007236) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 19:01:31.017684) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-01-27 19:01:31.018052) ========= /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=6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:01:31 INFO - MultiFileLogger online at 20170127 19:01:31 in /builds/slave/test 19:01:31 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 19:01:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:01:31 INFO - {'append_to_log': False, 19:01:31 INFO - 'base_work_dir': '/builds/slave/test', 19:01:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:01:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:01:31 INFO - 'branch': 'Mozilla-Beta', 19:01:31 INFO - 'buildbot_json_path': 'buildprops.json', 19:01:31 INFO - 'config_files': ('talos/linux_config.py',), 19:01:31 INFO - 'default_actions': ('clobber', 19:01:31 INFO - 'read-buildbot-config', 19:01:31 INFO - 'download-and-extract', 19:01:31 INFO - 'populate-webroot', 19:01:31 INFO - 'create-virtualenv', 19:01:31 INFO - 'install', 19:01:31 INFO - 'run-tests'), 19:01:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:01:31 INFO - 'download_minidump_stackwalk': True, 19:01:31 INFO - 'download_symbols': 'ondemand', 19:01:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:01:31 INFO - 'tooltool.py': '/tools/tooltool.py', 19:01:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:01:31 INFO - '/tools/misc-python/virtualenv.py')}, 19:01:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:01:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:01:31 INFO - 'installer_path': 'installer.exe', 19:01:31 INFO - 'log_level': 'info', 19:01:31 INFO - 'log_name': 'talos', 19:01:31 INFO - 'log_to_console': True, 19:01:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:01:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:01:31 INFO - 'opt_config_files': (), 19:01:31 INFO - 'pip_index': False, 19:01:31 INFO - 'sps_profile': False, 19:01:31 INFO - 'sps_profile_interval': 0, 19:01:31 INFO - 'suite': 'dromaeojs-e10s', 19:01:31 INFO - 'system_bits': '32', 19:01:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:01:31 INFO - 'title': 'talos-linux64-ix-050', 19:01:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:01:31 INFO - 'use_talos_json': True, 19:01:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:01:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:01:31 INFO - 'work_dir': 'build'} 19:01:31 INFO - [mozharness: 2017-01-28 03:01:31.189319Z] Running clobber step. 19:01:31 INFO - Running pre-action listener: _resource_record_pre_action 19:01:31 INFO - Running main action method: clobber 19:01:31 INFO - rmtree: /builds/slave/test/build 19:01:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:01:31 INFO - Running post-action listener: _resource_record_post_action 19:01:31 INFO - [mozharness: 2017-01-28 03:01:31.649915Z] Finished clobber step (success) 19:01:31 INFO - [mozharness: 2017-01-28 03:01:31.650015Z] Running read-buildbot-config step. 19:01:31 INFO - Running pre-action listener: _resource_record_pre_action 19:01:31 INFO - Running main action method: read_buildbot_config 19:01:31 INFO - Using buildbot properties: 19:01:31 INFO - { 19:01:31 INFO - "project": "", 19:01:31 INFO - "product": "firefox", 19:01:31 INFO - "script_repo_revision": "production", 19:01:31 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 19:01:31 INFO - "repository": "", 19:01:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 19:01:31 INFO - "buildid": "20170127170820", 19:01:31 INFO - "pgo_build": "True", 19:01:31 INFO - "basedir": "/builds/slave/test", 19:01:31 INFO - "buildnumber": 318, 19:01:31 INFO - "slavename": "talos-linux64-ix-050", 19:01:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:01:31 INFO - "platform": "ubuntu64_hw", 19:01:31 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 19:01:31 INFO - "branch": "mozilla-beta", 19:01:31 INFO - "repo_path": "releases/mozilla-beta", 19:01:31 INFO - "revision": "23ca52f77b78bbb221a786c96def039dffd1da69", 19:01:31 INFO - "stage_platform": "linux64-pgo", 19:01:31 INFO - "builduid": "310438fba06a4f61b195b4506f3fbd00", 19:01:31 INFO - "slavebuilddir": "test" 19:01:31 INFO - } 19:01:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 19:01:31 INFO - Running post-action listener: _resource_record_post_action 19:01:31 INFO - [mozharness: 2017-01-28 03:01:31.652428Z] Finished read-buildbot-config step (success) 19:01:31 INFO - [mozharness: 2017-01-28 03:01:31.652516Z] Running download-and-extract step. 19:01:31 INFO - Running pre-action listener: _resource_record_pre_action 19:01:31 INFO - Running main action method: download_and_extract 19:01:31 INFO - mkdir: /builds/slave/test/build/tests 19:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:31 INFO - trying https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 19:01:31 INFO - Downloading https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/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 19:01:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/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 19:01:32 INFO - Downloaded 1327 bytes. 19:01:32 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 19:01:32 INFO - Using the following test package requirements: 19:01:32 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 19:01:32 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 19:01:32 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 19:01:32 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 19:01:32 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 19:01:32 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 19:01:32 INFO - u'jsshell-linux-x86_64.zip'], 19:01:32 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 19:01:32 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 19:01:32 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 19:01:32 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 19:01:32 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 19:01:32 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 19:01:32 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 19:01:32 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 19:01:32 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 19:01:32 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 19:01:32 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 19:01:32 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:01:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 19:01:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:01:32 INFO - Fetch https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 19:01:32 INFO - Http code: 200 19:01:32 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 19:01:32 INFO - x-amz-cf-id: VpJU9zky3Zum5r4luqebBjoDqn6q_tcotcQiS435PbAWjKe4DzEyuQ== 19:01:32 INFO - x-amz-version-id: PBksCugMaAkCB9oYmruyfvuAWhFDTchv 19:01:33 INFO - Expected file size: 21951958 19:01:33 INFO - Obtained file size: 21951958 19:01:36 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 19:01:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 19:01:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:01:36 INFO - Fetch https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 19:01:37 INFO - Http code: 200 19:01:37 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 19:01:37 INFO - x-amz-cf-id: o_XP4cuYaTt_2bD3Pe5bBS5eEC9g483A4b0iKoTbQkmWRvVKmBYG7g== 19:01:37 INFO - x-amz-version-id: PBksCugMaAkCB9oYmruyfvuAWhFDTchv 19:01:37 INFO - Expected file size: 21951958 19:01:37 INFO - Obtained file size: 21951958 19:01:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 19:01:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:01:42 INFO - Fetch https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 19:01:42 INFO - Http code: 200 19:01:42 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 19:01:42 INFO - x-amz-cf-id: -6V23hVOJv7N8a_f56OO-vF3qs6clmwmmFbbQRSRO4JVV3NG6wJmYQ== 19:01:42 INFO - x-amz-version-id: TWH.RGSyfxtD9ie2KM2c803fWPatDw6O 19:01:42 INFO - Expected file size: 14403005 19:01:42 INFO - Obtained file size: 14403005 19:01:43 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')]} 19:01:43 INFO - trying https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 19:01:43 INFO - Downloading https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/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 19:01:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/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 19:01:44 INFO - Downloaded 57702224 bytes. 19:01:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 19:01:44 INFO - mkdir: /builds/slave/test/properties 19:01:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:01:44 INFO - Writing to file /builds/slave/test/properties/build_url 19:01:44 INFO - Contents: 19:01:44 INFO - build_url:https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 19:01:45 INFO - Running post-action listener: _resource_record_post_action 19:01:45 INFO - Running post-action listener: set_extra_try_arguments 19:01:45 INFO - [mozharness: 2017-01-28 03:01:45.029436Z] Finished download-and-extract step (success) 19:01:45 INFO - [mozharness: 2017-01-28 03:01:45.029702Z] Running populate-webroot step. 19:01:45 INFO - Running pre-action listener: _resource_record_pre_action 19:01:45 INFO - Running main action method: populate_webroot 19:01:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:01:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:01:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:01:45 INFO - '--tppagecycles', 19:01:45 INFO - '7'], 19:01:45 INFO - 'tests': ['tsvgm']}}, 19:01:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:01:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:01:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:01:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:01:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:01:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:01:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:45 INFO - 'talos_options': ['--disable-e10s'], 19:01:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:01:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:01:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:45 INFO - 'talos_options': ['--disable-e10s'], 19:01:45 INFO - 'tests': ['damp', 'tps']}, 19:01:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:45 INFO - 'tests': ['damp', 'tps']}, 19:01:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:01:45 INFO - 'tests': ['dromaeo_dom']}, 19:01:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:01:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:01:45 INFO - 'tests': ['basic_compositor_video']}, 19:01:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:01:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:01:45 INFO - 'tests': ['a11yr', 19:01:45 INFO - 'ts_paint', 19:01:45 INFO - 'tpaint', 19:01:45 INFO - 'sessionrestore', 19:01:45 INFO - 'sessionrestore_no_auto_restore', 19:01:45 INFO - 'tabpaint']}, 19:01:45 INFO - 'other-e10s': {'tests': ['a11yr', 19:01:45 INFO - 'ts_paint', 19:01:45 INFO - 'tpaint', 19:01:45 INFO - 'sessionrestore', 19:01:45 INFO - 'sessionrestore_no_auto_restore', 19:01:45 INFO - 'tabpaint']}, 19:01:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:01:45 INFO - 'ts_paint', 19:01:45 INFO - 'tpaint', 19:01:45 INFO - 'sessionrestore', 19:01:45 INFO - 'sessionrestore_no_auto_restore', 19:01:45 INFO - 'tabpaint']}, 19:01:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:01:45 INFO - 'ts_paint', 19:01:45 INFO - 'tpaint', 19:01:45 INFO - 'sessionrestore', 19:01:45 INFO - 'sessionrestore_no_auto_restore', 19:01:45 INFO - 'tabpaint']}, 19:01:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:01:45 INFO - 'tests': ['a11yr', 19:01:45 INFO - 'ts_paint', 19:01:45 INFO - 'tpaint', 19:01:45 INFO - 'sessionrestore', 19:01:45 INFO - 'sessionrestore_no_auto_restore', 19:01:45 INFO - 'tabpaint']}, 19:01:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:01:45 INFO - 'tests': ['a11yr', 19:01:45 INFO - 'ts_paint', 19:01:45 INFO - 'tpaint', 19:01:45 INFO - 'sessionrestore', 19:01:45 INFO - 'sessionrestore_no_auto_restore', 19:01:45 INFO - 'tabpaint']}, 19:01:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:01:45 INFO - 'tests': ['tsvgx', 19:01:45 INFO - 'tsvgr_opacity', 19:01:45 INFO - 'tart', 19:01:45 INFO - 'tscrollx', 19:01:45 INFO - 'cart']}, 19:01:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:01:45 INFO - 'tsvgr_opacity', 19:01:45 INFO - 'tart', 19:01:45 INFO - 'tscrollx', 19:01:45 INFO - 'cart']}, 19:01:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:45 INFO - 'talos_options': ['--disable-e10s'], 19:01:45 INFO - 'tests': ['tp5o']}, 19:01:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:45 INFO - 'tests': ['tp5o']}, 19:01:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:45 INFO - 'talos_options': ['--disable-e10s', 19:01:45 INFO - '--xperf_path', 19:01:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:01:45 INFO - 'tests': ['tp5n']}, 19:01:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:45 INFO - 'talos_options': ['--xperf_path', 19:01:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:01:45 INFO - 'tests': ['tp5n']}}, 19:01:45 INFO - 'talos.zip': {'path': '', 19:01:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:01:45 INFO - Running post-action listener: _resource_record_post_action 19:01:45 INFO - [mozharness: 2017-01-28 03:01:45.045452Z] Finished populate-webroot step (success) 19:01:45 INFO - [mozharness: 2017-01-28 03:01:45.045562Z] Running create-virtualenv step. 19:01:45 INFO - Running pre-action listener: _resource_record_pre_action 19:01:45 INFO - Running main action method: create_virtualenv 19:01:45 INFO - Creating virtualenv /builds/slave/test/build/venv 19:01:45 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 19:01:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:01:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:01:45 INFO - Using real prefix '/usr' 19:01:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:01:45 INFO - Installing distribute.............................................................................................................................................................................................done. 19:01:47 INFO - Installing pip.................done. 19:01:47 INFO - Return code: 0 19:01:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:01:47 INFO - Reading from file tmpfile_stdout 19:01:47 INFO - Output received: 19:01:47 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) 19:01:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:47 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 0x7fdb2950ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1681ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167ef60>, '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 0x167fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16801d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', '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 19:01:47 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 19:01:47 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 19:01:47 INFO - Using env: {'DISPLAY': ':0', 19:01:47 INFO - 'HOME': '/home/cltbld', 19:01:47 INFO - 'LANG': 'en_US.UTF-8', 19:01:47 INFO - 'LANGUAGE': 'en_US:en', 19:01:47 INFO - 'LOGNAME': 'cltbld', 19:01:47 INFO - 'MAIL': '/var/mail/cltbld', 19:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:47 INFO - 'MOZ_NO_REMOTE': '1', 19:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:47 INFO - 'NO_EM_RESTART': '1', 19:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:47 INFO - 'PWD': '/builds/slave/test', 19:01:47 INFO - 'SHELL': '/bin/bash', 19:01:47 INFO - 'SHLVL': '1', 19:01:47 INFO - 'TERM': 'linux', 19:01:47 INFO - 'TMOUT': '86400', 19:01:47 INFO - 'USER': 'cltbld', 19:01:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', 19:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:47 INFO - '_': '/tools/buildbot/bin/python'} 19:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:48 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 19:01:48 INFO - Cleaning up... 19:01:48 INFO - Return code: 0 19:01:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:01: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')]} 19:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01: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')]} 19:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01: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', '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 0x7fdb2950ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1681ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167ef60>, '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 0x167fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16801d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', '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 19:01: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', 'psutil>=3.1.1'] in /builds/slave/test/build 19:01: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 psutil>=3.1.1 19:01:48 INFO - Using env: {'DISPLAY': ':0', 19:01:48 INFO - 'HOME': '/home/cltbld', 19:01:48 INFO - 'LANG': 'en_US.UTF-8', 19:01:48 INFO - 'LANGUAGE': 'en_US:en', 19:01:48 INFO - 'LOGNAME': 'cltbld', 19:01:48 INFO - 'MAIL': '/var/mail/cltbld', 19:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:48 INFO - 'MOZ_NO_REMOTE': '1', 19:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:48 INFO - 'NO_EM_RESTART': '1', 19:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:48 INFO - 'PWD': '/builds/slave/test', 19:01:48 INFO - 'SHELL': '/bin/bash', 19:01:48 INFO - 'SHLVL': '1', 19:01:48 INFO - 'TERM': 'linux', 19:01:48 INFO - 'TMOUT': '86400', 19:01:48 INFO - 'USER': 'cltbld', 19:01:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', 19:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:48 INFO - '_': '/tools/buildbot/bin/python'} 19:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:48 INFO - Downloading/unpacking psutil>=3.1.1 19:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:01:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:01:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:01:50 INFO - Installing collected packages: psutil 19:01:50 INFO - Running setup.py install for psutil 19:01:50 INFO - building 'psutil._psutil_linux' extension 19:01:50 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 19:01:50 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 19:01:50 INFO - building 'psutil._psutil_posix' extension 19:01:50 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 19:01:50 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 19:01:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:01:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:01:50 INFO - Successfully installed psutil 19:01:50 INFO - Cleaning up... 19:01:50 INFO - Return code: 0 19:01:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb2950ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1681ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167ef60>, '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 0x167fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16801d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', '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 19:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:01:50 INFO - Using env: {'DISPLAY': ':0', 19:01:50 INFO - 'HOME': '/home/cltbld', 19:01:50 INFO - 'LANG': 'en_US.UTF-8', 19:01:50 INFO - 'LANGUAGE': 'en_US:en', 19:01:50 INFO - 'LOGNAME': 'cltbld', 19:01:50 INFO - 'MAIL': '/var/mail/cltbld', 19:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:50 INFO - 'MOZ_NO_REMOTE': '1', 19:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:50 INFO - 'NO_EM_RESTART': '1', 19:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:50 INFO - 'PWD': '/builds/slave/test', 19:01:50 INFO - 'SHELL': '/bin/bash', 19:01:50 INFO - 'SHLVL': '1', 19:01:50 INFO - 'TERM': 'linux', 19:01:50 INFO - 'TMOUT': '86400', 19:01:50 INFO - 'USER': 'cltbld', 19:01:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', 19:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:50 INFO - '_': '/tools/buildbot/bin/python'} 19:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:01:51 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 19:01:51 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 19:01:51 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 19:01:51 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 19:01:51 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 19:01:51 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 19:01:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:01:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:01:53 INFO - Installing collected packages: mozsystemmonitor 19:01:53 INFO - Running setup.py install for mozsystemmonitor 19:01:53 INFO - Successfully installed mozsystemmonitor 19:01:53 INFO - Cleaning up... 19:01:53 INFO - Return code: 0 19:01:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb2950ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1681ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167ef60>, '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 0x167fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16801d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', '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 19:01:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:01:53 INFO - Using env: {'DISPLAY': ':0', 19:01:53 INFO - 'HOME': '/home/cltbld', 19:01:53 INFO - 'LANG': 'en_US.UTF-8', 19:01:53 INFO - 'LANGUAGE': 'en_US:en', 19:01:53 INFO - 'LOGNAME': 'cltbld', 19:01:53 INFO - 'MAIL': '/var/mail/cltbld', 19:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:53 INFO - 'MOZ_NO_REMOTE': '1', 19:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:53 INFO - 'NO_EM_RESTART': '1', 19:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:53 INFO - 'PWD': '/builds/slave/test', 19:01:53 INFO - 'SHELL': '/bin/bash', 19:01:53 INFO - 'SHLVL': '1', 19:01:53 INFO - 'TERM': 'linux', 19:01:53 INFO - 'TMOUT': '86400', 19:01:53 INFO - 'USER': 'cltbld', 19:01:53 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', 19:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:53 INFO - '_': '/tools/buildbot/bin/python'} 19:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:53 INFO - Downloading/unpacking jsonschema==2.5.1 19:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:01:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:55 INFO - Downloading functools32-3.2.3-2.tar.gz 19:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:01:55 INFO - warning: no files found matching '*.txt' 19:01:55 INFO - no previously-included directories found matching 'build' 19:01:55 INFO - no previously-included directories found matching 'dist' 19:01:55 INFO - no previously-included directories found matching '.git*' 19:01:55 INFO - Installing collected packages: jsonschema, functools32 19:01:55 INFO - Running setup.py install for functools32 19:01:56 INFO - warning: no files found matching '*.txt' 19:01:56 INFO - no previously-included directories found matching 'build' 19:01:56 INFO - no previously-included directories found matching 'dist' 19:01:56 INFO - no previously-included directories found matching '.git*' 19:01:56 INFO - Successfully installed jsonschema functools32 19:01:56 INFO - Cleaning up... 19:01:56 INFO - Return code: 0 19:01:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:56 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 0x7fdb2950ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1681ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167ef60>, '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 0x167fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16801d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', '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 19:01:56 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 19:01:56 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 19:01:56 INFO - Using env: {'DISPLAY': ':0', 19:01:56 INFO - 'HOME': '/home/cltbld', 19:01:56 INFO - 'LANG': 'en_US.UTF-8', 19:01:56 INFO - 'LANGUAGE': 'en_US:en', 19:01:56 INFO - 'LOGNAME': 'cltbld', 19:01:56 INFO - 'MAIL': '/var/mail/cltbld', 19:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:56 INFO - 'MOZ_NO_REMOTE': '1', 19:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:56 INFO - 'NO_EM_RESTART': '1', 19:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:56 INFO - 'PWD': '/builds/slave/test', 19:01:56 INFO - 'SHELL': '/bin/bash', 19:01:56 INFO - 'SHLVL': '1', 19:01:56 INFO - 'TERM': 'linux', 19:01:56 INFO - 'TMOUT': '86400', 19:01:56 INFO - 'USER': 'cltbld', 19:01:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', 19:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:56 INFO - '_': '/tools/buildbot/bin/python'} 19:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:01:56 INFO - Cleaning up... 19:01:56 INFO - Return code: 0 19:01:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:56 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 0x7fdb2950ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1681ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167ef60>, '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 0x167fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16801d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', '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 19:01:56 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 19:01:56 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 19:01:56 INFO - Using env: {'DISPLAY': ':0', 19:01:56 INFO - 'HOME': '/home/cltbld', 19:01:56 INFO - 'LANG': 'en_US.UTF-8', 19:01:56 INFO - 'LANGUAGE': 'en_US:en', 19:01:56 INFO - 'LOGNAME': 'cltbld', 19:01:56 INFO - 'MAIL': '/var/mail/cltbld', 19:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:56 INFO - 'MOZ_NO_REMOTE': '1', 19:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:56 INFO - 'NO_EM_RESTART': '1', 19:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:56 INFO - 'PWD': '/builds/slave/test', 19:01:56 INFO - 'SHELL': '/bin/bash', 19:01:56 INFO - 'SHLVL': '1', 19:01:56 INFO - 'TERM': 'linux', 19:01:56 INFO - 'TMOUT': '86400', 19:01:56 INFO - 'USER': 'cltbld', 19:01:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', 19:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:56 INFO - '_': '/tools/buildbot/bin/python'} 19:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:56 INFO - Downloading/unpacking blobuploader==1.2.4 19:01:56 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 19:01:56 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 19:01:56 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 19:01:56 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 19:01:56 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 19:01:56 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 19:01:58 INFO - Downloading blobuploader-1.2.4.tar.gz 19:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:01:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:01:58 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 19:01:58 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 19:01:58 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 19:01:58 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 19:01:58 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 19:01:58 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 19:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:01:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:01:59 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 19:01:59 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 19:01:59 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 19:01:59 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 19:01:59 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 19:01:59 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 19:01:59 INFO - Downloading docopt-0.6.1.tar.gz 19:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:01:59 INFO - Installing collected packages: blobuploader, requests, docopt 19:01:59 INFO - Running setup.py install for blobuploader 19:01:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:01:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:01:59 INFO - Running setup.py install for requests 19:01:59 INFO - Running setup.py install for docopt 19:01:59 INFO - Successfully installed blobuploader requests docopt 19:01:59 INFO - Cleaning up... 19:01:59 INFO - Return code: 0 19:01:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:59 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 0x7fdb2950ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1681ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167ef60>, '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 0x167fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16801d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', '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 19:01:59 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 19:01:59 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 19:01:59 INFO - Using env: {'DISPLAY': ':0', 19:01:59 INFO - 'HOME': '/home/cltbld', 19:01:59 INFO - 'LANG': 'en_US.UTF-8', 19:01:59 INFO - 'LANGUAGE': 'en_US:en', 19:01:59 INFO - 'LOGNAME': 'cltbld', 19:01:59 INFO - 'MAIL': '/var/mail/cltbld', 19:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:59 INFO - 'MOZ_NO_REMOTE': '1', 19:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:59 INFO - 'NO_EM_RESTART': '1', 19:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:59 INFO - 'PWD': '/builds/slave/test', 19:01:59 INFO - 'SHELL': '/bin/bash', 19:01:59 INFO - 'SHLVL': '1', 19:01:59 INFO - 'TERM': 'linux', 19:01:59 INFO - 'TMOUT': '86400', 19:01:59 INFO - 'USER': 'cltbld', 19:01:59 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', 19:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:59 INFO - '_': '/tools/buildbot/bin/python'} 19:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:02:00 INFO - Running setup.py (path:/tmp/pip-7vHulM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:02:00 INFO - Running setup.py (path:/tmp/pip-IHzLu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:02:00 INFO - Running setup.py (path:/tmp/pip-nGUiA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:02:00 INFO - Running setup.py (path:/tmp/pip-XUtGjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:02:00 INFO - Running setup.py (path:/tmp/pip-xAmebi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:02:00 INFO - Running setup.py (path:/tmp/pip-aNI6VZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:02:00 INFO - Running setup.py (path:/tmp/pip-dTDzr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:02:00 INFO - Running setup.py (path:/tmp/pip-xCpkQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:02:00 INFO - Running setup.py (path:/tmp/pip-vP7BPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:02:00 INFO - Running setup.py (path:/tmp/pip-dhCHTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:02:00 INFO - Running setup.py (path:/tmp/pip-rV4m25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:02:00 INFO - Running setup.py (path:/tmp/pip-3ktO4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:02:01 INFO - Running setup.py (path:/tmp/pip-ZIvk49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:02:01 INFO - Running setup.py (path:/tmp/pip-FNx0bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:01 INFO - Running setup.py (path:/tmp/pip-ACBDKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:02:01 INFO - Running setup.py (path:/tmp/pip-dnHGUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:02:01 INFO - Running setup.py (path:/tmp/pip-crTYAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:02:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:02:01 INFO - Running setup.py install for manifestparser 19:02:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:02:01 INFO - Running setup.py install for mozcrash 19:02:01 INFO - Running setup.py install for mozdebug 19:02:01 INFO - Running setup.py install for mozdevice 19:02:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:02:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:02:01 INFO - Running setup.py install for mozfile 19:02:01 INFO - Running setup.py install for mozhttpd 19:02:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:02:02 INFO - Running setup.py install for mozinfo 19:02:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:02:02 INFO - Running setup.py install for mozInstall 19:02:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:02:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:02:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:02:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:02:02 INFO - Running setup.py install for mozleak 19:02:02 INFO - Running setup.py install for mozlog 19:02:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:02:02 INFO - Running setup.py install for moznetwork 19:02:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:02:02 INFO - Running setup.py install for mozprocess 19:02:02 INFO - Running setup.py install for mozprofile 19:02:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:02:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:02:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:02:02 INFO - Running setup.py install for mozrunner 19:02:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:02:02 INFO - Running setup.py install for mozscreenshot 19:02:02 INFO - Running setup.py install for moztest 19:02:03 INFO - Running setup.py install for mozversion 19:02:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:02:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:02:03 INFO - Cleaning up... 19:02:03 INFO - Return code: 0 19:02:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:03 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 0x7fdb2950ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1681ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167ef60>, '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 0x167fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16801d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', '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 19:02:03 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 19:02:03 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 19:02:03 INFO - Using env: {'DISPLAY': ':0', 19:02:03 INFO - 'HOME': '/home/cltbld', 19:02:03 INFO - 'LANG': 'en_US.UTF-8', 19:02:03 INFO - 'LANGUAGE': 'en_US:en', 19:02:03 INFO - 'LOGNAME': 'cltbld', 19:02:03 INFO - 'MAIL': '/var/mail/cltbld', 19:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:03 INFO - 'MOZ_NO_REMOTE': '1', 19:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:03 INFO - 'NO_EM_RESTART': '1', 19:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:03 INFO - 'PWD': '/builds/slave/test', 19:02:03 INFO - 'SHELL': '/bin/bash', 19:02:03 INFO - 'SHLVL': '1', 19:02:03 INFO - 'TERM': 'linux', 19:02:03 INFO - 'TMOUT': '86400', 19:02:03 INFO - 'USER': 'cltbld', 19:02:03 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', 19:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:03 INFO - '_': '/tools/buildbot/bin/python'} 19:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:02:03 INFO - Running setup.py (path:/tmp/pip-mFuwt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:02:03 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)) 19:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:02:03 INFO - Running setup.py (path:/tmp/pip-g12IhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:02:03 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)) 19:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:02:03 INFO - Running setup.py (path:/tmp/pip-FZGnnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:02:03 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)) 19:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:02:03 INFO - Running setup.py (path:/tmp/pip-CDcKQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:02:03 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)) 19:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:02:03 INFO - Running setup.py (path:/tmp/pip-3KJGlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:02:03 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)) 19:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:02:03 INFO - Running setup.py (path:/tmp/pip-Dxp06D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:02:03 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)) 19:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:02:03 INFO - Running setup.py (path:/tmp/pip-AoJSK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:02:03 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)) 19:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:02:03 INFO - Running setup.py (path:/tmp/pip-Hsq4Br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:02:04 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)) 19:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:02:04 INFO - Running setup.py (path:/tmp/pip-4irVq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:02:04 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)) 19:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:02:04 INFO - Running setup.py (path:/tmp/pip-FksxkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:02:04 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)) 19:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:02:04 INFO - Running setup.py (path:/tmp/pip-m0x0hX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:02:04 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)) 19:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:02:04 INFO - Running setup.py (path:/tmp/pip-MMh_ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:02:04 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)) 19:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:02:04 INFO - Running setup.py (path:/tmp/pip-Mae2gZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:02:04 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)) 19:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:02:04 INFO - Running setup.py (path:/tmp/pip-YMQSLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:02:04 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)) 19:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:04 INFO - Running setup.py (path:/tmp/pip-kbrqi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:04 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)) 19:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:02:04 INFO - Running setup.py (path:/tmp/pip-O2UzaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:02:04 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)) 19:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:02:04 INFO - Running setup.py (path:/tmp/pip-zaVDSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:02:04 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)) 19:02:04 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)) 19:02:04 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)) 19:02:04 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)) 19:02:04 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)) 19:02:04 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)) 19:02:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:02:04 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 19:02:04 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 19:02:04 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 19:02:04 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 19:02:04 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 19:02:04 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 19:02:06 INFO - Downloading blessings-1.6.tar.gz 19:02:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:02:06 INFO - Installing collected packages: blessings 19:02:06 INFO - Running setup.py install for blessings 19:02:06 INFO - Successfully installed blessings 19:02:06 INFO - Cleaning up... 19:02:06 INFO - Return code: 0 19:02:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:02:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:02:07 INFO - Reading from file tmpfile_stdout 19:02:07 INFO - Current package versions: 19:02:07 INFO - argparse == 1.2.1 19:02:07 INFO - blessings == 1.6 19:02:07 INFO - blobuploader == 1.2.4 19:02:07 INFO - docopt == 0.6.1 19:02:07 INFO - functools32 == 3.2.3-2 19:02:07 INFO - jsonschema == 2.5.1 19:02:07 INFO - manifestparser == 1.1 19:02:07 INFO - mozInstall == 1.12 19:02:07 INFO - mozcrash == 1.0 19:02:07 INFO - mozdebug == 0.1 19:02:07 INFO - mozdevice == 0.48 19:02:07 INFO - mozfile == 1.2 19:02:07 INFO - mozhttpd == 0.7 19:02:07 INFO - mozinfo == 0.9 19:02:07 INFO - mozleak == 0.1 19:02:07 INFO - mozlog == 3.4 19:02:07 INFO - moznetwork == 0.27 19:02:07 INFO - mozprocess == 0.23 19:02:07 INFO - mozprofile == 0.28 19:02:07 INFO - mozrunner == 6.13 19:02:07 INFO - mozscreenshot == 0.1 19:02:07 INFO - mozsystemmonitor == 0.3 19:02:07 INFO - moztest == 0.8 19:02:07 INFO - mozversion == 1.4 19:02:07 INFO - psutil == 3.1.1 19:02:07 INFO - requests == 1.2.3 19:02:07 INFO - wsgiref == 0.1.2 19:02:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02:07 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')]} 19:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:07 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')]} 19:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:07 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 0x7fdb2950ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1681ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167ef60>, '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 0x167fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16801d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', '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 19:02:07 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 19:02:07 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 19:02:07 INFO - Using env: {'DISPLAY': ':0', 19:02:07 INFO - 'HOME': '/home/cltbld', 19:02:07 INFO - 'LANG': 'en_US.UTF-8', 19:02:07 INFO - 'LANGUAGE': 'en_US:en', 19:02:07 INFO - 'LOGNAME': 'cltbld', 19:02:07 INFO - 'MAIL': '/var/mail/cltbld', 19:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:07 INFO - 'MOZ_NO_REMOTE': '1', 19:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:07 INFO - 'NO_EM_RESTART': '1', 19:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:07 INFO - 'PWD': '/builds/slave/test', 19:02:07 INFO - 'SHELL': '/bin/bash', 19:02:07 INFO - 'SHLVL': '1', 19:02:07 INFO - 'TERM': 'linux', 19:02:07 INFO - 'TMOUT': '86400', 19:02:07 INFO - 'USER': 'cltbld', 19:02:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', 19:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:07 INFO - '_': '/tools/buildbot/bin/python'} 19:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:07 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)) 19:02:07 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)) 19:02:07 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)) 19:02:07 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)) 19:02:07 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)) 19:02:07 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)) 19:02:07 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)) 19:02:07 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)) 19:02:07 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)) 19:02:07 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)) 19:02:07 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)) 19:02:07 INFO - Cleaning up... 19:02:07 INFO - Return code: 0 19:02:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:02:07 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')]} 19:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:07 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')]} 19:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:07 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 0x7fdb2950ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1681ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167ef60>, '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 0x167fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16801d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', '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 19:02:07 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 19:02:07 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 19:02:07 INFO - Using env: {'DISPLAY': ':0', 19:02:07 INFO - 'HOME': '/home/cltbld', 19:02:07 INFO - 'LANG': 'en_US.UTF-8', 19:02:07 INFO - 'LANGUAGE': 'en_US:en', 19:02:07 INFO - 'LOGNAME': 'cltbld', 19:02:07 INFO - 'MAIL': '/var/mail/cltbld', 19:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:07 INFO - 'MOZ_NO_REMOTE': '1', 19:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:07 INFO - 'NO_EM_RESTART': '1', 19:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:07 INFO - 'PWD': '/builds/slave/test', 19:02:07 INFO - 'SHELL': '/bin/bash', 19:02:07 INFO - 'SHLVL': '1', 19:02:07 INFO - 'TERM': 'linux', 19:02:07 INFO - 'TMOUT': '86400', 19:02:07 INFO - 'USER': 'cltbld', 19:02:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', 19:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:07 INFO - '_': '/tools/buildbot/bin/python'} 19:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:02:07 INFO - Cleaning up... 19:02:07 INFO - Return code: 0 19:02:07 INFO - Running post-action listener: _resource_record_post_action 19:02:07 INFO - Running post-action listener: _start_resource_monitoring 19:02:07 INFO - Starting resource monitoring. 19:02:07 INFO - [mozharness: 2017-01-28 03:02:07.657853Z] Finished create-virtualenv step (success) 19:02:07 INFO - [mozharness: 2017-01-28 03:02:07.658353Z] Running install step. 19:02:07 INFO - Running pre-action listener: _resource_record_pre_action 19:02:07 INFO - Running main action method: install 19:02:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:02:07 INFO - Reading from file tmpfile_stdout 19:02:07 INFO - Detecting whether we're running mozinstall >=1.0... 19:02:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:02:07 INFO - Reading from file tmpfile_stdout 19:02:07 INFO - Output received: 19:02:07 INFO - Usage: mozinstall [options] installer 19:02:07 INFO - Options: 19:02:07 INFO - -h, --help show this help message and exit 19:02:07 INFO - -d DEST, --destination=DEST 19:02:07 INFO - Directory to install application into. [default: 19:02:07 INFO - "/builds/slave/test"] 19:02:07 INFO - --app=APP Application being installed. [default: firefox] 19:02:07 INFO - mkdir: /builds/slave/test/build/application 19:02:07 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'] 19:02:07 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 19:02:22 INFO - Reading from file tmpfile_stdout 19:02:22 INFO - Output received: 19:02:22 INFO - /builds/slave/test/build/application/firefox/firefox 19:02:22 INFO - Running post-action listener: _resource_record_post_action 19:02:22 INFO - [mozharness: 2017-01-28 03:02:22.165768Z] Finished install step (success) 19:02:22 INFO - [mozharness: 2017-01-28 03:02:22.166012Z] Running run-tests step. 19:02:22 INFO - Running pre-action listener: _resource_record_pre_action 19:02:22 INFO - Running main action method: run_tests 19:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:02:22 INFO - Python 2.7.3 19:02:22 INFO - Return code: 0 19:02:22 INFO - grabbing minidump binary from tooltool 19:02:22 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')]} 19:02:22 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 0x167ef60>, '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 0x167fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16801d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:02:22 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 19:02:22 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 19:02:22 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 19:02:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:02:22 INFO - Return code: 0 19:02:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:02:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:02:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:02:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:02:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:02:22 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/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 19:02:22 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/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 19:02:22 INFO - Using env: {'DISPLAY': ':0', 19:02:22 INFO - 'HOME': '/home/cltbld', 19:02:22 INFO - 'LANG': 'en_US.UTF-8', 19:02:22 INFO - 'LANGUAGE': 'en_US:en', 19:02:22 INFO - 'LOGNAME': 'cltbld', 19:02:22 INFO - 'MAIL': '/var/mail/cltbld', 19:02:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:02:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:22 INFO - 'MOZ_NO_REMOTE': '1', 19:02:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:22 INFO - 'NO_EM_RESTART': '1', 19:02:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:22 INFO - 'PWD': '/builds/slave/test', 19:02:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:02:22 INFO - 'SHELL': '/bin/bash', 19:02:22 INFO - 'SHLVL': '1', 19:02:22 INFO - 'TERM': 'linux', 19:02:22 INFO - 'TMOUT': '86400', 19:02:22 INFO - 'USER': 'cltbld', 19:02:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368', 19:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:22 INFO - '_': '/tools/buildbot/bin/python'} 19:02:22 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/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 19:02:22 INFO - mozversion application_buildid: 20170127170820 19:02:22 INFO - mozversion application_changeset: 23ca52f77b78bbb221a786c96def039dffd1da69 19:02:22 INFO - mozversion application_display_name: Firefox 19:02:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:02:22 INFO - mozversion application_name: Firefox 19:02:22 INFO - mozversion application_remotingname: firefox 19:02:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:02:22 INFO - mozversion application_vendor: Mozilla 19:02:22 INFO - mozversion application_version: 52.0 19:02:22 INFO - mozversion platform_buildid: 20170127170820 19:02:22 INFO - mozversion platform_changeset: 23ca52f77b78bbb221a786c96def039dffd1da69 19:02:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:02:22 INFO - mozversion platform_version: 52.0 19:02:22 INFO - using testdate: 1485572542 19:02:22 INFO - actual date: 1485572542 19:02:22 INFO - starting webserver on 'localhost:47795' 19:02:22 INFO - SUITE-START | Running 2 tests 19:02:22 INFO - TEST-START | dromaeo_css 19:02:22 INFO - operating with platform_type : linux_ 19:02:22 INFO - Initialising browser for dromaeo_css test... 19:02:22 INFO - TEST-INFO | started process 9141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp3Lev1/profile http://localhost:47795/getInfo.html) 19:02:26 INFO - PROCESS | 9141 | __metrics Screen width/height:1600/1200 19:02:26 INFO - PROCESS | 9141 | colorDepth:24 19:02:26 INFO - PROCESS | 9141 | Browser inner width/height: 1024/697 19:02:26 INFO - PROCESS | 9141 | __metrics 19:02:27 ERROR - PROCESS | 9141 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 19:02:27 INFO - TEST-INFO | 9141: exit 0 19:02:27 INFO - Browser initialized. 19:02:27 INFO - Running cycle 1/1 for dromaeo_css test... 19:02:27 INFO - TEST-INFO | started process 9271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp3Lev1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:02:39 INFO - PROCESS | 9271 | RSS: Main: 147734528 19:02:39 INFO - PROCESS | 9271 | 19:05:39 INFO - PROCESS | 9271 | Cycle 1(1): loaded http://localhost:47795/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47795/tests/dromaeo/cssquery-ext.html) 19:05:40 INFO - PROCESS | 9271 | RSS: Main: 153948160 19:05:40 INFO - PROCESS | 9271 | 19:08:42 INFO - PROCESS | 9271 | Cycle 1(1): loaded http://localhost:47795/tests/dromaeo/cssquery-ext.html (next: http://localhost:47795/tests/dromaeo/cssquery-jquery.html) 19:08:43 INFO - PROCESS | 9271 | RSS: Main: 151986176 19:08:43 INFO - PROCESS | 9271 | 19:11:44 INFO - PROCESS | 9271 | Cycle 1(1): loaded http://localhost:47795/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47795/tests/dromaeo/cssquery-mootools.html) 19:11:45 INFO - PROCESS | 9271 | RSS: Main: 150880256 19:11:45 INFO - PROCESS | 9271 | 19:14:47 INFO - PROCESS | 9271 | Cycle 1(1): loaded http://localhost:47795/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47795/tests/dromaeo/cssquery-prototype.html) 19:14:47 INFO - PROCESS | 9271 | RSS: Main: 153767936 19:14:47 INFO - PROCESS | 9271 | 19:17:50 INFO - PROCESS | 9271 | Cycle 1(1): loaded http://localhost:47795/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47795/tests/dromaeo/cssquery-yui.html) 19:17:50 INFO - PROCESS | 9271 | RSS: Main: 154165248 19:17:50 INFO - PROCESS | 9271 | 19:20:53 INFO - PROCESS | 9271 | Cycle 1(1): loaded http://localhost:47795/tests/dromaeo/cssquery-yui.html (next: http://localhost:47795/tests/dromaeo/cssquery-dojo.html) 19:20:53 INFO - PROCESS | 9271 | RSS: Main: 154722304 19:20:53 INFO - PROCESS | 9271 | 19:20:53 INFO - PROCESS | 9271 | __start_tp_report 19:20:53 INFO - PROCESS | 9271 | _x_x_mozilla_page_load 19:20:53 INFO - PROCESS | 9271 | _x_x_mozilla_page_load_details 19:20:53 INFO - PROCESS | 9271 | |i|pagename|runs| 19:20:53 INFO - PROCESS | 9271 | |0;dojo.html;3150.716435520803;3256.7231785298245;3267.820269885157;3293.1273212598667;3296.0770984124424;5616.691081990489;5644.689542075184;5660.716964151797;5665.235193248905;5672.120821272699;5640.210370548116;5729.3411257705375;5775.913361299574;5785.566082543815;5805.274340707411;5184.844454666357;5187.170052791555;5210.921836172461;5222.268882356454;5226.372835259775;5257.36911570612;5262.842114736564;5277.525022747952;5285.788568457277;5289.788408463676;5058.165402708549;5080;5178.249153872686;5286.259923610698;5287.339082614673;5248.370195576536;5278.762455689503;5285.656432331886;5322.2814919985885;5327.547158491494;5203.271541984125;5236.371635403738;5237.921431178535;5245.527902488794;5260.868478288074;5483.479069488392;5541.27963364764;5634.887302253973;5642.689652069134;5757.971210143923;6015.127806468081;6046.486048685867;6053.122297266916;6066.787662431838;6125.815438131368;6167.752094036047;6189.195404597373;6195.845103872394;6199.814005579795;6231.3145553989025;5685.687287199161;5746.655200687972;5753.539716822645;5772.538196944234;5791.218185544982;6160.722767475474;6254.468370188494;6266.404691554295;6270.811875643738;6272.18461599989;6011.158437818709;6042.365551617105;6048.5765996380715;6054.152418661391;6076.665783381868;5787.652740835563;5832.416758324133;5929.673867937305;6121.938780612226;6135.570510064253;5920.2895652521975;6015.909761353583;6028.638281703112;6039.063945088518;6070.757169713162;5976.103584462366;6025.487833534199;6034.1853849730605;6034.577579569388;6041.879162416727;4577.153226653079;4629.745364005012;4678.929816052762;4697.530246975343;4702.905941881211;4066.9796651017145;4094.28350038742;4101.097758493127;4138.772367519755;4200.075983283673;5811.389804070596;5852.795152169653;5864.296284445893;5871.383504732027;5884.764609415661;6015.4586087252355;6088.4824789893355;6088.878222435526;6098.5426093042315;6113.266408031065;5797.884042319214;5833.241678581842;5854.297484301911;5893.057110862327;6000.159977603052;5245.606579506552;5247.527722504993;5252.763625636855;5257.185136303879;5267.209918512254;6349.809505714744;6420.390062944013;6428.132202152649;6462.806115816533;6467.256265529524;5988.790392336247;6039.063945088518;6039.335673076046;6044.093385992136;6046.57673962836;6308.653024083719;6349.269833969152;6355.5551111421755;6365.64988925595;6407.1350367701625;5963.821085367446;5972.880542389041;5973.133895585029;5981.401859813984;6004.669743164168;5942.346341902301;6045.667488288186;6064.848378790565;6084.300305464752;6121.4490695837585;5989.1914591529585;5996.820095397145;6023.849403764766;6033.879322413615;6060.909086363797;5963.2844058713235;5985.072313791369;5987.251593550806;5991.730372133177;6003.969980150246;5721.771129154788;5823.912641310299;5827.766889324549;5989.970050149721;6006.969965150146;5853.970730146322;5978.790742323998;5991.161237426677;6008.5493587981955;6010.368911264254;5842.561807864512;5846.064629659234;5861.32594751609;5864.648121112747;5868.061110222344 19:20:53 INFO - PROCESS | 9271 | |1;ext.html;619.4703528483146;642.6272761798156;658.9670516474175;684.8082536889669;705.6874213962027;42274.78862605686;46094.30858537125;46113;46655.83360415991;46681.29978050332;47077;47346.763266183705;47590;47642.285365719545;47757.044859102796;8923.241524470412;9067.682631107913;9068.77328066797;9073.682421115262;9119.817603647924;8835.381523293372;8914.777130571723;8925.910740892572;8931.062238464965;8975.640974361018;8892.066333035034;8940.240079593243;8941.374103812735;8951.373403861733;8961.731148065535;8914.732558023237;8950.552472376356;8962.86555701665;8977;8990.68532601359;8876.289896808239;8904.73285801427;8910.732678019669;8913.955430222808;8972.775680607972;43127;43196.35205471889;43508.782456087836;43534.78232608816;43554;3774.414965680324;3806.5535096663366;3815.9046023849346;3850.8267127979307;3865.5168103987003;33015.83492082548;33340;33471.66528334734;33494.1626459338;33693.831530842435;4124.092699606082;4152.771597562133;4164.5210800758;4164.708470407073;4266.850660226908;379823;385629;387941;500690;502123.99999999633;65804;65858.34141658618;66399.33600664028;66450;66694.66652666802;72142.63928680323;72478.63760681268;72542;72619;72668.63665681638;18911.716324255147;19040.52398690044;19075.2369905205;19430.125644346037;19535.413937581896;14768.113913165245;14825.110493370217;14966.70066598662;14968.47610333633;15001.474948376754;20284.492887677927;20907.268245611634;20908.163673453197;21003;21022;7616.504927179826;7637.19809420014;7739;7743.922560774433;7920.722774702857;1021.8109649714827;1051.4112097225425;1153.210051114989;1160.3878556668283;1180.8701042885275;31501.52747708786;33200.1699957503;33508;33511.16222094467;33758.83120584382;1133.637236084445;1154.7575009247985;1187.8455800745849;1198.4906414773686;1235.172434468908;17051;17100;17470;17514.649707006043;17515.64968700619;505028;505982;506294;506710;507218;61365;61723.07415388773;61942.38057619366;62065;62115;1395.483671041721;1438.6906815034818;1445.862478421827;1452.2012892908858;1460.1166294391953;31701.524477133324;32829.671703282664;33043.66956330406;33394.66605334013;33829.32341353208;55722.72138639281;56346;56432.7178364122;56468.15297770454;56491.43508564862;368927;375028;376012;377701;377991;46552.301715474976;48616;48863;49463.752681236365;49951;48929;49626.75186624044;51256;52502.47497524976;52590.474095258556;41738.79130604328;44197;44866.77566612146;47270.76364618155;48739;43608.34587481254;44059.55940440683;45480.31779523376;46147;46172.307415388124;44021.11957760891;44719;44807.55192448164;45543.54456455393;45628;38368.232635346576;39539.209215816096;40151.1969760609;40163.79918100391;40831.18337633171;29107.272318192216;30621.387572248877;30625.540616890317;31495.84252078725;32150.839245804556 19:20:53 INFO - PROCESS | 9271 | |2;jquery.html;413.95239547452036;416.4523651398409;416.48148055670674;421.4626351401963;428.84561557839174;18586.442406727787;19721.112549935235;19950.30173943912;20073.799262007375;20183.798162018375;16239;17077.91461042696;19323.130459129337;19777;19908.50228744282;5574.386817450088;5792.391798861122;5825.388334224909;5826.912596311059;5831.620944638585;5604.327480702322;5670.319561652587;5705.743241554119;5759.3376761672525;5769.682667453289;5817.767289308444;5831.125331200333;5845.503132233765;5876.9118463223085;5888.558358123137;5653.236813030229;5692.402297758758;5835.649861008353;5842.036064049426;5850.122481627747;5170.45710200431;5194.896102077937;5197.246399272122;5220.086484865134;5238.004779091961;22405.887970560205;23348.416289592726;23533.29400117999;23910.402239943967;24272;2443.0350011745263;2480.6651102101346;2559.4881023795315;2960.7335339819306;2985.1641540368732;10317.948410257975;10893.509792059298;10933.398663073527;11064.05955493784;11076.446177691163;1987.7813440521531;2016.84873634478;2041.7039529268322;2045.3250427358935;2061.1446249806313;85869;91254.54372728094;91746;91862.08137918603;92845.53577232138;11433.942830285961;11693.239939404082;11763.529458821722;11912.40437978115;12296.385180740926;16746.6650666986;16833;16854.57863553421;16899.15504224784;16914.830851691324;8290.378221633402;8338.874916876252;8442.957785211034;8542.18849209324;8716.607752651145;7946.721864734706;7988.960055199803;8039.397045221632;8237.79405514867;8253.298469630148;5013.298138260647;5096.3182149890445;5100.464451232641;5118.923216151761;5280.735963201824;2086.5618220173933;2159.5788821179717;2189.321310393783;2189.715337006179;2192.9451763706033;940.8259471997702;1004.9849252261222;1049.3022140276782;1072.8605281313535;1097.9725506862233;18985.24059037623;19878.60242795136;19915.701264481046;19929;20076.69884951727;1016.5273147986074;1044.9791004180026;1045.1429827541342;1049.9895001050045;1050.9842352364722;9974.750631234278;10958.287711298899;11158.888411115948;11216.943915280535;11229.775404491864;165160;433858;445939;450239;450503;89974;92496.53751731332;95350.52324738471;98742.5062874681;100360.49819750854;494.42893458056005;513.9100657385018;519.8648351428656;520.9479052094761;522.6863881671043;11291.661250162508;11572.59495917639;11675.824862626898;11928.880711193124;12191.878081219074;30886;32422.027339179862;40535;42792.358114627685;43239;57092.714536427055;57722;58111.418885812294;58723.70638146782;59167.70416147892;8638.049814520524;8751.781205469913;8856.557172141496;8950.418222815497;9095.954520227357;12465.252084874573;13024.153430027018;13040.54358097462;13042.869571304165;13265.734685306046;11368.658940231806;11478.196526243082;11743.11926605491;12188.20776649515;12320.815187772012;11838.28970261787;12212.938935305267;12424.689382765504;12770.361481926053;12973.027022973503;12319.076069295019;12607.87392126067;12754.553590624284;12841.871581284067;12955.676108097374;9410.106039926197;9535.570899309409;9617.71146865595;9637.71086867395;9649.662261820802;11429.257098288585;11845.11161662896;12412.62762117138;12437.62687119388;12693.619191424272 19:20:53 INFO - PROCESS | 9271 | |3;mootools.html;1518.817741870975;1536.7925330080438;1713.4088739384915;1793.4171394296857;1827.1047186878434;7283.271672832714;7455;7513.812154696136;7944.046714394273;7945.284924356814;7799.961000195005;8078.232567906054;8082.232187942151;8234.094249632535;8261.628226729797;2487.2165267940586;2513.673222481075;2517.169334119745;2518.269701786489;2523.4069993551593;2445.987770061156;2482;2525.4696513732138;2526.1411120219122;2527.0776166699206;2405.893289087022;2422.3338581890034;2478.8140889433275;2485.751424857518;2488.278399264211;2485.9751402485927;2492.526419980207;2494.6382774497597;2502.737212592688;2512.560301947161;2449.130558651671;2473.653688483596;2492.750724927511;2493;2521.319243804181;8194.631241594143;8236.711715089943;8286.295664868494;8292.875606865902;8307.750767476986;5147.536721695028;5291.708956007418;5293.9735301323635;5297.788088476456;5317.521423071942;3234;3277.082416923265;3354.731621470301;3362.562866827321;3403.4724617684296;996.1632228927735;1021.7241344836852;1046.3094357723867;1082.1667316166508;1102.5369344875091;11010.449477526092;11035.779284414348;11105.944470277678;11121.22151449399;11130.610428634958;4461.910761784811;4669.486356500782;4715.3869996900185;4718.95281047192;4783.473817880031;9189.908100918905;9200.723978280663;9203.631854725736;9230.769230769285;9231.399959002643;5254.264402983586;5258.6581872178185;5261.263423120766;5267.552258058108;5289.973550132302;4705.529447055267;4853.95146048542;4866.805327786919;4873.02539492103;4911.950880491221;3773.962260377416;3833.9233215336094;3840.251151025523;3947.802609869495;3956.40653901917;1247.7067889046066;1257.415301884628;1260.7478504299177;1264.0961712375695;1287.291989405823;846.3745630131361;956.7177682583655;963.3208587945481;1015.2994433840627;1029.7785976015043;5646.153077038477;5648.802291919846;5746.0519014363;5753.568482363756;5880.26496687914;937.4937533731845;942.123824842889;953.1183655118987;953.2299754471051;975.7560609847538;3863.5943225961432;4046.2716710991717;4125.66994640428;4134.400511925754;4144.544100148981;9516.19112375442;9733.17268032211;9868.062534059252;9921.50392480373;10071.295009349422;9516.19112375456;9524.142827145452;9526.523673816282;9526.85709714355;9542.713718588453;7636.3890888728765;7646.235376462309;7761.9611901940125;7804.68781248755;7818.179091195457;5570.415106413769;5707.914381284201;5784.8553786154;5789.913151302818;5826.504747096545;9058.411203271766;9072;9147.817043659223;9178.632854685738;9234.076592340982;8553.187447192508;8615.052344242255;9059.68291109808;9259.814803704023;9274.165325120503;6815.148106486689;7045.401140903081;7068.222495525385;7159.64201789898;7284.417246620364;7711;7829.960850195713;7830.09953855314;7830.451868369388;7846.058472983279;6958.79123626292;6995;7094.6097964612445;7174.282571742992;7199.280071992759;6744.662766861539;6771.86456270862;6831.555948863308;6834.598907224106;6902.551334163263;6599.043138744951;6659.101021362054;6661.966690166518;6666.666666666744;6667.533272670867;4994.9500504994485;5097.541221290102;5123.641345105807;5124.56441202502;5151.639385242997;5036.597072234285;5043.722595257149;5123.718195499134;5149.48505149482;5207.114790485551 19:20:53 INFO - PROCESS | 9271 | |4;prototype.html;353.1401038471321;366.6938106680921;370.7793862651723;371.064916410645;371.0871256708497;5555.8888822223535;5630.915536266954;5637.365164102405;5638.464345887144;5673.205751194836;5420.810271640494;5466.644668096571;5564.304461942257;5567.721613919298;5571;4456.79944402501;4491.708038977456;4505.769644026195;4514.796834142471;4526.592606665399;4242.624130486922;4327.740335579875;4386.4428128014415;4472.776361181945;4483.8342031072;4370.475542934836;4380.5106263870275;4385.605295523403;4387.451568553931;4393.868183954486;4383.408239887606;4386.890327741816;4411.911761764779;4413.095315460323;4432.495639963443;3840.1551658635058;3881.4760007398922;3935.3113205189265;3935.4490371348033;3950.6246906543834;5435.42927992559;5438.53772429344;5438.7280635968045;5440.3743569489225;5442.340086273685;5033.546980771748;5034.572061374787;5043.243513472972;5059.1905295152965;5071.7210553419545;5636.4927156556105;5776.86256085247;5801.53587712982;5888.941110588882;5894.616849904743;4242.830286788556;4244.320908654631;4250.851220207309;4259.808308626089;4271.530131685512;6080.513558915276;6113.816585502397;6132.938670613326;6134.5399095067605;6136.938630613681;4239.321708526682;4252.915506545811;4257.765822879709;4265.55211702773;4410.691251612357;4304.720193187432;4323.308270676739;4326.848560300375;4335.284678028153;4341.804618792162;4956.355673762388;4980.456058621767;4991.226359914219;4992.550670439605;5003.174476211457;5592.245046918695;5672.574556908248;5914.201582786355;5928.851778705481;5932.555058370639;1502.9473968411053;1520.4070412539118;1523.8628523432944;1530.2654725731488;1535.5086372360738;1046.4401545173448;1076.827707566801;1080.7406222506543;1085.5766251161895;1093.6500319897557;5565.276514053147;5572.972135139298;5581.386047534768;5582.692951887604;5603.6077474577205;5833.88332233353;5842.912356314659;5846.129238643678;5888.411158884077;5899.528037756969;5454.509094181542;5531.3362396512675;5542.11326187808;5627.803026894039;5655.907314293738;3073.2624170199438;3079.337157934735;3101.42623614632;3102.7672924530752;3125.6405513366253;5860.296764388216;6057.3639767824625;6071.544634152457;6075.33171351151;6080.543959203077;5721;5758.942410575924;5798.971005144947;5835.94164058354;5862.560307976919;5994.411480957549;6013.54898382623;6026.668533230627;6037.215162028908;6047.939520604826;5715.799947001835;5794.63826000881;6089.299730530868;6125.418085281891;6139.4781443577795;6056.90914636272;6085.421884921103;6088.665123418077;6109.511239100772;6120.204373431426;6241.25384830673;6302;6373.67360913254;6416.374748267214;6440.742370305135;4301.526832048535;4301.806418711228;4308.633766129914;4337.2626653469615;4344.9565504344555;5993.190919225849;6102.572819902564;6132.478739307209;6148.1699970503405;6192.225971753531;5915.85210369727;5946.940530594638;5952.285725712942;5967.6419414835245;5971.6113554578515;5936.28764548257;5944.197533332945;5958.880822383615;5995.670238136944;6009.429104235091;5725.828225153252;5884.617499862496;5889.793857214977;5927.703614819328;5955.404459554184;5916.171735956884;5941.821745347646;6028.09578563219;6030.185924900083;6051.8198951204095;5613.494785469327;5751.827445176651;5834.912476312774;5837.416258374298;5844.795432160024 19:20:53 INFO - PROCESS | 9271 | |5;yui.html;814.7677911795136;828.7472320942114;857.5712143928037;882.5807741322873;909.8180363927216;15139.243037848104;15930.362785488582;16299.674006519863;16569.502914912573;16677.99932004079;14526.201058941753;14638.48765293215;14903.478378256736;14905.32926018329;15023.849761502383;867.535868310454;887.5828360670474;894.552723638181;901.2924853989587;902.9819403611957;884.7213127864734;886.6187539358074;887.2946007923716;888.8089060851916;889.1108891108892;930.2186163622556;931.0689310689311;931.4225180388135;931.8229536388098;936.2930987104727;920.9447433153998;921.1755478846462;921.203159267229;921.4010892919589;925.2551695884777;679.6533767778419;681.3629256645053;681.4071757570945;681.7886455198905;683.1733602341174;15397.307121179574;15678.372865085383;15689.215539222992;15707.293171807296;15778.605534861605;12990.415431305613;13492.662683432894;14464;14568.490102846456;14676.633084172874;11965.162438629299;12018.579349722806;12106.334151621657;12113.091518136087;12173.391330433531;3897.7271590988644;3898.8440462381473;3908.2769687607883;3941.7043721720697;4017.1764788218347;67247.32752672509;67489;67530.3246967529;67908.32091679069;68094.65952670205;11756.177067605357;11761.117916156152;11874.34691091981;12093.153479256544;12127.514899403925;20916.581668366547;21210.36368908935;21349.78650213509;21569;21709.34871953844;8503.957480212559;8568.443051201652;8594.656213751505;8604.48373097616;8779.341549383822;4554.628699827959;4646.721196728207;4688.9531104689195;4707.576318131385;4757.26262429324;3409.232922592397;3498.3003399320237;3527;3529.347070791912;3530.6822385985383;575.0913556580592;575.6258432019138;577.9219805326311;578.8813293274868;607.1257389359308;694.3785312145601;738.9630518474055;789.3369569561596;791.4776247676621;793.8213901872033;9943.353682010646;10045;10219.693409197587;10373.63692270782;10379.532921018572;630.3727790848044;662.0532638327143;701.9087518622547;736.6427282767853;798.8082860113647;4799.616030717534;5010.949890501121;5074.797008119708;5103.5661968733075;5107.948920510822;89303.55348223347;90522;90784.54607726919;93056;93975;78007.21992780112;78260;80797.59601201957;81415.18584814195;81684.59157704293;70841.64579177072;71719.64140179266;71870.64064679643;72865.63567182237;73627.26372736311;9655.372400793925;9853.408795472295;9910.851337230091;9915.157211637092;9953.104220619889;48959.26561101658;49507.50492495029;50121.24818127804;50435.243471347225;50586;54702.72648636731;56592.43407566036;57550.068189651625;64807;65668;12913.354332283536;13005.479780808662;13255.734885302047;13458.798118028433;13600;14904.701905962036;14930.477433289783;15049.247537622856;15234.847651523343;15238.542843714706;13882.375293112036;14040.438382464996;14342.856571434151;14525.273736313353;14661.92669036648;13909.791353129509;14018.929905350817;14081.436742530184;14127;14524.419023238952;13653.453861845415;13874.306284685927;14172.503962361268;14233.64415889611;14379.784303235669;11623.24448910852;11768.041826891971;11788.646340609796;12183.756324873275;12501.562445314734;12200.75598488043;12302.569410070604;12362.44369003379;12538.05964552644;12574.497020119094 19:20:53 INFO - PROCESS | 9271 | __end_tp_report 19:20:53 INFO - PROCESS | 9271 | __start_cc_report 19:20:53 INFO - PROCESS | 9271 | _x_x_mozilla_cycle_collect,306 19:20:53 INFO - PROCESS | 9271 | __end_cc_report 19:20:53 INFO - PROCESS | 9271 | __startTimestamp1485573653250__endTimestamp 19:20:53 INFO - PROCESS | 9271 | 19:20:53 INFO - PROCESS | 9271 | ------- Summary: start ------- 19:20:53 INFO - PROCESS | 9271 | Number of tests: 6 19:20:53 INFO - PROCESS | 9271 | 19:20:53 INFO - PROCESS | 9271 | [#0] dojo.html Cycles:165 Average:5671.15 Median:5871.38 stddev:648.03 (11.0%) stddev-sans-first:619.12 19:20:53 INFO - PROCESS | 9271 | Values: 3150.7 3256.7 3267.8 3293.1 3296.1 5616.7 5644.7 5660.7 5665.2 5672.1 5640.2 5729.3 5775.9 5785.6 5805.3 5184.8 5187.2 5210.9 5222.3 5226.4 5257.4 5262.8 5277.5 5285.8 5289.8 5058.2 5080.0 5178.2 5286.3 5287.3 5248.4 5278.8 5285.7 5322.3 5327.5 5203.3 5236.4 5237.9 5245.5 5260.9 5483.5 5541.3 5634.9 5642.7 5758.0 6015.1 6046.5 6053.1 6066.8 6125.8 6167.8 6189.2 6195.8 6199.8 6231.3 5685.7 5746.7 5753.5 5772.5 5791.2 6160.7 6254.5 6266.4 6270.8 6272.2 6011.2 6042.4 6048.6 6054.2 6076.7 5787.7 5832.4 5929.7 6121.9 6135.6 5920.3 6015.9 6028.6 6039.1 6070.8 5976.1 6025.5 6034.2 6034.6 6041.9 4577.2 4629.7 4678.9 4697.5 4702.9 4067.0 4094.3 4101.1 4138.8 4200.1 5811.4 5852.8 5864.3 5871.4 5884.8 6015.5 6088.5 6088.9 6098.5 6113.3 5797.9 5833.2 5854.3 5893.1 6000.2 5245.6 5247.5 5252.8 5257.2 5267.2 6349.8 6420.4 6428.1 6462.8 6467.3 5988.8 6039.1 6039.3 6044.1 6046.6 6308.7 6349.3 6355.6 6365.6 6407.1 5963.8 5972.9 5973.1 5981.4 6004.7 5942.3 6045.7 6064.8 6084.3 6121.4 5989.2 5996.8 6023.8 6033.9 6060.9 5963.3 5985.1 5987.3 5991.7 6004.0 5721.8 5823.9 5827.8 5990.0 6007.0 5854.0 5978.8 5991.2 6008.5 6010.4 5842.6 5846.1 5861.3 5864.6 5868.1 19:20:53 INFO - PROCESS | 9271 | 19:20:53 INFO - PROCESS | 9271 | [#1] ext.html Cycles:180 Average:62450.55 Median:44837.16 stddev:116690.56 (260.3%) stddev-sans-first:116925.56 19:20:53 INFO - PROCESS | 9271 | Values: 619.5 642.6 659.0 684.8 705.7 42274.8 46094.3 46113.0 46655.8 46681.3 47077.0 47346.8 47590.0 47642.3 47757.0 8923.2 9067.7 9068.8 9073.7 9119.8 8835.4 8914.8 8925.9 8931.1 8975.6 8892.1 8940.2 8941.4 8951.4 8961.7 8914.7 8950.6 8962.9 8977.0 8990.7 8876.3 8904.7 8910.7 8914.0 8972.8 43127.0 43196.4 43508.8 43534.8 43554.0 3774.4 3806.6 3815.9 3850.8 3865.5 33015.8 33340.0 33471.7 33494.2 33693.8 4124.1 4152.8 4164.5 4164.7 4266.9 379823.0 385629.0 387941.0 500690.0 502124.0 65804.0 65858.3 66399.3 66450.0 66694.7 72142.6 72478.6 72542.0 72619.0 72668.6 18911.7 19040.5 19075.2 19430.1 19535.4 14768.1 14825.1 14966.7 14968.5 15001.5 20284.5 20907.3 20908.2 21003.0 21022.0 7616.5 7637.2 7739.0 7743.9 7920.7 1021.8 1051.4 1153.2 1160.4 1180.9 31501.5 33200.2 33508.0 33511.2 33758.8 1133.6 1154.8 1187.8 1198.5 1235.2 17051.0 17100.0 17470.0 17514.6 17515.6 505028.0 505982.0 506294.0 506710.0 507218.0 61365.0 61723.1 61942.4 62065.0 62115.0 1395.5 1438.7 1445.9 1452.2 1460.1 31701.5 32829.7 33043.7 33394.7 33829.3 55722.7 56346.0 56432.7 56468.2 56491.4 368927.0 375028.0 376012.0 377701.0 377991.0 46552.3 48616.0 48863.0 49463.8 49951.0 48929.0 49626.8 51256.0 52502.5 52590.5 41738.8 44197.0 44866.8 47270.8 48739.0 43608.3 44059.6 45480.3 46147.0 46172.3 44021.1 44719.0 44807.6 45543.5 45628.0 38368.2 39539.2 40151.2 40163.8 40831.2 29107.3 30621.4 30625.5 31495.8 32150.8 19:20:53 INFO - PROCESS | 9271 | 19:20:53 INFO - PROCESS | 9271 | [#2] jquery.html Cycles:180 Average:26537.68 Median:2461.85 stddev:67809.98 (2754.4%) stddev-sans-first:67971.84 19:20:53 INFO - PROCESS | 9271 | Values: 414.0 416.5 416.5 421.5 428.8 18586.4 19721.1 19950.3 20073.8 20183.8 16239.0 17077.9 19323.1 19777.0 19908.5 5574.4 5792.4 5825.4 5826.9 5831.6 5604.3 5670.3 5705.7 5759.3 5769.7 5817.8 5831.1 5845.5 5876.9 5888.6 5653.2 5692.4 5835.6 5842.0 5850.1 5170.5 5194.9 5197.2 5220.1 5238.0 22405.9 23348.4 23533.3 23910.4 24272.0 2443.0 2480.7 2559.5 2960.7 2985.2 10317.9 10893.5 10933.4 11064.1 11076.4 1987.8 2016.8 2041.7 2045.3 2061.1 85869.0 91254.5 91746.0 91862.1 92845.5 11433.9 11693.2 11763.5 11912.4 12296.4 16746.7 16833.0 16854.6 16899.2 16914.8 8290.4 8338.9 8443.0 8542.2 8716.6 7946.7 7989.0 8039.4 8237.8 8253.3 5013.3 5096.3 5100.5 5118.9 5280.7 2086.6 2159.6 2189.3 2189.7 2192.9 940.8 1005.0 1049.3 1072.9 1098.0 18985.2 19878.6 19915.7 19929.0 20076.7 1016.5 1045.0 1045.1 1050.0 1051.0 9974.8 10958.3 11158.9 11216.9 11229.8 165160.0 433858.0 445939.0 450239.0 450503.0 89974.0 92496.5 95350.5 98742.5 100360.5 494.4 513.9 519.9 520.9 522.7 11291.7 11572.6 11675.8 11928.9 12191.9 30886.0 32422.0 40535.0 42792.4 43239.0 57092.7 57722.0 58111.4 58723.7 59167.7 8638.0 8751.8 8856.6 8950.4 9096.0 12465.3 13024.2 13040.5 13042.9 13265.7 11368.7 11478.2 11743.1 12188.2 12320.8 11838.3 12212.9 12424.7 12770.4 12973.0 12319.1 12607.9 12754.6 12841.9 12955.7 9410.1 9535.6 9617.7 9637.7 9649.7 11429.3 11845.1 12412.6 12437.6 12693.6 19:20:53 INFO - PROCESS | 9271 | 19:20:53 INFO - PROCESS | 9271 | [#3] mootools.html Cycles:180 Average:5450.93 Median:5307.65 stddev:2858.52 (53.9%) stddev-sans-first:2851.27 19:20:53 INFO - PROCESS | 9271 | Values: 1518.8 1536.8 1713.4 1793.4 1827.1 7283.3 7455.0 7513.8 7944.0 7945.3 7800.0 8078.2 8082.2 8234.1 8261.6 2487.2 2513.7 2517.2 2518.3 2523.4 2446.0 2482.0 2525.5 2526.1 2527.1 2405.9 2422.3 2478.8 2485.8 2488.3 2486.0 2492.5 2494.6 2502.7 2512.6 2449.1 2473.7 2492.8 2493.0 2521.3 8194.6 8236.7 8286.3 8292.9 8307.8 5147.5 5291.7 5294.0 5297.8 5317.5 3234.0 3277.1 3354.7 3362.6 3403.5 996.2 1021.7 1046.3 1082.2 1102.5 11010.4 11035.8 11105.9 11121.2 11130.6 4461.9 4669.5 4715.4 4719.0 4783.5 9189.9 9200.7 9203.6 9230.8 9231.4 5254.3 5258.7 5261.3 5267.6 5290.0 4705.5 4854.0 4866.8 4873.0 4912.0 3774.0 3833.9 3840.3 3947.8 3956.4 1247.7 1257.4 1260.7 1264.1 1287.3 846.4 956.7 963.3 1015.3 1029.8 5646.2 5648.8 5746.1 5753.6 5880.3 937.5 942.1 953.1 953.2 975.8 3863.6 4046.3 4125.7 4134.4 4144.5 9516.2 9733.2 9868.1 9921.5 10071.3 9516.2 9524.1 9526.5 9526.9 9542.7 7636.4 7646.2 7762.0 7804.7 7818.2 5570.4 5707.9 5784.9 5789.9 5826.5 9058.4 9072.0 9147.8 9178.6 9234.1 8553.2 8615.1 9059.7 9259.8 9274.2 6815.1 7045.4 7068.2 7159.6 7284.4 7711.0 7830.0 7830.1 7830.5 7846.1 6958.8 6995.0 7094.6 7174.3 7199.3 6744.7 6771.9 6831.6 6834.6 6902.6 6599.0 6659.1 6662.0 6666.7 6667.5 4995.0 5097.5 5123.6 5124.6 5151.6 5036.6 5043.7 5123.7 5149.5 5207.1 19:20:53 INFO - PROCESS | 9271 | 19:20:53 INFO - PROCESS | 9271 | [#4] prototype.html Cycles:180 Average:4947.93 Median:5577.18 stddev:1438.78 (25.8%) stddev-sans-first:1400.88 19:20:53 INFO - PROCESS | 9271 | Values: 353.1 366.7 370.8 371.1 371.1 5555.9 5630.9 5637.4 5638.5 5673.2 5420.8 5466.6 5564.3 5567.7 5571.0 4456.8 4491.7 4505.8 4514.8 4526.6 4242.6 4327.7 4386.4 4472.8 4483.8 4370.5 4380.5 4385.6 4387.5 4393.9 4383.4 4386.9 4411.9 4413.1 4432.5 3840.2 3881.5 3935.3 3935.4 3950.6 5435.4 5438.5 5438.7 5440.4 5442.3 5033.5 5034.6 5043.2 5059.2 5071.7 5636.5 5776.9 5801.5 5888.9 5894.6 4242.8 4244.3 4250.9 4259.8 4271.5 6080.5 6113.8 6132.9 6134.5 6136.9 4239.3 4252.9 4257.8 4265.6 4410.7 4304.7 4323.3 4326.8 4335.3 4341.8 4956.4 4980.5 4991.2 4992.6 5003.2 5592.2 5672.6 5914.2 5928.9 5932.6 1502.9 1520.4 1523.9 1530.3 1535.5 1046.4 1076.8 1080.7 1085.6 1093.7 5565.3 5573.0 5581.4 5582.7 5603.6 5833.9 5842.9 5846.1 5888.4 5899.5 5454.5 5531.3 5542.1 5627.8 5655.9 3073.3 3079.3 3101.4 3102.8 3125.6 5860.3 6057.4 6071.5 6075.3 6080.5 5721.0 5758.9 5799.0 5835.9 5862.6 5994.4 6013.5 6026.7 6037.2 6047.9 5715.8 5794.6 6089.3 6125.4 6139.5 6056.9 6085.4 6088.7 6109.5 6120.2 6241.3 6302.0 6373.7 6416.4 6440.7 4301.5 4301.8 4308.6 4337.3 4345.0 5993.2 6102.6 6132.5 6148.2 6192.2 5915.9 5946.9 5952.3 5967.6 5971.6 5936.3 5944.2 5958.9 5995.7 6009.4 5725.8 5884.6 5889.8 5927.7 5955.4 5916.2 5941.8 6028.1 6030.2 6051.8 5613.5 5751.8 5834.9 5837.4 5844.8 19:20:53 INFO - PROCESS | 9271 | 19:20:53 INFO - PROCESS | 9271 | [#5] yui.html Cycles:180 Average:18758.99 Median:49233.39 stddev:24408.26 (49.6%) stddev-sans-first:24439.54 19:20:53 INFO - PROCESS | 9271 | Values: 814.8 828.7 857.6 882.6 909.8 15139.2 15930.4 16299.7 16569.5 16678.0 14526.2 14638.5 14903.5 14905.3 15023.8 867.5 887.6 894.6 901.3 903.0 884.7 886.6 887.3 888.8 889.1 930.2 931.1 931.4 931.8 936.3 920.9 921.2 921.2 921.4 925.3 679.7 681.4 681.4 681.8 683.2 15397.3 15678.4 15689.2 15707.3 15778.6 12990.4 13492.7 14464.0 14568.5 14676.6 11965.2 12018.6 12106.3 12113.1 12173.4 3897.7 3898.8 3908.3 3941.7 4017.2 67247.3 67489.0 67530.3 67908.3 68094.7 11756.2 11761.1 11874.3 12093.2 12127.5 20916.6 21210.4 21349.8 21569.0 21709.3 8504.0 8568.4 8594.7 8604.5 8779.3 4554.6 4646.7 4689.0 4707.6 4757.3 3409.2 3498.3 3527.0 3529.3 3530.7 575.1 575.6 577.9 578.9 607.1 694.4 739.0 789.3 791.5 793.8 9943.4 10045.0 10219.7 10373.6 10379.5 630.4 662.1 701.9 736.6 798.8 4799.6 5010.9 5074.8 5103.6 5107.9 89303.6 90522.0 90784.5 93056.0 93975.0 78007.2 78260.0 80797.6 81415.2 81684.6 70841.6 71719.6 71870.6 72865.6 73627.3 9655.4 9853.4 9910.9 9915.2 9953.1 48959.3 49507.5 50121.2 50435.2 50586.0 54702.7 56592.4 57550.1 64807.0 65668.0 12913.4 13005.5 13255.7 13458.8 13600.0 14904.7 14930.5 15049.2 15234.8 15238.5 13882.4 14040.4 14342.9 14525.3 14661.9 13909.8 14018.9 14081.4 14127.0 14524.4 13653.5 13874.3 14172.5 14233.6 14379.8 11623.2 11768.0 11788.6 12183.8 12501.6 12200.8 12302.6 12362.4 12538.1 12574.5 19:20:53 INFO - PROCESS | 9271 | -------- Summary: end -------- 19:20:53 INFO - PROCESS | 9271 | 19:20:54 INFO - TEST-INFO | 9271: exit 0 19:20:54 INFO - TEST-OK | dromaeo_css | took 1111587ms 19:20:54 INFO - TEST-START | kraken 19:20:54 INFO - operating with platform_type : linux_ 19:20:54 INFO - Initialising browser for kraken test... 19:20:54 INFO - TEST-INFO | started process 9628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMP0uYq/profile http://localhost:47795/getInfo.html) 19:20:57 INFO - PROCESS | 9628 | __metrics Screen width/height:1600/1200 19:20:57 INFO - PROCESS | 9628 | colorDepth:24 19:20:57 INFO - PROCESS | 9628 | Browser inner width/height: 1024/697 19:20:57 INFO - PROCESS | 9628 | __metrics 19:20:58 ERROR - PROCESS | 9628 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 19:20:59 INFO - TEST-INFO | 9628: exit 0 19:20:59 INFO - Browser initialized. 19:20:59 INFO - Running cycle 1/1 for kraken test... 19:20:59 INFO - TEST-INFO | started process 9758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMP0uYq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:21:11 INFO - PROCESS | 9758 | RSS: Main: 148316160 19:21:11 INFO - PROCESS | 9758 | 19:21:13 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:47795/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47795/tests/kraken/driver.html?testName=audio-beat-detection) 19:21:14 INFO - PROCESS | 9758 | RSS: Main: 153784320 19:21:14 INFO - PROCESS | 9758 | 19:21:17 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:47795/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47795/tests/kraken/driver.html?testName=audio-dft) 19:21:17 INFO - PROCESS | 9758 | RSS: Main: 152743936 19:21:17 INFO - PROCESS | 9758 | 19:21:20 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:47795/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47795/tests/kraken/driver.html?testName=audio-fft) 19:21:21 INFO - PROCESS | 9758 | RSS: Main: 153231360 19:21:21 INFO - PROCESS | 9758 | 19:21:23 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:47795/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47795/tests/kraken/driver.html?testName=audio-oscillator) 19:21:23 INFO - PROCESS | 9758 | RSS: Main: 152985600 19:21:23 INFO - PROCESS | 9758 | 19:21:25 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:47795/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47795/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:21:26 INFO - PROCESS | 9758 | RSS: Main: 152596480 19:21:26 INFO - PROCESS | 9758 | 19:21:29 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:47795/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47795/tests/kraken/driver.html?testName=imaging-darkroom) 19:21:30 INFO - PROCESS | 9758 | RSS: Main: 155332608 19:21:30 INFO - PROCESS | 9758 | 19:21:33 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:47795/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47795/tests/kraken/driver.html?testName=imaging-desaturate) 19:21:34 INFO - PROCESS | 9758 | RSS: Main: 155860992 19:21:34 INFO - PROCESS | 9758 | 19:21:36 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:47795/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47795/tests/kraken/driver.html?testName=json-parse-financial) 19:21:37 INFO - PROCESS | 9758 | RSS: Main: 155684864 19:21:37 INFO - PROCESS | 9758 | 19:21:38 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:47795/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47795/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:21:39 INFO - PROCESS | 9758 | RSS: Main: 155353088 19:21:39 INFO - PROCESS | 9758 | 19:21:41 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:47795/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47795/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:21:41 INFO - PROCESS | 9758 | RSS: Main: 155406336 19:21:41 INFO - PROCESS | 9758 | 19:21:43 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:47795/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47795/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:21:44 INFO - PROCESS | 9758 | RSS: Main: 155422720 19:21:44 INFO - PROCESS | 9758 | 19:21:47 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:47795/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:21:47 INFO - PROCESS | 9758 | RSS: Main: 155586560 19:21:47 INFO - PROCESS | 9758 | 19:21:50 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:47795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:21:51 INFO - PROCESS | 9758 | RSS: Main: 155811840 19:21:51 INFO - PROCESS | 9758 | 19:21:52 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:47795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47795/tests/kraken/driver.html?testName=ai-astar) 19:21:53 INFO - PROCESS | 9758 | RSS: Main: 157532160 19:21:53 INFO - PROCESS | 9758 | 19:21:53 INFO - PROCESS | 9758 | __start_tp_report 19:21:53 INFO - PROCESS | 9758 | _x_x_mozilla_page_load 19:21:53 INFO - PROCESS | 9758 | _x_x_mozilla_page_load_details 19:21:53 INFO - PROCESS | 9758 | |i|pagename|runs| 19:21:53 INFO - PROCESS | 9758 | |0;ai-astar;107;114;113;111;112;111;115;112;112;113 19:21:53 INFO - PROCESS | 9758 | |1;audio-beat-detection;146;119;119;160;123;121;118;119;150;126 19:21:53 INFO - PROCESS | 9758 | |2;audio-dft;174;162;163;160;162;161;162;163;161;162 19:21:53 INFO - PROCESS | 9758 | |3;audio-fft;75;76;77;109;75;77;75;76;100;75 19:21:53 INFO - PROCESS | 9758 | |4;audio-oscillator;81;82;114;83;83;83;99;83;82;119 19:21:53 INFO - PROCESS | 9758 | |5;imaging-gaussian-blur;117;118;118;118;116;118;117;117;118;121 19:21:53 INFO - PROCESS | 9758 | |6;imaging-darkroom;148;148;147;147;147;147;147;146;147;147 19:21:53 INFO - PROCESS | 9758 | |7;imaging-desaturate;85;85;85;85;86;86;84;85;85;85 19:21:53 INFO - PROCESS | 9758 | |8;json-parse-financial;52;52;51;54;52;52;52;50;51;51 19:21:53 INFO - PROCESS | 9758 | |9;json-stringify-tinderbox;59;60;59;59;60;60;58;59;59;59 19:21:53 INFO - PROCESS | 9758 | |10;stanford-crypto-aes;75;75;76;78;77;76;75;81;76;75 19:21:53 INFO - PROCESS | 9758 | |11;stanford-crypto-ccm;138;130;123;128;119;129;122;119;157;123 19:21:53 INFO - PROCESS | 9758 | |12;stanford-crypto-pbkdf2;155;153;158;156;156;161;162;157;164;155 19:21:53 INFO - PROCESS | 9758 | |13;stanford-crypto-sha256-iterative;63;62;64;63;63;61;65;62;62;70 19:21:53 INFO - PROCESS | 9758 | __end_tp_report 19:21:53 INFO - PROCESS | 9758 | __start_cc_report 19:21:53 INFO - PROCESS | 9758 | _x_x_mozilla_cycle_collect,771 19:21:53 INFO - PROCESS | 9758 | __end_cc_report 19:21:53 INFO - PROCESS | 9758 | __startTimestamp1485573713046__endTimestamp 19:21:53 INFO - PROCESS | 9758 | 19:21:53 INFO - PROCESS | 9758 | ------- Summary: start ------- 19:21:53 INFO - PROCESS | 9758 | Number of tests: 14 19:21:53 INFO - PROCESS | 9758 | 19:21:53 INFO - PROCESS | 9758 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.50 stddev:2.16 (1.9%) stddev-sans-first:1.33 19:21:53 INFO - PROCESS | 9758 | Values: 107.0 114.0 113.0 111.0 112.0 111.0 115.0 112.0 112.0 113.0 19:21:53 INFO - PROCESS | 9758 | 19:21:53 INFO - PROCESS | 9758 | [#1] audio-beat-detection Cycles:10 Average:130.10 Median:124.50 stddev:15.67 (12.6%) stddev-sans-first:15.52 19:21:53 INFO - PROCESS | 9758 | Values: 146.0 119.0 119.0 160.0 123.0 121.0 118.0 119.0 150.0 126.0 19:21:53 INFO - PROCESS | 9758 | 19:21:53 INFO - PROCESS | 9758 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.00 stddev:3.97 (2.5%) stddev-sans-first:0.97 19:21:53 INFO - PROCESS | 9758 | Values: 174.0 162.0 163.0 160.0 162.0 161.0 162.0 163.0 161.0 162.0 19:21:53 INFO - PROCESS | 9758 | 19:21:53 INFO - PROCESS | 9758 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.50 stddev:12.33 (16.3%) stddev-sans-first:12.85 19:21:53 INFO - PROCESS | 9758 | Values: 75.0 76.0 77.0 109.0 75.0 77.0 75.0 76.0 100.0 75.0 19:21:53 INFO - PROCESS | 9758 | 19:21:53 INFO - PROCESS | 9758 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:83.00 stddev:14.51 (17.5%) stddev-sans-first:14.94 19:21:53 INFO - PROCESS | 9758 | Values: 81.0 82.0 114.0 83.0 83.0 83.0 99.0 83.0 82.0 119.0 19:21:53 INFO - PROCESS | 9758 | 19:21:53 INFO - PROCESS | 9758 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:1.32 (1.1%) stddev-sans-first:1.36 19:21:53 INFO - PROCESS | 9758 | Values: 117.0 118.0 118.0 118.0 116.0 118.0 117.0 117.0 118.0 121.0 19:21:53 INFO - PROCESS | 9758 | 19:21:53 INFO - PROCESS | 9758 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 19:21:53 INFO - PROCESS | 9758 | Values: 148.0 148.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 19:21:53 INFO - PROCESS | 9758 | 19:21:53 INFO - PROCESS | 9758 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 19:21:53 INFO - PROCESS | 9758 | Values: 85.0 85.0 85.0 85.0 86.0 86.0 84.0 85.0 85.0 85.0 19:21:53 INFO - PROCESS | 9758 | 19:21:53 INFO - PROCESS | 9758 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:1.06 (2.0%) stddev-sans-first:1.12 19:21:53 INFO - PROCESS | 9758 | Values: 52.0 52.0 51.0 54.0 52.0 52.0 52.0 50.0 51.0 51.0 19:21:53 INFO - PROCESS | 9758 | 19:21:53 INFO - PROCESS | 9758 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 19:21:53 INFO - PROCESS | 9758 | Values: 59.0 60.0 59.0 59.0 60.0 60.0 58.0 59.0 59.0 59.0 19:21:53 INFO - PROCESS | 9758 | 19:21:53 INFO - PROCESS | 9758 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:76.00 stddev:1.90 (2.5%) stddev-sans-first:1.94 19:21:53 INFO - PROCESS | 9758 | Values: 75.0 75.0 76.0 78.0 77.0 76.0 75.0 81.0 76.0 75.0 19:21:53 INFO - PROCESS | 9758 | 19:21:53 INFO - PROCESS | 9758 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:128.50 stddev:11.49 (8.9%) stddev-sans-first:11.69 19:21:53 INFO - PROCESS | 9758 | Values: 138.0 130.0 123.0 128.0 119.0 129.0 122.0 119.0 157.0 123.0 19:21:53 INFO - PROCESS | 9758 | 19:21:53 INFO - PROCESS | 9758 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:157.50 stddev:3.53 (2.2%) stddev-sans-first:3.61 19:21:53 INFO - PROCESS | 9758 | Values: 155.0 153.0 158.0 156.0 156.0 161.0 162.0 157.0 164.0 155.0 19:21:53 INFO - PROCESS | 9758 | 19:21:53 INFO - PROCESS | 9758 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:2.55 (4.0%) stddev-sans-first:2.70 19:21:53 INFO - PROCESS | 9758 | Values: 63.0 62.0 64.0 63.0 63.0 61.0 65.0 62.0 62.0 70.0 19:21:53 INFO - PROCESS | 9758 | -------- Summary: end -------- 19:21:53 INFO - PROCESS | 9758 | 19:21:53 INFO - TEST-INFO | 9758: exit 0 19:21:54 INFO - TEST-OK | kraken | took 60010ms 19:21:54 INFO - SUITE-END | took 1171s 19:21:54 INFO - Completed test suite (00:19:31) 19:21:54 INFO - javascript benchmark 19:21:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7457.255854532189, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3150.716435520803, 3256.7231785298245, 3267.820269885157, 3293.1273212598667, 3296.0770984124424, 5616.691081990489, 5644.689542075184, 5660.716964151797, 5665.235193248905, 5672.120821272699, 5640.210370548116, 5729.3411257705375, 5775.913361299574, 5785.566082543815, 5805.274340707411, 5184.844454666357, 5187.170052791555, 5210.921836172461, 5222.268882356454, 5226.372835259775, 5257.36911570612, 5262.842114736564, 5277.525022747952, 5285.788568457277, 5289.788408463676, 5058.165402708549, 5080.0, 5178.249153872686, 5286.259923610698, 5287.339082614673, 5248.370195576536, 5278.762455689503, 5285.656432331886, 5322.2814919985885, 5327.547158491494, 5203.271541984125, 5236.371635403738, 5237.921431178535, 5245.527902488794, 5260.868478288074, 5483.479069488392, 5541.27963364764, 5634.887302253973, 5642.689652069134, 5757.971210143923, 6015.127806468081, 6046.486048685867, 6053.122297266916, 6066.787662431838, 6125.815438131368, 6167.752094036047, 6189.195404597373, 6195.845103872394, 6199.814005579795, 6231.3145553989025, 5685.687287199161, 5746.655200687972, 5753.539716822645, 5772.538196944234, 5791.218185544982, 6160.722767475474, 6254.468370188494, 6266.404691554295, 6270.811875643738, 6272.18461599989, 6011.158437818709, 6042.365551617105, 6048.5765996380715, 6054.152418661391, 6076.665783381868, 5787.652740835563, 5832.416758324133, 5929.673867937305, 6121.938780612226, 6135.570510064253, 5920.2895652521975, 6015.909761353583, 6028.638281703112, 6039.063945088518, 6070.757169713162, 5976.103584462366, 6025.487833534199, 6034.1853849730605, 6034.577579569388, 6041.879162416727, 4577.153226653079, 4629.745364005012, 4678.929816052762, 4697.530246975343, 4702.905941881211, 4066.9796651017145, 4094.28350038742, 4101.097758493127, 4138.772367519755, 4200.075983283673, 5811.389804070596, 5852.795152169653, 5864.296284445893, 5871.383504732027, 5884.764609415661, 6015.4586087252355, 6088.4824789893355, 6088.878222435526, 6098.5426093042315, 6113.266408031065, 5797.884042319214, 5833.241678581842, 5854.297484301911, 5893.057110862327, 6000.159977603052, 5245.606579506552, 5247.527722504993, 5252.763625636855, 5257.185136303879, 5267.209918512254, 6349.809505714744, 6420.390062944013, 6428.132202152649, 6462.806115816533, 6467.256265529524, 5988.790392336247, 6039.063945088518, 6039.335673076046, 6044.093385992136, 6046.57673962836, 6308.653024083719, 6349.269833969152, 6355.5551111421755, 6365.64988925595, 6407.1350367701625, 5963.821085367446, 5972.880542389041, 5973.133895585029, 5981.401859813984, 6004.669743164168, 5942.346341902301, 6045.667488288186, 6064.848378790565, 6084.300305464752, 6121.4490695837585, 5989.1914591529585, 5996.820095397145, 6023.849403764766, 6033.879322413615, 6060.909086363797, 5963.2844058713235, 5985.072313791369, 5987.251593550806, 5991.730372133177, 6003.969980150246, 5721.771129154788, 5823.912641310299, 5827.766889324549, 5989.970050149721, 6006.969965150146, 5853.970730146322, 5978.790742323998, 5991.161237426677, 6008.5493587981955, 6010.368911264254, 5842.561807864512, 5846.064629659234, 5861.32594751609, 5864.648121112747, 5868.061110222344], "value": 5626.609920191692, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.4703528483146, 642.6272761798156, 658.9670516474175, 684.8082536889669, 705.6874213962027, 42274.78862605686, 46094.30858537125, 46113.0, 46655.83360415991, 46681.29978050332, 47077.0, 47346.763266183705, 47590.0, 47642.285365719545, 47757.044859102796, 8923.241524470412, 9067.682631107913, 9068.77328066797, 9073.682421115262, 9119.817603647924, 8835.381523293372, 8914.777130571723, 8925.910740892572, 8931.062238464965, 8975.640974361018, 8892.066333035034, 8940.240079593243, 8941.374103812735, 8951.373403861733, 8961.731148065535, 8914.732558023237, 8950.552472376356, 8962.86555701665, 8977.0, 8990.68532601359, 8876.289896808239, 8904.73285801427, 8910.732678019669, 8913.955430222808, 8972.775680607972, 43127.0, 43196.35205471889, 43508.782456087836, 43534.78232608816, 43554.0, 3774.414965680324, 3806.5535096663366, 3815.9046023849346, 3850.8267127979307, 3865.5168103987003, 33015.83492082548, 33340.0, 33471.66528334734, 33494.1626459338, 33693.831530842435, 4124.092699606082, 4152.771597562133, 4164.5210800758, 4164.708470407073, 4266.850660226908, 379823.0, 385629.0, 387941.0, 500690.0, 502123.99999999633, 65804.0, 65858.34141658618, 66399.33600664028, 66450.0, 66694.66652666802, 72142.63928680323, 72478.63760681268, 72542.0, 72619.0, 72668.63665681638, 18911.716324255147, 19040.52398690044, 19075.2369905205, 19430.125644346037, 19535.413937581896, 14768.113913165245, 14825.110493370217, 14966.70066598662, 14968.47610333633, 15001.474948376754, 20284.492887677927, 20907.268245611634, 20908.163673453197, 21003.0, 21022.0, 7616.504927179826, 7637.19809420014, 7739.0, 7743.922560774433, 7920.722774702857, 1021.8109649714827, 1051.4112097225425, 1153.210051114989, 1160.3878556668283, 1180.8701042885275, 31501.52747708786, 33200.1699957503, 33508.0, 33511.16222094467, 33758.83120584382, 1133.637236084445, 1154.7575009247985, 1187.8455800745849, 1198.4906414773686, 1235.172434468908, 17051.0, 17100.0, 17470.0, 17514.649707006043, 17515.64968700619, 505028.0, 505982.0, 506294.0, 506710.0, 507218.0, 61365.0, 61723.07415388773, 61942.38057619366, 62065.0, 62115.0, 1395.483671041721, 1438.6906815034818, 1445.862478421827, 1452.2012892908858, 1460.1166294391953, 31701.524477133324, 32829.671703282664, 33043.66956330406, 33394.66605334013, 33829.32341353208, 55722.72138639281, 56346.0, 56432.7178364122, 56468.15297770454, 56491.43508564862, 368927.0, 375028.0, 376012.0, 377701.0, 377991.0, 46552.301715474976, 48616.0, 48863.0, 49463.752681236365, 49951.0, 48929.0, 49626.75186624044, 51256.0, 52502.47497524976, 52590.474095258556, 41738.79130604328, 44197.0, 44866.77566612146, 47270.76364618155, 48739.0, 43608.34587481254, 44059.55940440683, 45480.31779523376, 46147.0, 46172.307415388124, 44021.11957760891, 44719.0, 44807.55192448164, 45543.54456455393, 45628.0, 38368.232635346576, 39539.209215816096, 40151.1969760609, 40163.79918100391, 40831.18337633171, 29107.272318192216, 30621.387572248877, 30625.540616890317, 31495.84252078725, 32150.839245804556], "value": 21659.21295997389, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.95239547452036, 416.4523651398409, 416.48148055670674, 421.4626351401963, 428.84561557839174, 18586.442406727787, 19721.112549935235, 19950.30173943912, 20073.799262007375, 20183.798162018375, 16239.0, 17077.91461042696, 19323.130459129337, 19777.0, 19908.50228744282, 5574.386817450088, 5792.391798861122, 5825.388334224909, 5826.912596311059, 5831.620944638585, 5604.327480702322, 5670.319561652587, 5705.743241554119, 5759.3376761672525, 5769.682667453289, 5817.767289308444, 5831.125331200333, 5845.503132233765, 5876.9118463223085, 5888.558358123137, 5653.236813030229, 5692.402297758758, 5835.649861008353, 5842.036064049426, 5850.122481627747, 5170.45710200431, 5194.896102077937, 5197.246399272122, 5220.086484865134, 5238.004779091961, 22405.887970560205, 23348.416289592726, 23533.29400117999, 23910.402239943967, 24272.0, 2443.0350011745263, 2480.6651102101346, 2559.4881023795315, 2960.7335339819306, 2985.1641540368732, 10317.948410257975, 10893.509792059298, 10933.398663073527, 11064.05955493784, 11076.446177691163, 1987.7813440521531, 2016.84873634478, 2041.7039529268322, 2045.3250427358935, 2061.1446249806313, 85869.0, 91254.54372728094, 91746.0, 91862.08137918603, 92845.53577232138, 11433.942830285961, 11693.239939404082, 11763.529458821722, 11912.40437978115, 12296.385180740926, 16746.6650666986, 16833.0, 16854.57863553421, 16899.15504224784, 16914.830851691324, 8290.378221633402, 8338.874916876252, 8442.957785211034, 8542.18849209324, 8716.607752651145, 7946.721864734706, 7988.960055199803, 8039.397045221632, 8237.79405514867, 8253.298469630148, 5013.298138260647, 5096.3182149890445, 5100.464451232641, 5118.923216151761, 5280.735963201824, 2086.5618220173933, 2159.5788821179717, 2189.321310393783, 2189.715337006179, 2192.9451763706033, 940.8259471997702, 1004.9849252261222, 1049.3022140276782, 1072.8605281313535, 1097.9725506862233, 18985.24059037623, 19878.60242795136, 19915.701264481046, 19929.0, 20076.69884951727, 1016.5273147986074, 1044.9791004180026, 1045.1429827541342, 1049.9895001050045, 1050.9842352364722, 9974.750631234278, 10958.287711298899, 11158.888411115948, 11216.943915280535, 11229.775404491864, 165160.0, 433858.0, 445939.0, 450239.0, 450503.0, 89974.0, 92496.53751731332, 95350.52324738471, 98742.5062874681, 100360.49819750854, 494.42893458056005, 513.9100657385018, 519.8648351428656, 520.9479052094761, 522.6863881671043, 11291.661250162508, 11572.59495917639, 11675.824862626898, 11928.880711193124, 12191.878081219074, 30886.0, 32422.027339179862, 40535.0, 42792.358114627685, 43239.0, 57092.714536427055, 57722.0, 58111.418885812294, 58723.70638146782, 59167.70416147892, 8638.049814520524, 8751.781205469913, 8856.557172141496, 8950.418222815497, 9095.954520227357, 12465.252084874573, 13024.153430027018, 13040.54358097462, 13042.869571304165, 13265.734685306046, 11368.658940231806, 11478.196526243082, 11743.11926605491, 12188.20776649515, 12320.815187772012, 11838.28970261787, 12212.938935305267, 12424.689382765504, 12770.361481926053, 12973.027022973503, 12319.076069295019, 12607.87392126067, 12754.553590624284, 12841.871581284067, 12955.676108097374, 9410.106039926197, 9535.570899309409, 9617.71146865595, 9637.71086867395, 9649.662261820802, 11429.257098288585, 11845.11161662896, 12412.62762117138, 12437.62687119388, 12693.619191424272], "value": 9194.179736228587, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.817741870975, 1536.7925330080438, 1713.4088739384915, 1793.4171394296857, 1827.1047186878434, 7283.271672832714, 7455.0, 7513.812154696136, 7944.046714394273, 7945.284924356814, 7799.961000195005, 8078.232567906054, 8082.232187942151, 8234.094249632535, 8261.628226729797, 2487.2165267940586, 2513.673222481075, 2517.169334119745, 2518.269701786489, 2523.4069993551593, 2445.987770061156, 2482.0, 2525.4696513732138, 2526.1411120219122, 2527.0776166699206, 2405.893289087022, 2422.3338581890034, 2478.8140889433275, 2485.751424857518, 2488.278399264211, 2485.9751402485927, 2492.526419980207, 2494.6382774497597, 2502.737212592688, 2512.560301947161, 2449.130558651671, 2473.653688483596, 2492.750724927511, 2493.0, 2521.319243804181, 8194.631241594143, 8236.711715089943, 8286.295664868494, 8292.875606865902, 8307.750767476986, 5147.536721695028, 5291.708956007418, 5293.9735301323635, 5297.788088476456, 5317.521423071942, 3234.0, 3277.082416923265, 3354.731621470301, 3362.562866827321, 3403.4724617684296, 996.1632228927735, 1021.7241344836852, 1046.3094357723867, 1082.1667316166508, 1102.5369344875091, 11010.449477526092, 11035.779284414348, 11105.944470277678, 11121.22151449399, 11130.610428634958, 4461.910761784811, 4669.486356500782, 4715.3869996900185, 4718.95281047192, 4783.473817880031, 9189.908100918905, 9200.723978280663, 9203.631854725736, 9230.769230769285, 9231.399959002643, 5254.264402983586, 5258.6581872178185, 5261.263423120766, 5267.552258058108, 5289.973550132302, 4705.529447055267, 4853.95146048542, 4866.805327786919, 4873.02539492103, 4911.950880491221, 3773.962260377416, 3833.9233215336094, 3840.251151025523, 3947.802609869495, 3956.40653901917, 1247.7067889046066, 1257.415301884628, 1260.7478504299177, 1264.0961712375695, 1287.291989405823, 846.3745630131361, 956.7177682583655, 963.3208587945481, 1015.2994433840627, 1029.7785976015043, 5646.153077038477, 5648.802291919846, 5746.0519014363, 5753.568482363756, 5880.26496687914, 937.4937533731845, 942.123824842889, 953.1183655118987, 953.2299754471051, 975.7560609847538, 3863.5943225961432, 4046.2716710991717, 4125.66994640428, 4134.400511925754, 4144.544100148981, 9516.19112375442, 9733.17268032211, 9868.062534059252, 9921.50392480373, 10071.295009349422, 9516.19112375456, 9524.142827145452, 9526.523673816282, 9526.85709714355, 9542.713718588453, 7636.3890888728765, 7646.235376462309, 7761.9611901940125, 7804.68781248755, 7818.179091195457, 5570.415106413769, 5707.914381284201, 5784.8553786154, 5789.913151302818, 5826.504747096545, 9058.411203271766, 9072.0, 9147.817043659223, 9178.632854685738, 9234.076592340982, 8553.187447192508, 8615.052344242255, 9059.68291109808, 9259.814803704023, 9274.165325120503, 6815.148106486689, 7045.401140903081, 7068.222495525385, 7159.64201789898, 7284.417246620364, 7711.0, 7829.960850195713, 7830.09953855314, 7830.451868369388, 7846.058472983279, 6958.79123626292, 6995.0, 7094.6097964612445, 7174.282571742992, 7199.280071992759, 6744.662766861539, 6771.86456270862, 6831.555948863308, 6834.598907224106, 6902.551334163263, 6599.043138744951, 6659.101021362054, 6661.966690166518, 6666.666666666744, 6667.533272670867, 4994.9500504994485, 5097.541221290102, 5123.641345105807, 5124.56441202502, 5151.639385242997, 5036.597072234285, 5043.722595257149, 5123.718195499134, 5149.48505149482, 5207.114790485551], "value": 4489.6021137059, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.1401038471321, 366.6938106680921, 370.7793862651723, 371.064916410645, 371.0871256708497, 5555.8888822223535, 5630.915536266954, 5637.365164102405, 5638.464345887144, 5673.205751194836, 5420.810271640494, 5466.644668096571, 5564.304461942257, 5567.721613919298, 5571.0, 4456.79944402501, 4491.708038977456, 4505.769644026195, 4514.796834142471, 4526.592606665399, 4242.624130486922, 4327.740335579875, 4386.4428128014415, 4472.776361181945, 4483.8342031072, 4370.475542934836, 4380.5106263870275, 4385.605295523403, 4387.451568553931, 4393.868183954486, 4383.408239887606, 4386.890327741816, 4411.911761764779, 4413.095315460323, 4432.495639963443, 3840.1551658635058, 3881.4760007398922, 3935.3113205189265, 3935.4490371348033, 3950.6246906543834, 5435.42927992559, 5438.53772429344, 5438.7280635968045, 5440.3743569489225, 5442.340086273685, 5033.546980771748, 5034.572061374787, 5043.243513472972, 5059.1905295152965, 5071.7210553419545, 5636.4927156556105, 5776.86256085247, 5801.53587712982, 5888.941110588882, 5894.616849904743, 4242.830286788556, 4244.320908654631, 4250.851220207309, 4259.808308626089, 4271.530131685512, 6080.513558915276, 6113.816585502397, 6132.938670613326, 6134.5399095067605, 6136.938630613681, 4239.321708526682, 4252.915506545811, 4257.765822879709, 4265.55211702773, 4410.691251612357, 4304.720193187432, 4323.308270676739, 4326.848560300375, 4335.284678028153, 4341.804618792162, 4956.355673762388, 4980.456058621767, 4991.226359914219, 4992.550670439605, 5003.174476211457, 5592.245046918695, 5672.574556908248, 5914.201582786355, 5928.851778705481, 5932.555058370639, 1502.9473968411053, 1520.4070412539118, 1523.8628523432944, 1530.2654725731488, 1535.5086372360738, 1046.4401545173448, 1076.827707566801, 1080.7406222506543, 1085.5766251161895, 1093.6500319897557, 5565.276514053147, 5572.972135139298, 5581.386047534768, 5582.692951887604, 5603.6077474577205, 5833.88332233353, 5842.912356314659, 5846.129238643678, 5888.411158884077, 5899.528037756969, 5454.509094181542, 5531.3362396512675, 5542.11326187808, 5627.803026894039, 5655.907314293738, 3073.2624170199438, 3079.337157934735, 3101.42623614632, 3102.7672924530752, 3125.6405513366253, 5860.296764388216, 6057.3639767824625, 6071.544634152457, 6075.33171351151, 6080.543959203077, 5721.0, 5758.942410575924, 5798.971005144947, 5835.94164058354, 5862.560307976919, 5994.411480957549, 6013.54898382623, 6026.668533230627, 6037.215162028908, 6047.939520604826, 5715.799947001835, 5794.63826000881, 6089.299730530868, 6125.418085281891, 6139.4781443577795, 6056.90914636272, 6085.421884921103, 6088.665123418077, 6109.511239100772, 6120.204373431426, 6241.25384830673, 6302.0, 6373.67360913254, 6416.374748267214, 6440.742370305135, 4301.526832048535, 4301.806418711228, 4308.633766129914, 4337.2626653469615, 4344.9565504344555, 5993.190919225849, 6102.572819902564, 6132.478739307209, 6148.1699970503405, 6192.225971753531, 5915.85210369727, 5946.940530594638, 5952.285725712942, 5967.6419414835245, 5971.6113554578515, 5936.28764548257, 5944.197533332945, 5958.880822383615, 5995.670238136944, 6009.429104235091, 5725.828225153252, 5884.617499862496, 5889.793857214977, 5927.703614819328, 5955.404459554184, 5916.171735956884, 5941.821745347646, 6028.09578563219, 6030.185924900083, 6051.8198951204095, 5613.494785469327, 5751.827445176651, 5834.912476312774, 5837.416258374298, 5844.795432160024], "value": 4498.654676721103, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.7677911795136, 828.7472320942114, 857.5712143928037, 882.5807741322873, 909.8180363927216, 15139.243037848104, 15930.362785488582, 16299.674006519863, 16569.502914912573, 16677.99932004079, 14526.201058941753, 14638.48765293215, 14903.478378256736, 14905.32926018329, 15023.849761502383, 867.535868310454, 887.5828360670474, 894.552723638181, 901.2924853989587, 902.9819403611957, 884.7213127864734, 886.6187539358074, 887.2946007923716, 888.8089060851916, 889.1108891108892, 930.2186163622556, 931.0689310689311, 931.4225180388135, 931.8229536388098, 936.2930987104727, 920.9447433153998, 921.1755478846462, 921.203159267229, 921.4010892919589, 925.2551695884777, 679.6533767778419, 681.3629256645053, 681.4071757570945, 681.7886455198905, 683.1733602341174, 15397.307121179574, 15678.372865085383, 15689.215539222992, 15707.293171807296, 15778.605534861605, 12990.415431305613, 13492.662683432894, 14464.0, 14568.490102846456, 14676.633084172874, 11965.162438629299, 12018.579349722806, 12106.334151621657, 12113.091518136087, 12173.391330433531, 3897.7271590988644, 3898.8440462381473, 3908.2769687607883, 3941.7043721720697, 4017.1764788218347, 67247.32752672509, 67489.0, 67530.3246967529, 67908.32091679069, 68094.65952670205, 11756.177067605357, 11761.117916156152, 11874.34691091981, 12093.153479256544, 12127.514899403925, 20916.581668366547, 21210.36368908935, 21349.78650213509, 21569.0, 21709.34871953844, 8503.957480212559, 8568.443051201652, 8594.656213751505, 8604.48373097616, 8779.341549383822, 4554.628699827959, 4646.721196728207, 4688.9531104689195, 4707.576318131385, 4757.26262429324, 3409.232922592397, 3498.3003399320237, 3527.0, 3529.347070791912, 3530.6822385985383, 575.0913556580592, 575.6258432019138, 577.9219805326311, 578.8813293274868, 607.1257389359308, 694.3785312145601, 738.9630518474055, 789.3369569561596, 791.4776247676621, 793.8213901872033, 9943.353682010646, 10045.0, 10219.693409197587, 10373.63692270782, 10379.532921018572, 630.3727790848044, 662.0532638327143, 701.9087518622547, 736.6427282767853, 798.8082860113647, 4799.616030717534, 5010.949890501121, 5074.797008119708, 5103.5661968733075, 5107.948920510822, 89303.55348223347, 90522.0, 90784.54607726919, 93056.0, 93975.0, 78007.21992780112, 78260.0, 80797.59601201957, 81415.18584814195, 81684.59157704293, 70841.64579177072, 71719.64140179266, 71870.64064679643, 72865.63567182237, 73627.26372736311, 9655.372400793925, 9853.408795472295, 9910.851337230091, 9915.157211637092, 9953.104220619889, 48959.26561101658, 49507.50492495029, 50121.24818127804, 50435.243471347225, 50586.0, 54702.72648636731, 56592.43407566036, 57550.068189651625, 64807.0, 65668.0, 12913.354332283536, 13005.479780808662, 13255.734885302047, 13458.798118028433, 13600.0, 14904.701905962036, 14930.477433289783, 15049.247537622856, 15234.847651523343, 15238.542843714706, 13882.375293112036, 14040.438382464996, 14342.856571434151, 14525.273736313353, 14661.92669036648, 13909.791353129509, 14018.929905350817, 14081.436742530184, 14127.0, 14524.419023238952, 13653.453861845415, 13874.306284685927, 14172.503962361268, 14233.64415889611, 14379.784303235669, 11623.24448910852, 11768.041826891971, 11788.646340609796, 12183.756324873275, 12501.562445314734, 12200.75598488043, 12302.569410070604, 12362.44369003379, 12538.05964552644, 12574.497020119094], "value": 7598.639176434755, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1464.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 113.0, 111.0, 112.0, 111.0, 115.0, 112.0, 112.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 119.0, 119.0, 160.0, 123.0, 121.0, 118.0, 119.0, 150.0, 126.0], "value": 130.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 162.0, 163.0, 160.0, 162.0, 161.0, 162.0, 163.0, 161.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 109.0, 75.0, 77.0, 75.0, 76.0, 100.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 114.0, 83.0, 83.0, 83.0, 99.0, 83.0, 82.0, 119.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 116.0, 118.0, 117.0, 117.0, 118.0, 121.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 86.0, 86.0, 84.0, 85.0, 85.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 54.0, 52.0, 52.0, 52.0, 50.0, 51.0, 51.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 60.0, 60.0, 58.0, 59.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 78.0, 77.0, 76.0, 75.0, 81.0, 76.0, 75.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 130.0, 123.0, 128.0, 119.0, 129.0, 122.0, 119.0, 157.0, 123.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 153.0, 158.0, 156.0, 156.0, 161.0, 162.0, 157.0, 164.0, 155.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 63.0, 63.0, 61.0, 65.0, 62.0, 62.0, 70.0], "value": 63.5, "unit": "score"}]}]} 19:21:54 INFO - Return code: 0 19:21:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:21:54 ERROR - # TBPL SUCCESS # 19:21:54 INFO - Running post-action listener: _resource_record_post_action 19:21:54 INFO - [mozharness: 2017-01-28 03:21:54.365672Z] Finished run-tests step (success) 19:21:54 INFO - Running post-run listener: _resource_record_post_run 19:21:54 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 684032; Write bytes: 322666496; Read time: 184; Write time: 152724 19:21:54 INFO - TinderboxPrint: CPU usage
13.2% 19:21:54 INFO - TinderboxPrint: I/O read bytes / time
684,032 / 184 19:21:54 INFO - TinderboxPrint: I/O write bytes / time
322,666,496 / 152,724 19:21:54 INFO - TinderboxPrint: CPU idle
8,211.8 (86.8%) 19:21:54 INFO - TinderboxPrint: CPU user
1,201.1 (12.7%) 19:21:54 INFO - TinderboxPrint: Swap in / out
0 / 0 19:21:54 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 101076992; Read time: 0; Write time: 50488 19:21:54 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 679936; Write bytes: 221589504; Read time: 172; Write time: 102236 19:21:55 INFO - Running post-run listener: _upload_blobber_files 19:21:55 INFO - Blob upload gear active. 19:21:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:21:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:21:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:21:55 INFO - (blobuploader) - INFO - Open directory for files ... 19:21:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:21:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:21:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:21:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:21:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:21:56 INFO - (blobuploader) - INFO - Done attempting. 19:21:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:21:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:21:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:21:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:21:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:21:59 INFO - (blobuploader) - INFO - Done attempting. 19:21:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:21:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:21:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:22:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:00 INFO - (blobuploader) - INFO - Done attempting. 19:22:00 INFO - (blobuploader) - INFO - Iteration through files over. 19:22:00 INFO - Return code: 0 19:22:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:22:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:22:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/896371b8d4bbbd6e7e8c0c200ee52974a102d31b8325832867df076b78eb1ea33b4f1c21f72b12b7210d40a8521a18faa52a5c248ec53a9a11b8b2ffd7f40950", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f7c1ccf9925e3afe906db63b4e7e8cbbdc6f2eec55e03b2669733f88f46abaef8c67aa1587c8e70994b2598936aa5cdf2765ee389b527fae4be49d1071f9c4f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c14ecfbb99de5a7889e7a7994b3a5f83f87c3d246e1abe5e698ef71ec8b9d81389b1b9315248718679a7addddeda9cba95906dbbc1efd6dbae3b2ac0c9a9dfa8"} 19:22:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:22:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:22:00 INFO - Contents: 19:22:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/896371b8d4bbbd6e7e8c0c200ee52974a102d31b8325832867df076b78eb1ea33b4f1c21f72b12b7210d40a8521a18faa52a5c248ec53a9a11b8b2ffd7f40950", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f7c1ccf9925e3afe906db63b4e7e8cbbdc6f2eec55e03b2669733f88f46abaef8c67aa1587c8e70994b2598936aa5cdf2765ee389b527fae4be49d1071f9c4f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c14ecfbb99de5a7889e7a7994b3a5f83f87c3d246e1abe5e698ef71ec8b9d81389b1b9315248718679a7addddeda9cba95906dbbc1efd6dbae3b2ac0c9a9dfa8"} 19:22:00 INFO - Running post-run listener: copy_logs_to_upload_dir 19:22:00 INFO - Copying logs to upload dir... 19:22:00 INFO - mkdir: /builds/slave/test/build/upload/logs 19:22:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.478949 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-01-27 19:22:00.575218) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 19:22:00.578805) ========= 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=6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368 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/896371b8d4bbbd6e7e8c0c200ee52974a102d31b8325832867df076b78eb1ea33b4f1c21f72b12b7210d40a8521a18faa52a5c248ec53a9a11b8b2ffd7f40950", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f7c1ccf9925e3afe906db63b4e7e8cbbdc6f2eec55e03b2669733f88f46abaef8c67aa1587c8e70994b2598936aa5cdf2765ee389b527fae4be49d1071f9c4f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c14ecfbb99de5a7889e7a7994b3a5f83f87c3d246e1abe5e698ef71ec8b9d81389b1b9315248718679a7addddeda9cba95906dbbc1efd6dbae3b2ac0c9a9dfa8"} build_url:https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011449 build_url: 'https://queue.taskcluster.net/v1/task/P5kkntIaSpWglvXRVeJVaQ/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/896371b8d4bbbd6e7e8c0c200ee52974a102d31b8325832867df076b78eb1ea33b4f1c21f72b12b7210d40a8521a18faa52a5c248ec53a9a11b8b2ffd7f40950", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f7c1ccf9925e3afe906db63b4e7e8cbbdc6f2eec55e03b2669733f88f46abaef8c67aa1587c8e70994b2598936aa5cdf2765ee389b527fae4be49d1071f9c4f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c14ecfbb99de5a7889e7a7994b3a5f83f87c3d246e1abe5e698ef71ec8b9d81389b1b9315248718679a7addddeda9cba95906dbbc1efd6dbae3b2ac0c9a9dfa8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 19:22:00.603756) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 19:22:00.604082) ========= 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=6dbc10da6d83fee962c624be000001a8-1485572489.470183-1571164368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 19:22:00.686395) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 19:22:00.686730) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 19:22:00.687042) ========= ========= Total master_lag: 0.23 =========