builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1485243456.02 results: success (0) buildid: 20170123215343 builduid: bfd32c45eab04c74a269662b5c596776 revision: 1522cb56a651b62675f392d4064bd4365aac07f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.022787) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.023448) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.023731) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.092761) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.093072) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-23 23:37:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2017-01-23 23:37:36 (229 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.206220 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.335005) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.335303) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021203 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.384620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.384967) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1522cb56a651b62675f392d4064bd4365aac07f4 --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 1522cb56a651b62675f392d4064bd4365aac07f4 --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=74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-23 23:37:36,489 truncating revision to first 12 chars 2017-01-23 23:37:36,489 Setting DEBUG logging. 2017-01-23 23:37:36,489 attempt 1/10 2017-01-23 23:37:36,489 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1522cb56a651?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-23 23:37:36,759 unpacking tar archive at: mozilla-beta-1522cb56a651/testing/mozharness/ program finished with exit code 0 elapsedTime=0.566095 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.964450) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.964787) ========= script_repo_revision: 1522cb56a651b62675f392d4064bd4365aac07f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.965209) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.965492) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 23:37:36.981113) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-01-23 23:37:36.981580) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:37:37 INFO - MultiFileLogger online at 20170123 23:37:37 in /builds/slave/test 23:37:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 23:37:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:37:37 INFO - {'append_to_log': False, 23:37:37 INFO - 'base_work_dir': '/builds/slave/test', 23:37:37 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:37:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:37:37 INFO - 'branch': 'Mozilla-Beta', 23:37:37 INFO - 'buildbot_json_path': 'buildprops.json', 23:37:37 INFO - 'config_files': ('talos/linux_config.py',), 23:37:37 INFO - 'default_actions': ('clobber', 23:37:37 INFO - 'read-buildbot-config', 23:37:37 INFO - 'download-and-extract', 23:37:37 INFO - 'populate-webroot', 23:37:37 INFO - 'create-virtualenv', 23:37:37 INFO - 'install', 23:37:37 INFO - 'run-tests'), 23:37:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:37:37 INFO - 'download_minidump_stackwalk': True, 23:37:37 INFO - 'download_symbols': 'ondemand', 23:37:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:37:37 INFO - 'tooltool.py': '/tools/tooltool.py', 23:37:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:37:37 INFO - '/tools/misc-python/virtualenv.py')}, 23:37:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:37:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:37:37 INFO - 'installer_path': 'installer.exe', 23:37:37 INFO - 'log_level': 'info', 23:37:37 INFO - 'log_name': 'talos', 23:37:37 INFO - 'log_to_console': True, 23:37:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:37:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:37:37 INFO - 'opt_config_files': (), 23:37:37 INFO - 'pip_index': False, 23:37:37 INFO - 'sps_profile': False, 23:37:37 INFO - 'sps_profile_interval': 0, 23:37:37 INFO - 'suite': 'dromaeojs', 23:37:37 INFO - 'system_bits': '32', 23:37:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:37:37 INFO - 'title': 'talos-linux64-ix-042', 23:37:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:37:37 INFO - 'use_talos_json': True, 23:37:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:37:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:37:37 INFO - 'work_dir': 'build'} 23:37:37 INFO - [mozharness: 2017-01-24 07:37:37.285642Z] Running clobber step. 23:37:37 INFO - Running pre-action listener: _resource_record_pre_action 23:37:37 INFO - Running main action method: clobber 23:37:37 INFO - rmtree: /builds/slave/test/build 23:37:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:37:37 INFO - Running post-action listener: _resource_record_post_action 23:37:37 INFO - [mozharness: 2017-01-24 07:37:37.701259Z] Finished clobber step (success) 23:37:37 INFO - [mozharness: 2017-01-24 07:37:37.701358Z] Running read-buildbot-config step. 23:37:37 INFO - Running pre-action listener: _resource_record_pre_action 23:37:37 INFO - Running main action method: read_buildbot_config 23:37:37 INFO - Using buildbot properties: 23:37:37 INFO - { 23:37:37 INFO - "project": "", 23:37:37 INFO - "product": "firefox", 23:37:37 INFO - "script_repo_revision": "production", 23:37:37 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 23:37:37 INFO - "repository": "", 23:37:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 23:37:37 INFO - "buildid": "20170123215343", 23:37:37 INFO - "pgo_build": "True", 23:37:37 INFO - "basedir": "/builds/slave/test", 23:37:37 INFO - "buildnumber": 63, 23:37:37 INFO - "slavename": "talos-linux64-ix-042", 23:37:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:37:37 INFO - "platform": "ubuntu64_hw", 23:37:37 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 23:37:37 INFO - "branch": "mozilla-beta", 23:37:37 INFO - "repo_path": "releases/mozilla-beta", 23:37:37 INFO - "revision": "1522cb56a651b62675f392d4064bd4365aac07f4", 23:37:37 INFO - "stage_platform": "linux64-pgo", 23:37:37 INFO - "builduid": "bfd32c45eab04c74a269662b5c596776", 23:37:37 INFO - "slavebuilddir": "test" 23:37:37 INFO - } 23:37:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 23:37:37 INFO - Running post-action listener: _resource_record_post_action 23:37:37 INFO - [mozharness: 2017-01-24 07:37:37.703761Z] Finished read-buildbot-config step (success) 23:37:37 INFO - [mozharness: 2017-01-24 07:37:37.703848Z] Running download-and-extract step. 23:37:37 INFO - Running pre-action listener: _resource_record_pre_action 23:37:37 INFO - Running main action method: download_and_extract 23:37:37 INFO - mkdir: /builds/slave/test/build/tests 23:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:37:37 INFO - trying https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 23:37:37 INFO - Downloading https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/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 23:37:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/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 23:37:38 INFO - Downloaded 1327 bytes. 23:37:38 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 23:37:38 INFO - Using the following test package requirements: 23:37:38 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 23:37:38 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:37:38 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 23:37:38 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:37:38 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 23:37:38 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:37:38 INFO - u'jsshell-linux-x86_64.zip'], 23:37:38 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:37:38 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 23:37:38 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 23:37:38 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:37:38 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 23:37:38 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:37:38 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 23:37:38 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:37:38 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 23:37:38 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:37:38 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 23:37:38 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:37:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 23:37:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:37:38 INFO - Fetch https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 23:37:38 INFO - Http code: 200 23:37:38 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 23:37:38 INFO - x-amz-cf-id: g58PRpbTpP7waEfSlAfvE_9nGyaxaPc__T57RVVx6H9IWiNA0raNeg== 23:37:38 INFO - x-amz-version-id: UOkRhVrUn__KnCFIQZag48EpYDIi_5f9 23:37:39 INFO - Expected file size: 21950328 23:37:39 INFO - Obtained file size: 21950328 23:37:43 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 23:37:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 23:37:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:37:43 INFO - Fetch https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 23:37:43 INFO - Http code: 200 23:37:43 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 23:37:43 INFO - x-amz-cf-id: lLR2uT6H6C5UvBln_tpVfddYX7w9lHtD3PPXjmz4-RGQM8nvvGmmpQ== 23:37:43 INFO - x-amz-version-id: UOkRhVrUn__KnCFIQZag48EpYDIi_5f9 23:37:43 INFO - Expected file size: 21950328 23:37:43 INFO - Obtained file size: 21950328 23:37:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 23:37:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:37:48 INFO - Fetch https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 23:37:49 INFO - Http code: 200 23:37:49 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 23:37:49 INFO - x-amz-cf-id: zei36jbQc4nZgMK2NWsNVSUnlW_LhjteTWl0AtkgjLu1X1t_sxDQKw== 23:37:49 INFO - x-amz-version-id: VCl0zhyCKKu0czv99TM3mmcPJHOyqOgS 23:37:49 INFO - Expected file size: 14402992 23:37:49 INFO - Obtained file size: 14402992 23:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:37:49 INFO - trying https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:37:49 INFO - Downloading https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/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 23:37:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/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 23:37:50 INFO - Downloaded 57695407 bytes. 23:37:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:37:50 INFO - mkdir: /builds/slave/test/properties 23:37:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:37:50 INFO - Writing to file /builds/slave/test/properties/build_url 23:37:50 INFO - Contents: 23:37:50 INFO - build_url:https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:37:51 INFO - Running post-action listener: _resource_record_post_action 23:37:51 INFO - Running post-action listener: set_extra_try_arguments 23:37:51 INFO - [mozharness: 2017-01-24 07:37:51.508193Z] Finished download-and-extract step (success) 23:37:51 INFO - [mozharness: 2017-01-24 07:37:51.508464Z] Running populate-webroot step. 23:37:51 INFO - Running pre-action listener: _resource_record_pre_action 23:37:51 INFO - Running main action method: populate_webroot 23:37:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:37:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:37:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:37:51 INFO - '--tppagecycles', 23:37:51 INFO - '7'], 23:37:51 INFO - 'tests': ['tsvgm']}}, 23:37:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:37:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:37:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:37:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:37:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:37:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:37:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:51 INFO - 'talos_options': ['--disable-e10s'], 23:37:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:37:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:37:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:51 INFO - 'talos_options': ['--disable-e10s'], 23:37:51 INFO - 'tests': ['damp', 'tps']}, 23:37:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:51 INFO - 'tests': ['damp', 'tps']}, 23:37:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:37:51 INFO - 'tests': ['dromaeo_dom']}, 23:37:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:37:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:37:51 INFO - 'tests': ['basic_compositor_video']}, 23:37:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:37:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:37:51 INFO - 'tests': ['a11yr', 23:37:51 INFO - 'ts_paint', 23:37:51 INFO - 'tpaint', 23:37:51 INFO - 'sessionrestore', 23:37:51 INFO - 'sessionrestore_no_auto_restore', 23:37:51 INFO - 'tabpaint']}, 23:37:51 INFO - 'other-e10s': {'tests': ['a11yr', 23:37:51 INFO - 'ts_paint', 23:37:51 INFO - 'tpaint', 23:37:51 INFO - 'sessionrestore', 23:37:51 INFO - 'sessionrestore_no_auto_restore', 23:37:51 INFO - 'tabpaint']}, 23:37:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:37:51 INFO - 'ts_paint', 23:37:51 INFO - 'tpaint', 23:37:51 INFO - 'sessionrestore', 23:37:51 INFO - 'sessionrestore_no_auto_restore', 23:37:51 INFO - 'tabpaint']}, 23:37:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:37:51 INFO - 'ts_paint', 23:37:51 INFO - 'tpaint', 23:37:51 INFO - 'sessionrestore', 23:37:51 INFO - 'sessionrestore_no_auto_restore', 23:37:51 INFO - 'tabpaint']}, 23:37:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:37:51 INFO - 'tests': ['a11yr', 23:37:51 INFO - 'ts_paint', 23:37:51 INFO - 'tpaint', 23:37:51 INFO - 'sessionrestore', 23:37:51 INFO - 'sessionrestore_no_auto_restore', 23:37:51 INFO - 'tabpaint']}, 23:37:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:37:51 INFO - 'tests': ['a11yr', 23:37:51 INFO - 'ts_paint', 23:37:51 INFO - 'tpaint', 23:37:51 INFO - 'sessionrestore', 23:37:51 INFO - 'sessionrestore_no_auto_restore', 23:37:51 INFO - 'tabpaint']}, 23:37:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:37:51 INFO - 'tests': ['tsvgx', 23:37:51 INFO - 'tsvgr_opacity', 23:37:51 INFO - 'tart', 23:37:51 INFO - 'tscrollx', 23:37:51 INFO - 'cart']}, 23:37:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:37:51 INFO - 'tsvgr_opacity', 23:37:51 INFO - 'tart', 23:37:51 INFO - 'tscrollx', 23:37:51 INFO - 'cart']}, 23:37:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:51 INFO - 'talos_options': ['--disable-e10s'], 23:37:51 INFO - 'tests': ['tp5o']}, 23:37:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:51 INFO - 'tests': ['tp5o']}, 23:37:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:51 INFO - 'talos_options': ['--disable-e10s', 23:37:51 INFO - '--xperf_path', 23:37:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:37:51 INFO - 'tests': ['tp5n']}, 23:37:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:51 INFO - 'talos_options': ['--xperf_path', 23:37:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:37:51 INFO - 'tests': ['tp5n']}}, 23:37:51 INFO - 'talos.zip': {'path': '', 23:37:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:37:51 INFO - Running post-action listener: _resource_record_post_action 23:37:51 INFO - [mozharness: 2017-01-24 07:37:51.526773Z] Finished populate-webroot step (success) 23:37:51 INFO - [mozharness: 2017-01-24 07:37:51.526860Z] Running create-virtualenv step. 23:37:51 INFO - Running pre-action listener: _resource_record_pre_action 23:37:51 INFO - Running main action method: create_virtualenv 23:37:51 INFO - Creating virtualenv /builds/slave/test/build/venv 23:37:51 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 23:37:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:37:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:37:51 INFO - Using real prefix '/usr' 23:37:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:37:52 INFO - Installing distribute.............................................................................................................................................................................................done. 23:37:54 INFO - Installing pip.................done. 23:37:54 INFO - Return code: 0 23:37:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:37:54 INFO - Reading from file tmpfile_stdout 23:37:54 INFO - Output received: 23:37:54 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) 23:37:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:37:54 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')]} 23:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:54 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')]} 23:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:54 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 0x7f6029adff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b13f60>, '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 0x1b14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b151d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', '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 23:37:54 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 23:37:54 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 23:37:54 INFO - Using env: {'DISPLAY': ':0', 23:37:54 INFO - 'HOME': '/home/cltbld', 23:37:54 INFO - 'LANG': 'en_US.UTF-8', 23:37:54 INFO - 'LANGUAGE': 'en_US:en', 23:37:54 INFO - 'LOGNAME': 'cltbld', 23:37:54 INFO - 'MAIL': '/var/mail/cltbld', 23:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:54 INFO - 'MOZ_NO_REMOTE': '1', 23:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:37:54 INFO - 'NO_EM_RESTART': '1', 23:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:54 INFO - 'PWD': '/builds/slave/test', 23:37:54 INFO - 'SHELL': '/bin/bash', 23:37:54 INFO - 'SHLVL': '1', 23:37:54 INFO - 'TERM': 'linux', 23:37:54 INFO - 'TMOUT': '86400', 23:37:54 INFO - 'USER': 'cltbld', 23:37:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', 23:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:54 INFO - '_': '/tools/buildbot/bin/python'} 23:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:54 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 23:37:54 INFO - Cleaning up... 23:37:54 INFO - Return code: 0 23:37:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:37:54 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')]} 23:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:54 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')]} 23:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:54 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 0x7f6029adff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b13f60>, '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 0x1b14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b151d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', '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 23:37:54 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 23:37:54 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 23:37:54 INFO - Using env: {'DISPLAY': ':0', 23:37:54 INFO - 'HOME': '/home/cltbld', 23:37:54 INFO - 'LANG': 'en_US.UTF-8', 23:37:54 INFO - 'LANGUAGE': 'en_US:en', 23:37:54 INFO - 'LOGNAME': 'cltbld', 23:37:54 INFO - 'MAIL': '/var/mail/cltbld', 23:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:54 INFO - 'MOZ_NO_REMOTE': '1', 23:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:37:54 INFO - 'NO_EM_RESTART': '1', 23:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:54 INFO - 'PWD': '/builds/slave/test', 23:37:54 INFO - 'SHELL': '/bin/bash', 23:37:54 INFO - 'SHLVL': '1', 23:37:54 INFO - 'TERM': 'linux', 23:37:54 INFO - 'TMOUT': '86400', 23:37:54 INFO - 'USER': 'cltbld', 23:37:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', 23:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:54 INFO - '_': '/tools/buildbot/bin/python'} 23:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:55 INFO - Downloading/unpacking psutil>=3.1.1 23:37: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 23:37: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 23:37: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 23:37: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 23:37: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 23:37: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 23:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:37:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:37:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:37:57 INFO - Installing collected packages: psutil 23:37:57 INFO - Running setup.py install for psutil 23:37:57 INFO - building 'psutil._psutil_linux' extension 23:37:57 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 23:37:58 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 23:37:58 INFO - building 'psutil._psutil_posix' extension 23:37:58 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 23:37:59 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 23:37:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:37:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:37:59 INFO - Successfully installed psutil 23:37:59 INFO - Cleaning up... 23:37:59 INFO - Return code: 0 23:37:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:37: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')]} 23:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37: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')]} 23:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:59 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 0x7f6029adff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b13f60>, '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 0x1b14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b151d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', '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 23:37:59 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 23:37:59 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 23:37:59 INFO - Using env: {'DISPLAY': ':0', 23:37:59 INFO - 'HOME': '/home/cltbld', 23:37:59 INFO - 'LANG': 'en_US.UTF-8', 23:37:59 INFO - 'LANGUAGE': 'en_US:en', 23:37:59 INFO - 'LOGNAME': 'cltbld', 23:37:59 INFO - 'MAIL': '/var/mail/cltbld', 23:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:59 INFO - 'MOZ_NO_REMOTE': '1', 23:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:37:59 INFO - 'NO_EM_RESTART': '1', 23:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:59 INFO - 'PWD': '/builds/slave/test', 23:37:59 INFO - 'SHELL': '/bin/bash', 23:37:59 INFO - 'SHLVL': '1', 23:37:59 INFO - 'TERM': 'linux', 23:37:59 INFO - 'TMOUT': '86400', 23:37:59 INFO - 'USER': 'cltbld', 23:37:59 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', 23:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:59 INFO - '_': '/tools/buildbot/bin/python'} 23:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:37: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 23:37: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 23:37: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 23:37: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 23:37: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 23:37: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 23:38:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:38:01 INFO - Installing collected packages: mozsystemmonitor 23:38:01 INFO - Running setup.py install for mozsystemmonitor 23:38:01 INFO - Successfully installed mozsystemmonitor 23:38:01 INFO - Cleaning up... 23:38:01 INFO - Return code: 0 23:38:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:38:01 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')]} 23:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:01 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')]} 23:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:01 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 0x7f6029adff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b13f60>, '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 0x1b14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b151d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', '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 23:38:01 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 23:38:01 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 23:38:01 INFO - Using env: {'DISPLAY': ':0', 23:38:01 INFO - 'HOME': '/home/cltbld', 23:38:01 INFO - 'LANG': 'en_US.UTF-8', 23:38:01 INFO - 'LANGUAGE': 'en_US:en', 23:38:01 INFO - 'LOGNAME': 'cltbld', 23:38:01 INFO - 'MAIL': '/var/mail/cltbld', 23:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:01 INFO - 'MOZ_NO_REMOTE': '1', 23:38:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:38:01 INFO - 'NO_EM_RESTART': '1', 23:38:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:01 INFO - 'PWD': '/builds/slave/test', 23:38:01 INFO - 'SHELL': '/bin/bash', 23:38:01 INFO - 'SHLVL': '1', 23:38:01 INFO - 'TERM': 'linux', 23:38:01 INFO - 'TMOUT': '86400', 23:38:01 INFO - 'USER': 'cltbld', 23:38:01 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', 23:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:01 INFO - '_': '/tools/buildbot/bin/python'} 23:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:38:01 INFO - Downloading/unpacking jsonschema==2.5.1 23:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:38:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:38:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:38:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:38:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:38:03 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 23:38:03 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 23:38:03 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 23:38:03 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 23:38:03 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 23:38:03 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 23:38:04 INFO - Downloading functools32-3.2.3-2.tar.gz 23:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:38:04 INFO - warning: no files found matching '*.txt' 23:38:04 INFO - no previously-included directories found matching 'build' 23:38:04 INFO - no previously-included directories found matching 'dist' 23:38:04 INFO - no previously-included directories found matching '.git*' 23:38:04 INFO - Installing collected packages: jsonschema, functools32 23:38:04 INFO - Running setup.py install for functools32 23:38:04 INFO - warning: no files found matching '*.txt' 23:38:04 INFO - no previously-included directories found matching 'build' 23:38:04 INFO - no previously-included directories found matching 'dist' 23:38:04 INFO - no previously-included directories found matching '.git*' 23:38:04 INFO - Successfully installed jsonschema functools32 23:38:04 INFO - Cleaning up... 23:38:04 INFO - Return code: 0 23:38:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6029adff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b13f60>, '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 0x1b14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b151d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', '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 23:38:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:38:04 INFO - Using env: {'DISPLAY': ':0', 23:38:04 INFO - 'HOME': '/home/cltbld', 23:38:04 INFO - 'LANG': 'en_US.UTF-8', 23:38:04 INFO - 'LANGUAGE': 'en_US:en', 23:38:04 INFO - 'LOGNAME': 'cltbld', 23:38:04 INFO - 'MAIL': '/var/mail/cltbld', 23:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:04 INFO - 'MOZ_NO_REMOTE': '1', 23:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:38:04 INFO - 'NO_EM_RESTART': '1', 23:38:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:04 INFO - 'PWD': '/builds/slave/test', 23:38:04 INFO - 'SHELL': '/bin/bash', 23:38:04 INFO - 'SHLVL': '1', 23:38:04 INFO - 'TERM': 'linux', 23:38:04 INFO - 'TMOUT': '86400', 23:38:04 INFO - 'USER': 'cltbld', 23:38:04 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', 23:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:04 INFO - '_': '/tools/buildbot/bin/python'} 23:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:38:04 INFO - Cleaning up... 23:38:04 INFO - Return code: 0 23:38:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6029adff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b13f60>, '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 0x1b14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b151d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', '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 23:38:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:38:04 INFO - Using env: {'DISPLAY': ':0', 23:38:04 INFO - 'HOME': '/home/cltbld', 23:38:04 INFO - 'LANG': 'en_US.UTF-8', 23:38:04 INFO - 'LANGUAGE': 'en_US:en', 23:38:04 INFO - 'LOGNAME': 'cltbld', 23:38:04 INFO - 'MAIL': '/var/mail/cltbld', 23:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:04 INFO - 'MOZ_NO_REMOTE': '1', 23:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:38:04 INFO - 'NO_EM_RESTART': '1', 23:38:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:04 INFO - 'PWD': '/builds/slave/test', 23:38:04 INFO - 'SHELL': '/bin/bash', 23:38:04 INFO - 'SHLVL': '1', 23:38:04 INFO - 'TERM': 'linux', 23:38:04 INFO - 'TMOUT': '86400', 23:38:04 INFO - 'USER': 'cltbld', 23:38:04 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', 23:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:04 INFO - '_': '/tools/buildbot/bin/python'} 23:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:38:04 INFO - Downloading/unpacking blobuploader==1.2.4 23:38: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 23:38: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 23:38: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 23:38: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 23:38: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 23:38: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 23:38:06 INFO - Downloading blobuploader-1.2.4.tar.gz 23:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:38:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:38:06 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 23:38:06 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 23:38:06 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 23:38:06 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 23:38:06 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 23:38:06 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 23:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:38:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:38:07 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 23:38:07 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 23:38:07 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 23:38:07 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 23:38:07 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 23:38:07 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 23:38:07 INFO - Downloading docopt-0.6.1.tar.gz 23:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:38:07 INFO - Installing collected packages: blobuploader, requests, docopt 23:38:07 INFO - Running setup.py install for blobuploader 23:38:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:38:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:38:07 INFO - Running setup.py install for requests 23:38:08 INFO - Running setup.py install for docopt 23:38:08 INFO - Successfully installed blobuploader requests docopt 23:38:08 INFO - Cleaning up... 23:38:08 INFO - Return code: 0 23:38:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:38:08 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')]} 23:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:08 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')]} 23:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:08 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 0x7f6029adff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b13f60>, '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 0x1b14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b151d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', '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 23:38:08 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 23:38:08 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 23:38:08 INFO - Using env: {'DISPLAY': ':0', 23:38:08 INFO - 'HOME': '/home/cltbld', 23:38:08 INFO - 'LANG': 'en_US.UTF-8', 23:38:08 INFO - 'LANGUAGE': 'en_US:en', 23:38:08 INFO - 'LOGNAME': 'cltbld', 23:38:08 INFO - 'MAIL': '/var/mail/cltbld', 23:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:08 INFO - 'MOZ_NO_REMOTE': '1', 23:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:38:08 INFO - 'NO_EM_RESTART': '1', 23:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:08 INFO - 'PWD': '/builds/slave/test', 23:38:08 INFO - 'SHELL': '/bin/bash', 23:38:08 INFO - 'SHLVL': '1', 23:38:08 INFO - 'TERM': 'linux', 23:38:08 INFO - 'TMOUT': '86400', 23:38:08 INFO - 'USER': 'cltbld', 23:38:08 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', 23:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:08 INFO - '_': '/tools/buildbot/bin/python'} 23:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:38:08 INFO - Running setup.py (path:/tmp/pip-9W7Dvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:38:08 INFO - Running setup.py (path:/tmp/pip-dvgVbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:38:08 INFO - Running setup.py (path:/tmp/pip-SHo0pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:38:08 INFO - Running setup.py (path:/tmp/pip-8qmWz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:38:08 INFO - Running setup.py (path:/tmp/pip-2BhlDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:38:08 INFO - Running setup.py (path:/tmp/pip-PDJnkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:38:08 INFO - Running setup.py (path:/tmp/pip-gD0jOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:38:09 INFO - Running setup.py (path:/tmp/pip-1e1qSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:38:09 INFO - Running setup.py (path:/tmp/pip-8j74KZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:38:09 INFO - Running setup.py (path:/tmp/pip-jdee3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:38:09 INFO - Running setup.py (path:/tmp/pip-K8epWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:38:09 INFO - Running setup.py (path:/tmp/pip-HbGr2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:38:09 INFO - Running setup.py (path:/tmp/pip-NMlXty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:38:09 INFO - Running setup.py (path:/tmp/pip-ybbywu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:38:09 INFO - Running setup.py (path:/tmp/pip-2pzoRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:38:09 INFO - Running setup.py (path:/tmp/pip-a9b1y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:38:09 INFO - Running setup.py (path:/tmp/pip-WpDWMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:38:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:38:09 INFO - Running setup.py install for manifestparser 23:38:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:38:09 INFO - Running setup.py install for mozcrash 23:38:09 INFO - Running setup.py install for mozdebug 23:38:10 INFO - Running setup.py install for mozdevice 23:38:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:38:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:38:10 INFO - Running setup.py install for mozfile 23:38:10 INFO - Running setup.py install for mozhttpd 23:38:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:38:10 INFO - Running setup.py install for mozinfo 23:38:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:38:10 INFO - Running setup.py install for mozInstall 23:38:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:38:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:38:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:38:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:38:10 INFO - Running setup.py install for mozleak 23:38:10 INFO - Running setup.py install for mozlog 23:38:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:38:10 INFO - Running setup.py install for moznetwork 23:38:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:38:10 INFO - Running setup.py install for mozprocess 23:38:11 INFO - Running setup.py install for mozprofile 23:38:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:38:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:38:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:38:11 INFO - Running setup.py install for mozrunner 23:38:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:38:11 INFO - Running setup.py install for mozscreenshot 23:38:11 INFO - Running setup.py install for moztest 23:38:11 INFO - Running setup.py install for mozversion 23:38:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:38:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:38:11 INFO - Cleaning up... 23:38:11 INFO - Return code: 0 23:38:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:38:11 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')]} 23:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:11 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')]} 23:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:11 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 0x7f6029adff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b13f60>, '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 0x1b14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b151d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', '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 23:38:11 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 23:38:11 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 23:38:11 INFO - Using env: {'DISPLAY': ':0', 23:38:11 INFO - 'HOME': '/home/cltbld', 23:38:11 INFO - 'LANG': 'en_US.UTF-8', 23:38:11 INFO - 'LANGUAGE': 'en_US:en', 23:38:11 INFO - 'LOGNAME': 'cltbld', 23:38:11 INFO - 'MAIL': '/var/mail/cltbld', 23:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:11 INFO - 'MOZ_NO_REMOTE': '1', 23:38:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:38:11 INFO - 'NO_EM_RESTART': '1', 23:38:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:11 INFO - 'PWD': '/builds/slave/test', 23:38:11 INFO - 'SHELL': '/bin/bash', 23:38:11 INFO - 'SHLVL': '1', 23:38:11 INFO - 'TERM': 'linux', 23:38:11 INFO - 'TMOUT': '86400', 23:38:11 INFO - 'USER': 'cltbld', 23:38:11 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', 23:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:11 INFO - '_': '/tools/buildbot/bin/python'} 23:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:38:11 INFO - Running setup.py (path:/tmp/pip-VH7_Y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:38:11 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)) 23:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:38:11 INFO - Running setup.py (path:/tmp/pip-LOE4gW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:38:11 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)) 23:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:38:11 INFO - Running setup.py (path:/tmp/pip-Al0Iqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:38:12 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)) 23:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:38:12 INFO - Running setup.py (path:/tmp/pip-iisWdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:38:12 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)) 23:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:38:12 INFO - Running setup.py (path:/tmp/pip-PP6Tab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:38:12 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)) 23:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:38:12 INFO - Running setup.py (path:/tmp/pip-sNGMdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:38:12 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)) 23:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:38:12 INFO - Running setup.py (path:/tmp/pip-sar2ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:38:12 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)) 23:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:38:12 INFO - Running setup.py (path:/tmp/pip-P6Cah_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:38:12 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)) 23:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:38:12 INFO - Running setup.py (path:/tmp/pip-0gGeiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:38:12 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)) 23:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:38:12 INFO - Running setup.py (path:/tmp/pip-pnvkK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:38:12 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)) 23:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:38:12 INFO - Running setup.py (path:/tmp/pip-yxG4gO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:38:12 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)) 23:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:38:12 INFO - Running setup.py (path:/tmp/pip-zWgXnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:38:12 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)) 23:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:38:12 INFO - Running setup.py (path:/tmp/pip-_1RKS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:38:12 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)) 23:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:38:12 INFO - Running setup.py (path:/tmp/pip-xUW5Ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:38:12 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)) 23:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:38:12 INFO - Running setup.py (path:/tmp/pip-0m2OKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:38:12 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)) 23:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:38:12 INFO - Running setup.py (path:/tmp/pip-lWOn1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:38:12 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)) 23:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:38:12 INFO - Running setup.py (path:/tmp/pip-JqCJzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:38:13 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)) 23:38:13 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)) 23:38:13 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)) 23:38:13 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)) 23:38:13 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)) 23:38:13 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)) 23:38:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:38:13 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 23:38:13 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 23:38:13 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 23:38:13 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 23:38:13 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 23:38:13 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 23:38:15 INFO - Downloading blessings-1.6.tar.gz 23:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:38:15 INFO - Installing collected packages: blessings 23:38:15 INFO - Running setup.py install for blessings 23:38:15 INFO - Successfully installed blessings 23:38:15 INFO - Cleaning up... 23:38:15 INFO - Return code: 0 23:38:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:38:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:38:15 INFO - Reading from file tmpfile_stdout 23:38:15 INFO - Current package versions: 23:38:15 INFO - argparse == 1.2.1 23:38:15 INFO - blessings == 1.6 23:38:15 INFO - blobuploader == 1.2.4 23:38:15 INFO - docopt == 0.6.1 23:38:15 INFO - functools32 == 3.2.3-2 23:38:15 INFO - jsonschema == 2.5.1 23:38:15 INFO - manifestparser == 1.1 23:38:15 INFO - mozInstall == 1.12 23:38:15 INFO - mozcrash == 1.0 23:38:15 INFO - mozdebug == 0.1 23:38:15 INFO - mozdevice == 0.48 23:38:15 INFO - mozfile == 1.2 23:38:15 INFO - mozhttpd == 0.7 23:38:15 INFO - mozinfo == 0.9 23:38:15 INFO - mozleak == 0.1 23:38:15 INFO - mozlog == 3.4 23:38:15 INFO - moznetwork == 0.27 23:38:15 INFO - mozprocess == 0.23 23:38:15 INFO - mozprofile == 0.28 23:38:15 INFO - mozrunner == 6.13 23:38:15 INFO - mozscreenshot == 0.1 23:38:15 INFO - mozsystemmonitor == 0.3 23:38:15 INFO - moztest == 0.8 23:38:15 INFO - mozversion == 1.4 23:38:15 INFO - psutil == 3.1.1 23:38:15 INFO - requests == 1.2.3 23:38:15 INFO - wsgiref == 0.1.2 23:38:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:38:15 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')]} 23:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:15 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')]} 23:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:15 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 0x7f6029adff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b13f60>, '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 0x1b14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b151d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', '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 23:38:15 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 23:38:15 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 23:38:15 INFO - Using env: {'DISPLAY': ':0', 23:38:15 INFO - 'HOME': '/home/cltbld', 23:38:15 INFO - 'LANG': 'en_US.UTF-8', 23:38:15 INFO - 'LANGUAGE': 'en_US:en', 23:38:15 INFO - 'LOGNAME': 'cltbld', 23:38:15 INFO - 'MAIL': '/var/mail/cltbld', 23:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:15 INFO - 'MOZ_NO_REMOTE': '1', 23:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:38:15 INFO - 'NO_EM_RESTART': '1', 23:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:15 INFO - 'PWD': '/builds/slave/test', 23:38:15 INFO - 'SHELL': '/bin/bash', 23:38:15 INFO - 'SHLVL': '1', 23:38:15 INFO - 'TERM': 'linux', 23:38:15 INFO - 'TMOUT': '86400', 23:38:15 INFO - 'USER': 'cltbld', 23:38:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', 23:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:15 INFO - '_': '/tools/buildbot/bin/python'} 23:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:38:15 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)) 23:38:15 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)) 23:38:15 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)) 23:38:15 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)) 23:38:15 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)) 23:38:15 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)) 23:38:15 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)) 23:38:15 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)) 23:38:15 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)) 23:38:15 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)) 23:38:15 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)) 23:38:15 INFO - Cleaning up... 23:38:15 INFO - Return code: 0 23:38:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:38:15 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')]} 23:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:15 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')]} 23:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:15 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 0x7f6029adff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b16ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b13f60>, '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 0x1b14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b151d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', '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 23:38:15 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 23:38:15 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 23:38:15 INFO - Using env: {'DISPLAY': ':0', 23:38:15 INFO - 'HOME': '/home/cltbld', 23:38:15 INFO - 'LANG': 'en_US.UTF-8', 23:38:15 INFO - 'LANGUAGE': 'en_US:en', 23:38:15 INFO - 'LOGNAME': 'cltbld', 23:38:15 INFO - 'MAIL': '/var/mail/cltbld', 23:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:15 INFO - 'MOZ_NO_REMOTE': '1', 23:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:38:15 INFO - 'NO_EM_RESTART': '1', 23:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:15 INFO - 'PWD': '/builds/slave/test', 23:38:15 INFO - 'SHELL': '/bin/bash', 23:38:15 INFO - 'SHLVL': '1', 23:38:15 INFO - 'TERM': 'linux', 23:38:15 INFO - 'TMOUT': '86400', 23:38:15 INFO - 'USER': 'cltbld', 23:38:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', 23:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:15 INFO - '_': '/tools/buildbot/bin/python'} 23:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:38:16 INFO - Cleaning up... 23:38:16 INFO - Return code: 0 23:38:16 INFO - Running post-action listener: _resource_record_post_action 23:38:16 INFO - Running post-action listener: _start_resource_monitoring 23:38:16 INFO - Starting resource monitoring. 23:38:16 INFO - [mozharness: 2017-01-24 07:38:16.072890Z] Finished create-virtualenv step (success) 23:38:16 INFO - [mozharness: 2017-01-24 07:38:16.073811Z] Running install step. 23:38:16 INFO - Running pre-action listener: _resource_record_pre_action 23:38:16 INFO - Running main action method: install 23:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:38:16 INFO - Reading from file tmpfile_stdout 23:38:16 INFO - Detecting whether we're running mozinstall >=1.0... 23:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:38:16 INFO - Reading from file tmpfile_stdout 23:38:16 INFO - Output received: 23:38:16 INFO - Usage: mozinstall [options] installer 23:38:16 INFO - Options: 23:38:16 INFO - -h, --help show this help message and exit 23:38:16 INFO - -d DEST, --destination=DEST 23:38:16 INFO - Directory to install application into. [default: 23:38:16 INFO - "/builds/slave/test"] 23:38:16 INFO - --app=APP Application being installed. [default: firefox] 23:38:16 INFO - mkdir: /builds/slave/test/build/application 23:38:16 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'] 23:38:16 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 23:38:29 INFO - Reading from file tmpfile_stdout 23:38:29 INFO - Output received: 23:38:29 INFO - /builds/slave/test/build/application/firefox/firefox 23:38:29 INFO - Running post-action listener: _resource_record_post_action 23:38:29 INFO - [mozharness: 2017-01-24 07:38:29.984950Z] Finished install step (success) 23:38:29 INFO - [mozharness: 2017-01-24 07:38:29.985192Z] Running run-tests step. 23:38:29 INFO - Running pre-action listener: _resource_record_pre_action 23:38:29 INFO - Running main action method: run_tests 23:38:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:38:29 INFO - Python 2.7.3 23:38:29 INFO - Return code: 0 23:38:29 INFO - grabbing minidump binary from tooltool 23:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:38:29 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 0x1b13f60>, '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 0x1b14d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b151d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:38:29 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 23:38:29 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 23:38:29 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 23:38:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:38:30 INFO - Return code: 0 23:38:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:38:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:38:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:38:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:38:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:38:30 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:38:30 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:38:30 INFO - Using env: {'DISPLAY': ':0', 23:38:30 INFO - 'HOME': '/home/cltbld', 23:38:30 INFO - 'LANG': 'en_US.UTF-8', 23:38:30 INFO - 'LANGUAGE': 'en_US:en', 23:38:30 INFO - 'LOGNAME': 'cltbld', 23:38:30 INFO - 'MAIL': '/var/mail/cltbld', 23:38:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:38:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:30 INFO - 'MOZ_NO_REMOTE': '1', 23:38:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:38:30 INFO - 'NO_EM_RESTART': '1', 23:38:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:30 INFO - 'PWD': '/builds/slave/test', 23:38:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:38:30 INFO - 'SHELL': '/bin/bash', 23:38:30 INFO - 'SHLVL': '1', 23:38:30 INFO - 'TERM': 'linux', 23:38:30 INFO - 'TMOUT': '86400', 23:38:30 INFO - 'USER': 'cltbld', 23:38:30 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006', 23:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:30 INFO - '_': '/tools/buildbot/bin/python'} 23:38:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:38:30 INFO - mozversion application_buildid: 20170123215343 23:38:30 INFO - mozversion application_changeset: 1522cb56a651b62675f392d4064bd4365aac07f4 23:38:30 INFO - mozversion application_display_name: Firefox 23:38:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:38:30 INFO - mozversion application_name: Firefox 23:38:30 INFO - mozversion application_remotingname: firefox 23:38:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:38:30 INFO - mozversion application_vendor: Mozilla 23:38:30 INFO - mozversion application_version: 52.0 23:38:30 INFO - mozversion platform_buildid: 20170123215343 23:38:30 INFO - mozversion platform_changeset: 1522cb56a651b62675f392d4064bd4365aac07f4 23:38:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:38:30 INFO - mozversion platform_version: 52.0 23:38:30 INFO - using testdate: 1485243510 23:38:30 INFO - actual date: 1485243510 23:38:30 INFO - starting webserver on 'localhost:41166' 23:38:30 INFO - SUITE-START | Running 2 tests 23:38:30 INFO - TEST-START | dromaeo_css 23:38:30 INFO - operating with platform_type : linux_ 23:38:30 INFO - Initialising browser for dromaeo_css test... 23:38:30 INFO - TEST-INFO | started process 3317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTSlGST/profile http://localhost:41166/getInfo.html) 23:38:36 INFO - PROCESS | 3317 | __metrics Screen width/height:1600/1200 23:38:36 INFO - PROCESS | 3317 | colorDepth:24 23:38:36 INFO - PROCESS | 3317 | Browser inner width/height: 1024/697 23:38:36 INFO - PROCESS | 3317 | __metrics 23:38:37 INFO - PROCESS | 3317 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:38:37 INFO - PROCESS | 3317 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:38:37 INFO - PROCESS | 3317 | console.error: PushService: 23:38:37 INFO - PROCESS | 3317 | stateChangeProcessEnqueue: Error transitioning state 23:38:37 INFO - PROCESS | 3317 | UnknownError 23:38:38 INFO - TEST-INFO | 3317: exit 0 23:38:38 INFO - Browser initialized. 23:38:38 INFO - Running cycle 1/1 for dromaeo_css test... 23:38:38 INFO - TEST-INFO | started process 3409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTSlGST/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:38:50 INFO - PROCESS | 3409 | RSS: Main: 141393920 23:38:50 INFO - PROCESS | 3409 | 23:41:51 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:41166/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41166/tests/dromaeo/cssquery-ext.html) 23:41:52 INFO - PROCESS | 3409 | RSS: Main: 239218688 23:41:52 INFO - PROCESS | 3409 | 23:44:55 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:41166/tests/dromaeo/cssquery-ext.html (next: http://localhost:41166/tests/dromaeo/cssquery-jquery.html) 23:44:55 INFO - PROCESS | 3409 | RSS: Main: 230760448 23:44:55 INFO - PROCESS | 3409 | 23:47:57 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:41166/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41166/tests/dromaeo/cssquery-mootools.html) 23:47:58 INFO - PROCESS | 3409 | RSS: Main: 197115904 23:47:58 INFO - PROCESS | 3409 | 23:51:00 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:41166/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41166/tests/dromaeo/cssquery-prototype.html) 23:51:00 INFO - PROCESS | 3409 | RSS: Main: 209559552 23:51:00 INFO - PROCESS | 3409 | 23:54:03 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:41166/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41166/tests/dromaeo/cssquery-yui.html) 23:54:03 INFO - PROCESS | 3409 | RSS: Main: 175931392 23:54:03 INFO - PROCESS | 3409 | 23:57:06 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:41166/tests/dromaeo/cssquery-yui.html (next: http://localhost:41166/tests/dromaeo/cssquery-dojo.html) 23:57:06 INFO - PROCESS | 3409 | RSS: Main: 266108928 23:57:06 INFO - PROCESS | 3409 | 23:57:06 INFO - PROCESS | 3409 | __start_tp_report 23:57:06 INFO - PROCESS | 3409 | _x_x_mozilla_page_load 23:57:06 INFO - PROCESS | 3409 | _x_x_mozilla_page_load_details 23:57:06 INFO - PROCESS | 3409 | |i|pagename|runs| 23:57:06 INFO - PROCESS | 3409 | |0;dojo.html;3187.187267246852;3230.224746060946;3238.3199528099103;3256.1859535116223;3261.3477304539083;5531.336239651242;5575.916361254579;5581.107022876341;5581.776728930848;5596.384397716248;5564.554835613151;5579.107342825148;5585.525230355414;5586.804461843836;5596.328440587125;5015.949840501594;5029.270755740416;5065.214891691794;5092.9745351273195;5137.101007323722;4893.41279046515;4929.433115191763;5054.9241761373605;5110.897782044357;5117.053345131144;5002.599792016648;5005.299258103868;5049.8485045448515;5055.165897626887;5062.392512898439;5104.872378190538;5117.846464606049;5179.404368497633;5180.130895780676;5210.817621383233;4772.427308722976;5071.137906555894;5092.898142037176;5127.359080114986;5147.716875571842;5310.867228319285;5420.972895135538;5433.049216387117;5443.755031023614;5491.862703432406;5894.646321220741;5899.528037756969;5970.104484327386;5985.0124729419595;5990.041593345088;5789.681567513785;6032.4570788629235;6041.033434650479;6070.301915279755;6071.605345652519;5422.9728851355885;5549.528290095347;5557.444255574491;5593.244911936918;5646.040173170571;6181.196444462191;6182.381761823782;6198.845028874314;6202.503799696104;6204.348543402878;5663.660180389107;5935.52515798735;5939.584229103922;5941.821745347646;5949.196858424144;5770.16332631766;5864.618799778086;5916.408359164136;5931.377205393458;6030.396960304022;5968.552358573038;5968.582199246011;5977.880442391215;5977.880442391215;6013.248343957005;5931.73307201177;5991.071383935497;5991.58058935879;5994.250718660168;5994.850128746729;4470.619997300201;4491.101779644085;4526.95473045272;4545.204589196877;4560.612347950461;4057.736247143926;4088.3254263046265;4096.2871484343805;4120.670346372283;4127.587241275848;5641.576881733804;5649.971750141305;5650.0959846424375;5654.717264136777;5679.687617181012;5803.912941305884;5854.443827836349;5956.76172953077;5963.552733544915;5998.550108741862;5734.598578099493;5736.913946290809;5748.798792042258;5752.539796816244;5772.595918285764;5172.146595811724;5212.530872221519;5212.765425555859;5217.895642087213;5248.553872920845;6016.308124565643;6032.095185722177;6236;6286.18279623646;6304.085907543381;5847.707614619337;5926.555508336978;5928.3775203603;5982.760689572368;6003.969980150071;6199.659018754011;6200.410960958701;6203.875922481616;6210.658413787285;6214.067889816383;5600.411956744483;5828.446297601721;5844.327902291121;5845.736941837713;5846.590738648254;5823.5923485355615;5942.494887934401;5992.131140984446;5996.790112346047;6092.177556029879;5827.125931110198;5867.853303667443;5873.706314684334;5874.471297583067;5877.0302900021015;5869.501092407022;5871.647701137946;5872.765089396376;5876.882462350814;5878.794242201502;5604.8879022418505;5627.774889004558;5696.515796157373;5735.655860648374;5764.481196692318;5850.12248162779;5857.238558987475;5857.47282744555;5861.238039055066;5870.412958704095;5524.14375771756;5565.081761509306;5696.401877802937;5702.657840529581;5707.885842283048 23:57:06 INFO - PROCESS | 3409 | |1;ext.html;588.58210670424;607.5959486941183;642.2806456768419;659.6174218953005;672.4754691340756;34560.13599660007;35335.2932941341;46191.30713039307;47222.763886180524;47356.76321618387;43915.78042109785;48218.27672584914;48259.75870120645;48282;48350.75824620881;8461.53461559614;8866.246369058621;8997.100289970984;9008.639654413848;9014.188723014928;8445.873311900326;10704.678859634223;10961.780764384748;10962.945185274102;11289;10986.066184374338;11047.392393418359;11062.612808551703;11066.114710823114;11073.058790002859;10876.456177191109;10924.508397122148;10937.398443085627;10939.234253602252;10953.83569246454;10904.672859814218;10956.28784129029;10956.506957186946;10967.890321096846;10983.340999540053;45332.320015199795;45489.31766023512;45721.31418028732;45734.771326143156;45743.54256457426;3643.908902277438;3758.0604848787802;4382.715123516961;4399.846005389796;4463.553644635543;33347;33421.33157336864;33497.33005339879;33500.396463248675;33571.496427553604;4371.693981421302;4433.791498418638;4436.471211409498;4447.444069491314;4491.550844915515;257667;257947;257975.71012145007;258138;258992;63420.36579634237;63616;63817;63864;63867;39932.80033599871;41150.588494115276;41202.38196427056;43466.130677386274;66420.33579664238;17738.5565360867;17832.732509012374;17841.7323740144;17847.910760446113;17848.732269015974;12620.17968832023;12830;14035.719285614436;14190.858091418953;14284;20314.085866136058;20458.95410458972;20520.281790137273;20526.794732052487;20557.280495182596;7245.311695388929;7288.344049035612;7390.371818395389;7455.589942553212;7583.658735356922;980.6616717232686;994.2841154368842;1067.9305845120043;1112.076976109827;1117.5976648406568;32118.197045073593;32181.35637287241;32310.19224519406;32382.19044523906;32867.83566082202;1095.9945200274108;1115.0522056252282;1122.7698321844166;1181.468339247342;1186.95845645402;17224.827751722572;17255.22351494186;17308.307667693403;17400;17453.21460534279;416323;423853;423964;424129;424496;59102;59582;59589;59740.70129649324;59789;1282.9550965716342;1327.0511584217138;1337.404854839587;1363.352407606379;1382.384838746748;29640.407191856473;33524.329513410084;33565;34119.65880341165;34517.309653807286;52579.94840103253;53083.469165307855;53175.468245318596;53193.73403132959;53229;372552;373334;373549;374055;374691;27620.585691214244;27927.441451170456;28382;28426;29864;44358;49109.50890491049;49624.79592193422;49853;50087.49912500828;41362.379564307164;41461.37807932823;41725;41731.374029390194;42896.35655465233;41526;42426;42669.35995960125;43277;43358;41510;41995.37006944837;42600;42740.35889461599;42810.14379712326;35279.823600881835;37361.25277494381;37555.436668450544;37835.243295134496;38258.61741382551;27982.44035119327;27985;28312.433751324446;28363.71636283611;28375.71624283731 23:57:06 INFO - PROCESS | 3409 | |2;jquery.html;415.35205080075104;416.92286926918524;425.3173656281668;426.2519278665941;435.09283144643416;18453.815461845395;19277.132529036193;20173.29393471229;20224;20585.27951521697;18746.156422960965;19047.904760476213;19812.801871981275;20002.499937501532;20009.399718008484;5140.126178549655;5379.246905433242;5402.78388864445;5452.6455780374345;5471.480209380123;5237.580993520528;5403.2165336026255;5431.891362172754;5439.0209762242785;5439.048166570854;5360.2763626910255;5395.7032363220005;5395.919061214085;5398.811041613544;5401.810936617219;5297.419078284944;5370.167624018283;5372.2210279509445;5377.085895397791;5797.971010144965;5316.521513063843;5320.281761962125;5330.093884039684;5336.839894803124;5337.279467271907;14282.714345713028;14447.277636118151;14483.637909052253;14845.480408185662;15002.02486838352;2408.0849277274697;2542.733013033623;2586.961195582068;2712.294803351143;3018.833964131994;10195.337303075275;10542.894571054345;10644.254902156852;10707.089897358734;10823.458827058615;1937.680282753344;2013.4865609269543;2052.3022172461287;2067.3281183615236;2088.5092003379195;79781.60109199474;80647.19352806456;82216;82291.58854205691;86823.56588217018;11735.471903764352;11808.70478238051;11816.231944923553;11977.341246231366;11999.160058795975;16571.42000029993;16614.00315981045;16620;16631.584210394594;16648;8416.158384161536;8580.95709521461;8637.956810215908;8696.347773916981;8717.956410218036;8271.669133234604;8340.165983401612;8354.373421993374;8382.245597896219;8570.528620925785;4972.179590367549;5043.5712964398435;5059.595232381401;5100.821471248489;5113.079645663816;2059.3718915730847;2062.9381118566466;2111.9577608447744;2118.5233322502313;2119.173522326294;887.3344991256557;957.0812020460436;994.2841154368842;1016.8627235323285;1114.4539175803798;20056.899715501328;20093.095810688556;20276.797232027788;20327.695084573745;20357.694634580494;1012.1953047327393;1016.8983101689772;1030.3714734012246;1042.4162469017374;1044.9738756530996;10502.317349372266;11133.818686946874;11135.01265228916;11443.599474018369;11534.250273732181;460406;468579;472897;489537;495616;75965.91387360705;77140.22859771442;95610.52194739121;98219;98245.5087724571;916.1983264643437;1010.2322235101523;1011.0698157694939;1034.6171916390983;1040.7918416316616;17490;18273.81726182721;18296.26814927388;18389.90805045966;18543.814561854208;43027;44085.559144408144;44380.778096109316;44755.104897902514;45102.54897450984;56736.14895776484;57296.56220626776;59178;61056.69471652613;61247.69376153091;9192.402493837879;12254.264744115382;12641.557545485864;12676.746465070462;12981.4158362872;14266.857331426552;14515.274236288355;14734.968552201672;14804.7779283313;15295.923520382326;11198.664040078811;11382.658520244406;12352.444140013542;12418.503259869865;12927.935360323138;11420.600278990196;11903.82144267854;12221.572244971383;12238.632841014783;12693.492260309484;12445.937770311091;12698;13286.20282783036;13292.26892520882;13600.727985440433;13239.933800330937;13326.733465330446;13399.33003349809;13407.262600557064;13439.731205375641;12818.166819156724;12871.485140594272;12978.091533592935;12994.80507792365;13049.608511744664 23:57:06 INFO - PROCESS | 3409 | |3;mootools.html;1540.5532395605276;1554.4404014554761;1717.8196289389614;1817.3730063128216;1838.9080545972697;8425.32597392208;9012.594433250511;9018.639254429814;9022.458652480856;9029;7806.180351063128;7979.720709775159;7991;8231.382646301536;8828.29373650108;2329.6738456616044;2383.3088404362716;2388.235764555343;2416.794572461343;2425.648280999254;2432.1487479382163;2449.8285120041605;2450.644656524803;2453.681021467207;2454.521368333176;2408.0728919366084;2428.4657375377387;2428.514297140579;2430.283066495388;2430.6840110785574;2368.6328619064075;2396.1373905394216;2398.4363674536385;2398.904043838253;2399.664047033417;2390.7728765767224;2397.2209032064648;2398.9640155397683;2404.843685160459;2416.2388847513153;8873.73378798637;8932.687355942577;8935.910640893573;8937.910620893774;8964.775880602972;5346.4118946915805;5482.095454250044;5482.424345443751;5488.204210389511;5490.231367608538;3180.189051791778;3259.103746469716;3468.1676397664633;3468.618451970281;3485.024193225901;1042.4318746283218;1080.222239987208;1096.8957948994832;1108.6175269531998;1119.7592517608753;11645.417729113595;11930.821037684442;11942.522299108025;11975.580854670045;11978.64064078079;4486.887827804266;4637.837675681335;4675.509071547506;4678.415198100238;4698.2247929092;9886.258530610234;9892.307538472238;9899.059589339002;9903.950480247553;9919.40483570988;5381;5389.7035663038905;5394.244805727201;5396.811111611075;5401.567874570025;4357.803898824561;4845.466998630148;5002.049610573979;5015.097282489114;5017.0216807722145;3705.1478160023344;3922.5881282465502;4037.9798101009305;4074.6536544394057;4075.144219713834;1238.2261086820738;1245.6636708088947;1255.8492980842175;1266.208619612742;1278.5652878021517;911.284641556375;925.9259259259378;927.0821886332483;932.8647346134773;940.3652534539159;5522;5734.827955161351;5855.2973643163095;5959.67221802805;6072;918.8392031394479;938.3853575907791;982.7690492734201;988.2341185581232;996.6230540161766;3639.1629925117372;3870.903227419337;3942.126231914484;4103.343465045578;4172.061286210578;10751.408672523086;11002.284851484788;11098.944505277423;11104.44477776108;11117.666470005914;10999.670009899715;11022.393768342657;11041.447927603587;11042.779144417067;11044;7921.801954951057;8258.463199891989;8259.545724985184;8265.752027439186;8434.746957591282;5875.6474611523445;5919.792807251725;6012.609180403259;6017.849553761191;6074.3925607438905;10106.898931010595;10108.39349639024;10130.696079117639;10136.543855526372;10179.796404071729;9638.469884156439;9979.900200998187;10003.799924001625;10171.23715721309;10305.896941030795;7079.469039821931;7974.082980457321;8089.150639183036;8091.757247282356;8095.757127286191;7650.31147196755;8122.390820688353;8235.464694794819;8324.542150181798;8560.48637081777;7590.582517961565;7703.152653208031;7796.337311328601;7852.136265010959;7877.606119694107;7436.330730234305;7774.6890124394395;7867.527948323119;7883.408744344312;7887.44787864844;6746.69639866217;6857.691403886737;6858.931410685829;6859.382655561023;6863.073485079451;4898.118338699069;4898.559129678346;4905.460399355997;4946.155960322901;5074.213496907985;4750.691205071659;4771.308160316804;4831.106245344622;4859.149648811514;4874.53691899269 23:57:06 INFO - PROCESS | 3409 | |4;prototype.html;326.2611153870357;338.51085181912134;339.70785124792684;342.49995007289357;344.91377155711075;5339.172428273619;5413.83758487246;5433.64681295716;5436;5469.890602187954;5090.745462726867;5224.29472021277;5258.158694608854;5285.762140703668;5334.91997620036;4201.369794530814;4211.284081706102;4214.325707886724;4222.261104306749;4227.019950934591;4207.852725154605;4215.810288537024;4229.238737027334;4232.174725928445;4244.702870799046;4115.54728979812;4173.353130264813;4199.727017743852;4206.810693518783;4216.617611049763;4192.517860446057;4197.223513649985;4198.139381426816;4201;4204.768737719455;3719.6838268747188;3728.5831384073877;3741.4013757798893;3747.1194269346956;3752.924941501182;5053.343065401475;5190.494756520605;5244.65909715871;5254.6847189168775;5271.6277675046385;4796.52034796521;4811.374521312207;4821.156297647897;4828.299896515021;4832.758362081917;5560.610757246954;5584.246126772915;5585.050541407971;5608.4111168327145;5628.915566266509;3778.1688028633657;3955.5055618047745;4144.083840770473;4145.8963525911795;4149.543550209474;5778.59549831512;5807.390224026501;5823.737931793037;5824.650520968756;5830.854228644318;4120.361343991686;4122.2579935611275;4134.545200028055;4141.254574176617;4145.502539695256;4124.257633625916;4129.670460640007;4173.499180098408;4186.748795072244;4200.4539409876525;4785.904281914342;4789.904201915942;4794.7842347094465;4803.183458811941;4808.27875818623;5673.347565030074;5683.891641130022;5684.744186511617;5695.145728140729;5695.943040569624;1397.5248415538765;1413.2086031822212;1425.672095418039;1425.8574142585658;1428.757111291083;950.3632566180676;958.1951161024633;969.2246203037541;971.3831716859845;974.8830140383058;5256.26412302278;5262.315898933114;5262.368665713641;5262.447443018505;5271.736413179326;5227.431770468844;5490.18823788149;5494.642848214933;5535.363433205152;5561.360443548962;5173.974130129325;5183.870403239949;5191.922121168185;5198.896022079537;5212.843614691566;2829.5048366535775;2969.9109026729234;2970.8116753298423;2971.732544071044;2975.1966968918705;5612.971935140298;5731.971340143356;5775.834062226665;5782.826515204551;5783.566232532577;5633.549316054788;5636.718164091779;5674.2339784129435;5681.57388195887;5692.117721753135;5479.397266300703;5723.713814309268;5734.455226753368;5743.812184237705;5755.769769209269;5482.862928426821;5503.422140675171;5519.558435325244;5533.031719449161;5533.391326953952;5254.238135470259;5483.917741233805;5489.58828087887;5542.861428464159;5554.694646757928;5666.320041595035;5745.396733343106;5790.507806836466;5806.4193580641595;5818.33089194748;4034.1528279061727;4067.9287138211644;4073.5315438724924;4076.857309994136;4087.5708050654252;5577.191307260506;5593.300837395325;5674.120511320752;5710.628809127559;5742.856428589152;5553.8333849984565;5632.859178520406;5645.576581756467;5648.745806438802;5670.149477578396;5417.268668729671;5636.887262254814;5637.774489020393;5638.661680299195;5644.858878527905;5653.3216014076925;5668.574856885668;5669.5180909621495;5674.205611214516;5697.772089116389;5693.259876216065;5713.200531739501;5722.742476588647;5742.712864356849;5749.9712501437225;5476.6166368355425;5594.559346002261;5596.188552659923;5613.887722245614;5627.493525582553 23:57:06 INFO - PROCESS | 3409 | |5;yui.html;781.3866115099644;785.9489133206341;795.5783434779565;796.0407708710997;840.3949156607243;14870.851291487083;15432.691346173084;15804.209789510507;15906.125163116025;16075.91962040188;13774.380152893118;14877.903513996433;14998.625034374147;15164.696706065872;15188.392464301442;835.5529791561515;871.651339464213;876.4697358098355;876.7194497760719;876.8158686675774;853.9957300213521;857.1128881607538;860.1785295043219;860.290260535058;860.6600392844854;886.5877367024333;889.8309321228978;890.3722875372847;891.2736120062128;895.928325733943;882.7704796752859;886.3529623374908;887.5650931043807;888.564603344363;889.3107841422917;656.6683824668512;657.2966925389787;657.3459407889181;657.4510283912938;657.9703913323912;13548.254845983467;13759.243241621707;13762.380692868845;14255.287235638176;14597.708045839025;12295.815562766566;12670.429830657551;12701.682457938534;12750;12810.10329276951;11010.339379637167;11127.833082503688;11216.214864959456;11398;11490.557264821959;3768.9811550942345;3816.370298900678;3879.941800872989;3908.355121404965;3928.941065884014;66235.33764662388;68406.9999999995;68433.31566684319;69272.653636732;70428.6478567609;9834.508274586386;10041.598336066476;10051.246156538142;10069.446180460145;10179.491025448699;19654.21383144658;19661.803381966285;19668.508287292647;19672.70490942637;19692.704609430584;8520.8721869172;8595.871061934076;8691.608877600524;8795.856538649934;8863.202311791969;4345.826166953287;4748.857534273909;4782.880427989328;4805.111054454937;4839.927401088987;3320.833958302075;3418.4701371287492;3420.452727563578;3420.504026916133;3427.674370934807;585.1953563849706;597.0924195223237;600;601.6901295832649;602.1479606357043;607.1590846677384;616.0236025899001;625.3902445116066;657.8881590129689;685.1572565744063;9481.573329200202;9547.809043819223;9569.425834449956;9574.712758617252;9695.61217551304;633.3255083336232;645.1580687203245;687.3367200651395;693.7675878580732;708.8865781475042;4325.97837010813;4564.475085365226;4605.078984203105;4643.141018911512;4672.556107169813;87023.84701125194;91522;91651.54174229086;92060;95197.5240123795;50301.24548131781;51663.22505162426;51957;76693.6165319181;76860;71664;72458.63770681113;72704;73135.63432182805;73496.63251683814;8716.171963663443;8948.955255223682;8963.686270980485;9034.593443295198;9206.045761395575;48147.277790832464;48580.5141948576;48919;49124.508754913426;49578.25632615441;61202;65778.34221657722;65899.34100659123;66103.33896660972;67627.32372676407;11098.500567474644;11304.43477826089;11328.32030078198;11366.659000230007;11993.520259189534;12432.564860229848;12466.626001219978;12468.127231093737;12716.74566508646;12778.361081946052;10862.945685271523;11273.605423810128;11462.140339474407;12113.757724845278;12157.75684486323;13724.382402791698;13854.65363365924;13985.370658320604;14169.362378692776;15050.397984080952;12834.422450989914;13003;13141.868581314064;13166.407511661806;13683.934724467465;11434.82847757301;11591.130665199975;11882.702932426759;11883.405829708652;11938.343391113573;11179.329240245612;11452.885471145182;11492.195546311677;11613.593524226611;11944.16390852632 23:57:06 INFO - PROCESS | 3409 | __end_tp_report 23:57:06 INFO - PROCESS | 3409 | __start_cc_report 23:57:06 INFO - PROCESS | 3409 | _x_x_mozilla_cycle_collect,966 23:57:06 INFO - PROCESS | 3409 | __end_cc_report 23:57:06 INFO - PROCESS | 3409 | __startTimestamp1485244626439__endTimestamp 23:57:06 INFO - PROCESS | 3409 | 23:57:06 INFO - PROCESS | 3409 | ------- Summary: start ------- 23:57:06 INFO - PROCESS | 3409 | Number of tests: 6 23:57:06 INFO - PROCESS | 3409 | 23:57:06 INFO - PROCESS | 3409 | [#0] dojo.html Cycles:165 Average:5537.45 Median:5736.91 stddev:631.43 (11.0%) stddev-sans-first:605.85 23:57:06 INFO - PROCESS | 3409 | Values: 3187.2 3230.2 3238.3 3256.2 3261.3 5531.3 5575.9 5581.1 5581.8 5596.4 5564.6 5579.1 5585.5 5586.8 5596.3 5015.9 5029.3 5065.2 5093.0 5137.1 4893.4 4929.4 5054.9 5110.9 5117.1 5002.6 5005.3 5049.8 5055.2 5062.4 5104.9 5117.8 5179.4 5180.1 5210.8 4772.4 5071.1 5092.9 5127.4 5147.7 5310.9 5421.0 5433.0 5443.8 5491.9 5894.6 5899.5 5970.1 5985.0 5990.0 5789.7 6032.5 6041.0 6070.3 6071.6 5423.0 5549.5 5557.4 5593.2 5646.0 6181.2 6182.4 6198.8 6202.5 6204.3 5663.7 5935.5 5939.6 5941.8 5949.2 5770.2 5864.6 5916.4 5931.4 6030.4 5968.6 5968.6 5977.9 5977.9 6013.2 5931.7 5991.1 5991.6 5994.3 5994.9 4470.6 4491.1 4527.0 4545.2 4560.6 4057.7 4088.3 4096.3 4120.7 4127.6 5641.6 5650.0 5650.1 5654.7 5679.7 5803.9 5854.4 5956.8 5963.6 5998.6 5734.6 5736.9 5748.8 5752.5 5772.6 5172.1 5212.5 5212.8 5217.9 5248.6 6016.3 6032.1 6236.0 6286.2 6304.1 5847.7 5926.6 5928.4 5982.8 6004.0 6199.7 6200.4 6203.9 6210.7 6214.1 5600.4 5828.4 5844.3 5845.7 5846.6 5823.6 5942.5 5992.1 5996.8 6092.2 5827.1 5867.9 5873.7 5874.5 5877.0 5869.5 5871.6 5872.8 5876.9 5878.8 5604.9 5627.8 5696.5 5735.7 5764.5 5850.1 5857.2 5857.5 5861.2 5870.4 5524.1 5565.1 5696.4 5702.7 5707.9 23:57:06 INFO - PROCESS | 3409 | 23:57:06 INFO - PROCESS | 3409 | [#1] ext.html Cycles:180 Average:53391.58 Median:374373.00 stddev:94078.53 (25.1%) stddev-sans-first:94258.91 23:57:06 INFO - PROCESS | 3409 | Values: 588.6 607.6 642.3 659.6 672.5 34560.1 35335.3 46191.3 47222.8 47356.8 43915.8 48218.3 48259.8 48282.0 48350.8 8461.5 8866.2 8997.1 9008.6 9014.2 8445.9 10704.7 10961.8 10962.9 11289.0 10986.1 11047.4 11062.6 11066.1 11073.1 10876.5 10924.5 10937.4 10939.2 10953.8 10904.7 10956.3 10956.5 10967.9 10983.3 45332.3 45489.3 45721.3 45734.8 45743.5 3643.9 3758.1 4382.7 4399.8 4463.6 33347.0 33421.3 33497.3 33500.4 33571.5 4371.7 4433.8 4436.5 4447.4 4491.6 257667.0 257947.0 257975.7 258138.0 258992.0 63420.4 63616.0 63817.0 63864.0 63867.0 39932.8 41150.6 41202.4 43466.1 66420.3 17738.6 17832.7 17841.7 17847.9 17848.7 12620.2 12830.0 14035.7 14190.9 14284.0 20314.1 20459.0 20520.3 20526.8 20557.3 7245.3 7288.3 7390.4 7455.6 7583.7 980.7 994.3 1067.9 1112.1 1117.6 32118.2 32181.4 32310.2 32382.2 32867.8 1096.0 1115.1 1122.8 1181.5 1187.0 17224.8 17255.2 17308.3 17400.0 17453.2 416323.0 423853.0 423964.0 424129.0 424496.0 59102.0 59582.0 59589.0 59740.7 59789.0 1283.0 1327.1 1337.4 1363.4 1382.4 29640.4 33524.3 33565.0 34119.7 34517.3 52579.9 53083.5 53175.5 53193.7 53229.0 372552.0 373334.0 373549.0 374055.0 374691.0 27620.6 27927.4 28382.0 28426.0 29864.0 44358.0 49109.5 49624.8 49853.0 50087.5 41362.4 41461.4 41725.0 41731.4 42896.4 41526.0 42426.0 42669.4 43277.0 43358.0 41510.0 41995.4 42600.0 42740.4 42810.1 35279.8 37361.3 37555.4 37835.2 38258.6 27982.4 27985.0 28312.4 28363.7 28375.7 23:57:06 INFO - PROCESS | 3409 | 23:57:06 INFO - PROCESS | 3409 | [#2] jquery.html Cycles:180 Average:29002.27 Median:11205.00 stddev:78742.02 (702.7%) stddev-sans-first:78933.65 23:57:06 INFO - PROCESS | 3409 | Values: 415.4 416.9 425.3 426.3 435.1 18453.8 19277.1 20173.3 20224.0 20585.3 18746.2 19047.9 19812.8 20002.5 20009.4 5140.1 5379.2 5402.8 5452.6 5471.5 5237.6 5403.2 5431.9 5439.0 5439.0 5360.3 5395.7 5395.9 5398.8 5401.8 5297.4 5370.2 5372.2 5377.1 5798.0 5316.5 5320.3 5330.1 5336.8 5337.3 14282.7 14447.3 14483.6 14845.5 15002.0 2408.1 2542.7 2587.0 2712.3 3018.8 10195.3 10542.9 10644.3 10707.1 10823.5 1937.7 2013.5 2052.3 2067.3 2088.5 79781.6 80647.2 82216.0 82291.6 86823.6 11735.5 11808.7 11816.2 11977.3 11999.2 16571.4 16614.0 16620.0 16631.6 16648.0 8416.2 8581.0 8638.0 8696.3 8718.0 8271.7 8340.2 8354.4 8382.2 8570.5 4972.2 5043.6 5059.6 5100.8 5113.1 2059.4 2062.9 2112.0 2118.5 2119.2 887.3 957.1 994.3 1016.9 1114.5 20056.9 20093.1 20276.8 20327.7 20357.7 1012.2 1016.9 1030.4 1042.4 1045.0 10502.3 11133.8 11135.0 11443.6 11534.3 460406.0 468579.0 472897.0 489537.0 495616.0 75965.9 77140.2 95610.5 98219.0 98245.5 916.2 1010.2 1011.1 1034.6 1040.8 17490.0 18273.8 18296.3 18389.9 18543.8 43027.0 44085.6 44380.8 44755.1 45102.5 56736.1 57296.6 59178.0 61056.7 61247.7 9192.4 12254.3 12641.6 12676.7 12981.4 14266.9 14515.3 14735.0 14804.8 15295.9 11198.7 11382.7 12352.4 12418.5 12927.9 11420.6 11903.8 12221.6 12238.6 12693.5 12445.9 12698.0 13286.2 13292.3 13600.7 13239.9 13326.7 13399.3 13407.3 13439.7 12818.2 12871.5 12978.1 12994.8 13049.6 23:57:06 INFO - PROCESS | 3409 | 23:57:06 INFO - PROCESS | 3409 | [#3] mootools.html Cycles:180 Average:5772.43 Median:4898.34 stddev:3243.90 (66.2%) stddev-sans-first:3237.41 23:57:06 INFO - PROCESS | 3409 | Values: 1540.6 1554.4 1717.8 1817.4 1838.9 8425.3 9012.6 9018.6 9022.5 9029.0 7806.2 7979.7 7991.0 8231.4 8828.3 2329.7 2383.3 2388.2 2416.8 2425.6 2432.1 2449.8 2450.6 2453.7 2454.5 2408.1 2428.5 2428.5 2430.3 2430.7 2368.6 2396.1 2398.4 2398.9 2399.7 2390.8 2397.2 2399.0 2404.8 2416.2 8873.7 8932.7 8935.9 8937.9 8964.8 5346.4 5482.1 5482.4 5488.2 5490.2 3180.2 3259.1 3468.2 3468.6 3485.0 1042.4 1080.2 1096.9 1108.6 1119.8 11645.4 11930.8 11942.5 11975.6 11978.6 4486.9 4637.8 4675.5 4678.4 4698.2 9886.3 9892.3 9899.1 9904.0 9919.4 5381.0 5389.7 5394.2 5396.8 5401.6 4357.8 4845.5 5002.0 5015.1 5017.0 3705.1 3922.6 4038.0 4074.7 4075.1 1238.2 1245.7 1255.8 1266.2 1278.6 911.3 925.9 927.1 932.9 940.4 5522.0 5734.8 5855.3 5959.7 6072.0 918.8 938.4 982.8 988.2 996.6 3639.2 3870.9 3942.1 4103.3 4172.1 10751.4 11002.3 11098.9 11104.4 11117.7 10999.7 11022.4 11041.4 11042.8 11044.0 7921.8 8258.5 8259.5 8265.8 8434.7 5875.6 5919.8 6012.6 6017.8 6074.4 10106.9 10108.4 10130.7 10136.5 10179.8 9638.5 9979.9 10003.8 10171.2 10305.9 7079.5 7974.1 8089.2 8091.8 8095.8 7650.3 8122.4 8235.5 8324.5 8560.5 7590.6 7703.2 7796.3 7852.1 7877.6 7436.3 7774.7 7867.5 7883.4 7887.4 6746.7 6857.7 6858.9 6859.4 6863.1 4898.1 4898.6 4905.5 4946.2 5074.2 4750.7 4771.3 4831.1 4859.1 4874.5 23:57:06 INFO - PROCESS | 3409 | 23:57:06 INFO - PROCESS | 3409 | [#4] prototype.html Cycles:180 Average:4689.04 Median:5310.34 stddev:1360.33 (25.6%) stddev-sans-first:1324.15 23:57:06 INFO - PROCESS | 3409 | Values: 326.3 338.5 339.7 342.5 344.9 5339.2 5413.8 5433.6 5436.0 5469.9 5090.7 5224.3 5258.2 5285.8 5334.9 4201.4 4211.3 4214.3 4222.3 4227.0 4207.9 4215.8 4229.2 4232.2 4244.7 4115.5 4173.4 4199.7 4206.8 4216.6 4192.5 4197.2 4198.1 4201.0 4204.8 3719.7 3728.6 3741.4 3747.1 3752.9 5053.3 5190.5 5244.7 5254.7 5271.6 4796.5 4811.4 4821.2 4828.3 4832.8 5560.6 5584.2 5585.1 5608.4 5628.9 3778.2 3955.5 4144.1 4145.9 4149.5 5778.6 5807.4 5823.7 5824.7 5830.9 4120.4 4122.3 4134.5 4141.3 4145.5 4124.3 4129.7 4173.5 4186.7 4200.5 4785.9 4789.9 4794.8 4803.2 4808.3 5673.3 5683.9 5684.7 5695.1 5695.9 1397.5 1413.2 1425.7 1425.9 1428.8 950.4 958.2 969.2 971.4 974.9 5256.3 5262.3 5262.4 5262.4 5271.7 5227.4 5490.2 5494.6 5535.4 5561.4 5174.0 5183.9 5191.9 5198.9 5212.8 2829.5 2969.9 2970.8 2971.7 2975.2 5613.0 5732.0 5775.8 5782.8 5783.6 5633.5 5636.7 5674.2 5681.6 5692.1 5479.4 5723.7 5734.5 5743.8 5755.8 5482.9 5503.4 5519.6 5533.0 5533.4 5254.2 5483.9 5489.6 5542.9 5554.7 5666.3 5745.4 5790.5 5806.4 5818.3 4034.2 4067.9 4073.5 4076.9 4087.6 5577.2 5593.3 5674.1 5710.6 5742.9 5553.8 5632.9 5645.6 5648.7 5670.1 5417.3 5636.9 5637.8 5638.7 5644.9 5653.3 5668.6 5669.5 5674.2 5697.8 5693.3 5713.2 5722.7 5742.7 5750.0 5476.6 5594.6 5596.2 5613.9 5627.5 23:57:06 INFO - PROCESS | 3409 | 23:57:06 INFO - PROCESS | 3409 | [#5] yui.html Cycles:180 Average:17867.73 Median:48749.76 stddev:23807.98 (48.8%) stddev-sans-first:23840.20 23:57:06 INFO - PROCESS | 3409 | Values: 781.4 785.9 795.6 796.0 840.4 14870.9 15432.7 15804.2 15906.1 16075.9 13774.4 14877.9 14998.6 15164.7 15188.4 835.6 871.7 876.5 876.7 876.8 854.0 857.1 860.2 860.3 860.7 886.6 889.8 890.4 891.3 895.9 882.8 886.4 887.6 888.6 889.3 656.7 657.3 657.3 657.5 658.0 13548.3 13759.2 13762.4 14255.3 14597.7 12295.8 12670.4 12701.7 12750.0 12810.1 11010.3 11127.8 11216.2 11398.0 11490.6 3769.0 3816.4 3879.9 3908.4 3928.9 66235.3 68407.0 68433.3 69272.7 70428.6 9834.5 10041.6 10051.2 10069.4 10179.5 19654.2 19661.8 19668.5 19672.7 19692.7 8520.9 8595.9 8691.6 8795.9 8863.2 4345.8 4748.9 4782.9 4805.1 4839.9 3320.8 3418.5 3420.5 3420.5 3427.7 585.2 597.1 600.0 601.7 602.1 607.2 616.0 625.4 657.9 685.2 9481.6 9547.8 9569.4 9574.7 9695.6 633.3 645.2 687.3 693.8 708.9 4326.0 4564.5 4605.1 4643.1 4672.6 87023.8 91522.0 91651.5 92060.0 95197.5 50301.2 51663.2 51957.0 76693.6 76860.0 71664.0 72458.6 72704.0 73135.6 73496.6 8716.2 8949.0 8963.7 9034.6 9206.0 48147.3 48580.5 48919.0 49124.5 49578.3 61202.0 65778.3 65899.3 66103.3 67627.3 11098.5 11304.4 11328.3 11366.7 11993.5 12432.6 12466.6 12468.1 12716.7 12778.4 10862.9 11273.6 11462.1 12113.8 12157.8 13724.4 13854.7 13985.4 14169.4 15050.4 12834.4 13003.0 13141.9 13166.4 13683.9 11434.8 11591.1 11882.7 11883.4 11938.3 11179.3 11452.9 11492.2 11613.6 11944.2 23:57:06 INFO - PROCESS | 3409 | -------- Summary: end -------- 23:57:06 INFO - PROCESS | 3409 | 23:57:07 INFO - TEST-INFO | 3409: exit 0 23:57:07 INFO - TEST-OK | dromaeo_css | took 1116833ms 23:57:07 INFO - TEST-START | kraken 23:57:07 INFO - operating with platform_type : linux_ 23:57:07 INFO - Initialising browser for kraken test... 23:57:07 INFO - TEST-INFO | started process 3712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3rk1Vs/profile http://localhost:41166/getInfo.html) 23:57:11 INFO - PROCESS | 3712 | __metrics Screen width/height:1600/1200 23:57:11 INFO - PROCESS | 3712 | colorDepth:24 23:57:11 INFO - PROCESS | 3712 | Browser inner width/height: 1024/697 23:57:11 INFO - PROCESS | 3712 | __metrics 23:57:11 INFO - PROCESS | 3712 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:57:11 INFO - PROCESS | 3712 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:57:12 INFO - PROCESS | 3712 | console.error: PushService: 23:57:12 INFO - PROCESS | 3712 | stateChangeProcessEnqueue: Error transitioning state 23:57:12 INFO - PROCESS | 3712 | UnknownError 23:57:12 INFO - TEST-INFO | 3712: exit 0 23:57:12 INFO - Browser initialized. 23:57:12 INFO - Running cycle 1/1 for kraken test... 23:57:12 INFO - TEST-INFO | started process 3804 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3rk1Vs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:57:24 INFO - PROCESS | 3804 | RSS: Main: 141541376 23:57:24 INFO - PROCESS | 3804 | 23:57:27 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:41166/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41166/tests/kraken/driver.html?testName=audio-beat-detection) 23:57:28 INFO - PROCESS | 3804 | RSS: Main: 183148544 23:57:28 INFO - PROCESS | 3804 | 23:57:30 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:41166/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41166/tests/kraken/driver.html?testName=audio-dft) 23:57:31 INFO - PROCESS | 3804 | RSS: Main: 173047808 23:57:31 INFO - PROCESS | 3804 | 23:57:34 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:41166/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41166/tests/kraken/driver.html?testName=audio-fft) 23:57:34 INFO - PROCESS | 3804 | RSS: Main: 263323648 23:57:34 INFO - PROCESS | 3804 | 23:57:36 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:41166/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41166/tests/kraken/driver.html?testName=audio-oscillator) 23:57:37 INFO - PROCESS | 3804 | RSS: Main: 170160128 23:57:37 INFO - PROCESS | 3804 | 23:57:39 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:41166/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41166/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:57:39 INFO - PROCESS | 3804 | RSS: Main: 172793856 23:57:39 INFO - PROCESS | 3804 | 23:57:42 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:41166/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41166/tests/kraken/driver.html?testName=imaging-darkroom) 23:57:43 INFO - PROCESS | 3804 | RSS: Main: 211050496 23:57:43 INFO - PROCESS | 3804 | 23:57:46 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:41166/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41166/tests/kraken/driver.html?testName=imaging-desaturate) 23:57:47 INFO - PROCESS | 3804 | RSS: Main: 211259392 23:57:47 INFO - PROCESS | 3804 | 23:57:49 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:41166/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41166/tests/kraken/driver.html?testName=json-parse-financial) 23:57:50 INFO - PROCESS | 3804 | RSS: Main: 209244160 23:57:50 INFO - PROCESS | 3804 | 23:57:51 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:41166/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41166/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:57:52 INFO - PROCESS | 3804 | RSS: Main: 171429888 23:57:52 INFO - PROCESS | 3804 | 23:57:54 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:41166/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41166/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:57:54 INFO - PROCESS | 3804 | RSS: Main: 177500160 23:57:54 INFO - PROCESS | 3804 | 23:57:57 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:41166/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41166/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:57:57 INFO - PROCESS | 3804 | RSS: Main: 187715584 23:57:57 INFO - PROCESS | 3804 | 23:57:59 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:41166/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41166/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:58:00 INFO - PROCESS | 3804 | RSS: Main: 195387392 23:58:00 INFO - PROCESS | 3804 | 23:58:03 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:41166/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41166/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:58:03 INFO - PROCESS | 3804 | RSS: Main: 192331776 23:58:03 INFO - PROCESS | 3804 | 23:58:05 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:41166/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41166/tests/kraken/driver.html?testName=ai-astar) 23:58:05 INFO - PROCESS | 3804 | RSS: Main: 245256192 23:58:05 INFO - PROCESS | 3804 | 23:58:05 INFO - PROCESS | 3804 | __start_tp_report 23:58:05 INFO - PROCESS | 3804 | _x_x_mozilla_page_load 23:58:05 INFO - PROCESS | 3804 | _x_x_mozilla_page_load_details 23:58:05 INFO - PROCESS | 3804 | |i|pagename|runs| 23:58:05 INFO - PROCESS | 3804 | |0;ai-astar;101;111;112;110;111;112;110;111;110;110 23:58:05 INFO - PROCESS | 3804 | |1;audio-beat-detection;149;117;119;152;117;118;122;119;148;118 23:58:05 INFO - PROCESS | 3804 | |2;audio-dft;160;162;159;161;159;162;158;158;160;158 23:58:05 INFO - PROCESS | 3804 | |3;audio-fft;73;74;76;98;74;75;75;74;94;74 23:58:05 INFO - PROCESS | 3804 | |4;audio-oscillator;81;81;114;82;81;81;100;81;80;112 23:58:05 INFO - PROCESS | 3804 | |5;imaging-gaussian-blur;117;117;117;117;116;117;116;117;116;117 23:58:05 INFO - PROCESS | 3804 | |6;imaging-darkroom;145;145;146;147;147;146;145;147;147;146 23:58:05 INFO - PROCESS | 3804 | |7;imaging-desaturate;84;85;85;84;85;85;85;85;84;84 23:58:05 INFO - PROCESS | 3804 | |8;json-parse-financial;49;50;50;49;50;51;51;49;49;50 23:58:05 INFO - PROCESS | 3804 | |9;json-stringify-tinderbox;60;61;59;59;60;60;61;60;60;62 23:58:05 INFO - PROCESS | 3804 | |10;stanford-crypto-aes;75;74;74;76;74;73;75;77;72;73 23:58:05 INFO - PROCESS | 3804 | |11;stanford-crypto-ccm;121;123;121;118;119;119;119;121;169;119 23:58:05 INFO - PROCESS | 3804 | |12;stanford-crypto-pbkdf2;164;155;153;156;153;157;155;156;159;159 23:58:05 INFO - PROCESS | 3804 | |13;stanford-crypto-sha256-iterative;62;62;63;62;63;65;62;62;62;64 23:58:05 INFO - PROCESS | 3804 | __end_tp_report 23:58:05 INFO - PROCESS | 3804 | __start_cc_report 23:58:05 INFO - PROCESS | 3804 | _x_x_mozilla_cycle_collect,1571 23:58:05 INFO - PROCESS | 3804 | __end_cc_report 23:58:05 INFO - PROCESS | 3804 | __startTimestamp1485244685815__endTimestamp 23:58:05 INFO - PROCESS | 3804 | 23:58:05 INFO - PROCESS | 3804 | ------- Summary: start ------- 23:58:05 INFO - PROCESS | 3804 | Number of tests: 14 23:58:05 INFO - PROCESS | 3804 | 23:58:05 INFO - PROCESS | 3804 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.19 (2.9%) stddev-sans-first:0.83 23:58:05 INFO - PROCESS | 3804 | Values: 101.0 111.0 112.0 110.0 111.0 112.0 110.0 111.0 110.0 110.0 23:58:05 INFO - PROCESS | 3804 | 23:58:05 INFO - PROCESS | 3804 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:120.50 stddev:15.12 (12.5%) stddev-sans-first:13.97 23:58:05 INFO - PROCESS | 3804 | Values: 149.0 117.0 119.0 152.0 117.0 118.0 122.0 119.0 148.0 118.0 23:58:05 INFO - PROCESS | 3804 | 23:58:05 INFO - PROCESS | 3804 | [#2] audio-dft Cycles:10 Average:159.70 Median:160.00 stddev:1.57 (1.0%) stddev-sans-first:1.66 23:58:05 INFO - PROCESS | 3804 | Values: 160.0 162.0 159.0 161.0 159.0 162.0 158.0 158.0 160.0 158.0 23:58:05 INFO - PROCESS | 3804 | 23:58:05 INFO - PROCESS | 3804 | [#3] audio-fft Cycles:10 Average:78.70 Median:75.00 stddev:9.20 (12.3%) stddev-sans-first:9.53 23:58:05 INFO - PROCESS | 3804 | Values: 73.0 74.0 76.0 98.0 74.0 75.0 75.0 74.0 94.0 74.0 23:58:05 INFO - PROCESS | 3804 | 23:58:05 INFO - PROCESS | 3804 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:81.00 stddev:13.84 (17.1%) stddev-sans-first:14.35 23:58:05 INFO - PROCESS | 3804 | Values: 81.0 81.0 114.0 82.0 81.0 81.0 100.0 81.0 80.0 112.0 23:58:05 INFO - PROCESS | 3804 | 23:58:05 INFO - PROCESS | 3804 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 23:58:05 INFO - PROCESS | 3804 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 23:58:05 INFO - PROCESS | 3804 | 23:58:05 INFO - PROCESS | 3804 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.50 stddev:0.88 (0.6%) stddev-sans-first:0.83 23:58:05 INFO - PROCESS | 3804 | Values: 145.0 145.0 146.0 147.0 147.0 146.0 145.0 147.0 147.0 146.0 23:58:05 INFO - PROCESS | 3804 | 23:58:05 INFO - PROCESS | 3804 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 23:58:05 INFO - PROCESS | 3804 | Values: 84.0 85.0 85.0 84.0 85.0 85.0 85.0 85.0 84.0 84.0 23:58:05 INFO - PROCESS | 3804 | 23:58:05 INFO - PROCESS | 3804 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:50.00 stddev:0.79 (1.6%) stddev-sans-first:0.78 23:58:05 INFO - PROCESS | 3804 | Values: 49.0 50.0 50.0 49.0 50.0 51.0 51.0 49.0 49.0 50.0 23:58:05 INFO - PROCESS | 3804 | 23:58:05 INFO - PROCESS | 3804 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 23:58:05 INFO - PROCESS | 3804 | Values: 60.0 61.0 59.0 59.0 60.0 60.0 61.0 60.0 60.0 62.0 23:58:05 INFO - PROCESS | 3804 | 23:58:05 INFO - PROCESS | 3804 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:74.50 stddev:1.49 (2.0%) stddev-sans-first:1.56 23:58:05 INFO - PROCESS | 3804 | Values: 75.0 74.0 74.0 76.0 74.0 73.0 75.0 77.0 72.0 73.0 23:58:05 INFO - PROCESS | 3804 | 23:58:05 INFO - PROCESS | 3804 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:121.00 stddev:15.57 (12.9%) stddev-sans-first:16.45 23:58:05 INFO - PROCESS | 3804 | Values: 121.0 123.0 121.0 118.0 119.0 119.0 119.0 121.0 169.0 119.0 23:58:05 INFO - PROCESS | 3804 | 23:58:05 INFO - PROCESS | 3804 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.70 Median:156.50 stddev:3.30 (2.1%) stddev-sans-first:2.20 23:58:05 INFO - PROCESS | 3804 | Values: 164.0 155.0 153.0 156.0 153.0 157.0 155.0 156.0 159.0 159.0 23:58:05 INFO - PROCESS | 3804 | 23:58:05 INFO - PROCESS | 3804 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:1.06 (1.7%) stddev-sans-first:1.09 23:58:05 INFO - PROCESS | 3804 | Values: 62.0 62.0 63.0 62.0 63.0 65.0 62.0 62.0 62.0 64.0 23:58:05 INFO - PROCESS | 3804 | -------- Summary: end -------- 23:58:05 INFO - PROCESS | 3804 | 23:58:06 INFO - TEST-INFO | 3804: exit 0 23:58:06 INFO - TEST-OK | kraken | took 59601ms 23:58:06 INFO - SUITE-END | took 1176s 23:58:06 INFO - Completed test suite (00:19:36) 23:58:06 INFO - javascript benchmark 23:58:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3187.187267246852, 3230.224746060946, 3238.3199528099103, 3256.1859535116223, 3261.3477304539083, 5531.336239651242, 5575.916361254579, 5581.107022876341, 5581.776728930848, 5596.384397716248, 5564.554835613151, 5579.107342825148, 5585.525230355414, 5586.804461843836, 5596.328440587125, 5015.949840501594, 5029.270755740416, 5065.214891691794, 5092.9745351273195, 5137.101007323722, 4893.41279046515, 4929.433115191763, 5054.9241761373605, 5110.897782044357, 5117.053345131144, 5002.599792016648, 5005.299258103868, 5049.8485045448515, 5055.165897626887, 5062.392512898439, 5104.872378190538, 5117.846464606049, 5179.404368497633, 5180.130895780676, 5210.817621383233, 4772.427308722976, 5071.137906555894, 5092.898142037176, 5127.359080114986, 5147.716875571842, 5310.867228319285, 5420.972895135538, 5433.049216387117, 5443.755031023614, 5491.862703432406, 5894.646321220741, 5899.528037756969, 5970.104484327386, 5985.0124729419595, 5990.041593345088, 5789.681567513785, 6032.4570788629235, 6041.033434650479, 6070.301915279755, 6071.605345652519, 5422.9728851355885, 5549.528290095347, 5557.444255574491, 5593.244911936918, 5646.040173170571, 6181.196444462191, 6182.381761823782, 6198.845028874314, 6202.503799696104, 6204.348543402878, 5663.660180389107, 5935.52515798735, 5939.584229103922, 5941.821745347646, 5949.196858424144, 5770.16332631766, 5864.618799778086, 5916.408359164136, 5931.377205393458, 6030.396960304022, 5968.552358573038, 5968.582199246011, 5977.880442391215, 5977.880442391215, 6013.248343957005, 5931.73307201177, 5991.071383935497, 5991.58058935879, 5994.250718660168, 5994.850128746729, 4470.619997300201, 4491.101779644085, 4526.95473045272, 4545.204589196877, 4560.612347950461, 4057.736247143926, 4088.3254263046265, 4096.2871484343805, 4120.670346372283, 4127.587241275848, 5641.576881733804, 5649.971750141305, 5650.0959846424375, 5654.717264136777, 5679.687617181012, 5803.912941305884, 5854.443827836349, 5956.76172953077, 5963.552733544915, 5998.550108741862, 5734.598578099493, 5736.913946290809, 5748.798792042258, 5752.539796816244, 5772.595918285764, 5172.146595811724, 5212.530872221519, 5212.765425555859, 5217.895642087213, 5248.553872920845, 6016.308124565643, 6032.095185722177, 6236.0, 6286.18279623646, 6304.085907543381, 5847.707614619337, 5926.555508336978, 5928.3775203603, 5982.760689572368, 6003.969980150071, 6199.659018754011, 6200.410960958701, 6203.875922481616, 6210.658413787285, 6214.067889816383, 5600.411956744483, 5828.446297601721, 5844.327902291121, 5845.736941837713, 5846.590738648254, 5823.5923485355615, 5942.494887934401, 5992.131140984446, 5996.790112346047, 6092.177556029879, 5827.125931110198, 5867.853303667443, 5873.706314684334, 5874.471297583067, 5877.0302900021015, 5869.501092407022, 5871.647701137946, 5872.765089396376, 5876.882462350814, 5878.794242201502, 5604.8879022418505, 5627.774889004558, 5696.515796157373, 5735.655860648374, 5764.481196692318, 5850.12248162779, 5857.238558987475, 5857.47282744555, 5861.238039055066, 5870.412958704095, 5524.14375771756, 5565.081761509306, 5696.401877802937, 5702.657840529581, 5707.885842283048], "value": 5494.935812594167, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.58210670424, 607.5959486941183, 642.2806456768419, 659.6174218953005, 672.4754691340756, 34560.13599660007, 35335.2932941341, 46191.30713039307, 47222.763886180524, 47356.76321618387, 43915.78042109785, 48218.27672584914, 48259.75870120645, 48282.0, 48350.75824620881, 8461.53461559614, 8866.246369058621, 8997.100289970984, 9008.639654413848, 9014.188723014928, 8445.873311900326, 10704.678859634223, 10961.780764384748, 10962.945185274102, 11289.0, 10986.066184374338, 11047.392393418359, 11062.612808551703, 11066.114710823114, 11073.058790002859, 10876.456177191109, 10924.508397122148, 10937.398443085627, 10939.234253602252, 10953.83569246454, 10904.672859814218, 10956.28784129029, 10956.506957186946, 10967.890321096846, 10983.340999540053, 45332.320015199795, 45489.31766023512, 45721.31418028732, 45734.771326143156, 45743.54256457426, 3643.908902277438, 3758.0604848787802, 4382.715123516961, 4399.846005389796, 4463.553644635543, 33347.0, 33421.33157336864, 33497.33005339879, 33500.396463248675, 33571.496427553604, 4371.693981421302, 4433.791498418638, 4436.471211409498, 4447.444069491314, 4491.550844915515, 257667.0, 257947.0, 257975.71012145007, 258138.0, 258992.0, 63420.36579634237, 63616.0, 63817.0, 63864.0, 63867.0, 39932.80033599871, 41150.588494115276, 41202.38196427056, 43466.130677386274, 66420.33579664238, 17738.5565360867, 17832.732509012374, 17841.7323740144, 17847.910760446113, 17848.732269015974, 12620.17968832023, 12830.0, 14035.719285614436, 14190.858091418953, 14284.0, 20314.085866136058, 20458.95410458972, 20520.281790137273, 20526.794732052487, 20557.280495182596, 7245.311695388929, 7288.344049035612, 7390.371818395389, 7455.589942553212, 7583.658735356922, 980.6616717232686, 994.2841154368842, 1067.9305845120043, 1112.076976109827, 1117.5976648406568, 32118.197045073593, 32181.35637287241, 32310.19224519406, 32382.19044523906, 32867.83566082202, 1095.9945200274108, 1115.0522056252282, 1122.7698321844166, 1181.468339247342, 1186.95845645402, 17224.827751722572, 17255.22351494186, 17308.307667693403, 17400.0, 17453.21460534279, 416323.0, 423853.0, 423964.0, 424129.0, 424496.0, 59102.0, 59582.0, 59589.0, 59740.70129649324, 59789.0, 1282.9550965716342, 1327.0511584217138, 1337.404854839587, 1363.352407606379, 1382.384838746748, 29640.407191856473, 33524.329513410084, 33565.0, 34119.65880341165, 34517.309653807286, 52579.94840103253, 53083.469165307855, 53175.468245318596, 53193.73403132959, 53229.0, 372552.0, 373334.0, 373549.0, 374055.0, 374691.0, 27620.585691214244, 27927.441451170456, 28382.0, 28426.0, 29864.0, 44358.0, 49109.50890491049, 49624.79592193422, 49853.0, 50087.49912500828, 41362.379564307164, 41461.37807932823, 41725.0, 41731.374029390194, 42896.35655465233, 41526.0, 42426.0, 42669.35995960125, 43277.0, 43358.0, 41510.0, 41995.37006944837, 42600.0, 42740.35889461599, 42810.14379712326, 35279.823600881835, 37361.25277494381, 37555.436668450544, 37835.243295134496, 38258.61741382551, 27982.44035119327, 27985.0, 28312.433751324446, 28363.71636283611, 28375.71624283731], "value": 20602.322236628534, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.35205080075104, 416.92286926918524, 425.3173656281668, 426.2519278665941, 435.09283144643416, 18453.815461845395, 19277.132529036193, 20173.29393471229, 20224.0, 20585.27951521697, 18746.156422960965, 19047.904760476213, 19812.801871981275, 20002.499937501532, 20009.399718008484, 5140.126178549655, 5379.246905433242, 5402.78388864445, 5452.6455780374345, 5471.480209380123, 5237.580993520528, 5403.2165336026255, 5431.891362172754, 5439.0209762242785, 5439.048166570854, 5360.2763626910255, 5395.7032363220005, 5395.919061214085, 5398.811041613544, 5401.810936617219, 5297.419078284944, 5370.167624018283, 5372.2210279509445, 5377.085895397791, 5797.971010144965, 5316.521513063843, 5320.281761962125, 5330.093884039684, 5336.839894803124, 5337.279467271907, 14282.714345713028, 14447.277636118151, 14483.637909052253, 14845.480408185662, 15002.02486838352, 2408.0849277274697, 2542.733013033623, 2586.961195582068, 2712.294803351143, 3018.833964131994, 10195.337303075275, 10542.894571054345, 10644.254902156852, 10707.089897358734, 10823.458827058615, 1937.680282753344, 2013.4865609269543, 2052.3022172461287, 2067.3281183615236, 2088.5092003379195, 79781.60109199474, 80647.19352806456, 82216.0, 82291.58854205691, 86823.56588217018, 11735.471903764352, 11808.70478238051, 11816.231944923553, 11977.341246231366, 11999.160058795975, 16571.42000029993, 16614.00315981045, 16620.0, 16631.584210394594, 16648.0, 8416.158384161536, 8580.95709521461, 8637.956810215908, 8696.347773916981, 8717.956410218036, 8271.669133234604, 8340.165983401612, 8354.373421993374, 8382.245597896219, 8570.528620925785, 4972.179590367549, 5043.5712964398435, 5059.595232381401, 5100.821471248489, 5113.079645663816, 2059.3718915730847, 2062.9381118566466, 2111.9577608447744, 2118.5233322502313, 2119.173522326294, 887.3344991256557, 957.0812020460436, 994.2841154368842, 1016.8627235323285, 1114.4539175803798, 20056.899715501328, 20093.095810688556, 20276.797232027788, 20327.695084573745, 20357.694634580494, 1012.1953047327393, 1016.8983101689772, 1030.3714734012246, 1042.4162469017374, 1044.9738756530996, 10502.317349372266, 11133.818686946874, 11135.01265228916, 11443.599474018369, 11534.250273732181, 460406.0, 468579.0, 472897.0, 489537.0, 495616.0, 75965.91387360705, 77140.22859771442, 95610.52194739121, 98219.0, 98245.5087724571, 916.1983264643437, 1010.2322235101523, 1011.0698157694939, 1034.6171916390983, 1040.7918416316616, 17490.0, 18273.81726182721, 18296.26814927388, 18389.90805045966, 18543.814561854208, 43027.0, 44085.559144408144, 44380.778096109316, 44755.104897902514, 45102.54897450984, 56736.14895776484, 57296.56220626776, 59178.0, 61056.69471652613, 61247.69376153091, 9192.402493837879, 12254.264744115382, 12641.557545485864, 12676.746465070462, 12981.4158362872, 14266.857331426552, 14515.274236288355, 14734.968552201672, 14804.7779283313, 15295.923520382326, 11198.664040078811, 11382.658520244406, 12352.444140013542, 12418.503259869865, 12927.935360323138, 11420.600278990196, 11903.82144267854, 12221.572244971383, 12238.632841014783, 12693.492260309484, 12445.937770311091, 12698.0, 13286.20282783036, 13292.26892520882, 13600.727985440433, 13239.933800330937, 13326.733465330446, 13399.33003349809, 13407.262600557064, 13439.731205375641, 12818.166819156724, 12871.485140594272, 12978.091533592935, 12994.80507792365, 13049.608511744664], "value": 9574.24690771406, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1540.5532395605276, 1554.4404014554761, 1717.8196289389614, 1817.3730063128216, 1838.9080545972697, 8425.32597392208, 9012.594433250511, 9018.639254429814, 9022.458652480856, 9029.0, 7806.180351063128, 7979.720709775159, 7991.0, 8231.382646301536, 8828.29373650108, 2329.6738456616044, 2383.3088404362716, 2388.235764555343, 2416.794572461343, 2425.648280999254, 2432.1487479382163, 2449.8285120041605, 2450.644656524803, 2453.681021467207, 2454.521368333176, 2408.0728919366084, 2428.4657375377387, 2428.514297140579, 2430.283066495388, 2430.6840110785574, 2368.6328619064075, 2396.1373905394216, 2398.4363674536385, 2398.904043838253, 2399.664047033417, 2390.7728765767224, 2397.2209032064648, 2398.9640155397683, 2404.843685160459, 2416.2388847513153, 8873.73378798637, 8932.687355942577, 8935.910640893573, 8937.910620893774, 8964.775880602972, 5346.4118946915805, 5482.095454250044, 5482.424345443751, 5488.204210389511, 5490.231367608538, 3180.189051791778, 3259.103746469716, 3468.1676397664633, 3468.618451970281, 3485.024193225901, 1042.4318746283218, 1080.222239987208, 1096.8957948994832, 1108.6175269531998, 1119.7592517608753, 11645.417729113595, 11930.821037684442, 11942.522299108025, 11975.580854670045, 11978.64064078079, 4486.887827804266, 4637.837675681335, 4675.509071547506, 4678.415198100238, 4698.2247929092, 9886.258530610234, 9892.307538472238, 9899.059589339002, 9903.950480247553, 9919.40483570988, 5381.0, 5389.7035663038905, 5394.244805727201, 5396.811111611075, 5401.567874570025, 4357.803898824561, 4845.466998630148, 5002.049610573979, 5015.097282489114, 5017.0216807722145, 3705.1478160023344, 3922.5881282465502, 4037.9798101009305, 4074.6536544394057, 4075.144219713834, 1238.2261086820738, 1245.6636708088947, 1255.8492980842175, 1266.208619612742, 1278.5652878021517, 911.284641556375, 925.9259259259378, 927.0821886332483, 932.8647346134773, 940.3652534539159, 5522.0, 5734.827955161351, 5855.2973643163095, 5959.67221802805, 6072.0, 918.8392031394479, 938.3853575907791, 982.7690492734201, 988.2341185581232, 996.6230540161766, 3639.1629925117372, 3870.903227419337, 3942.126231914484, 4103.343465045578, 4172.061286210578, 10751.408672523086, 11002.284851484788, 11098.944505277423, 11104.44477776108, 11117.666470005914, 10999.670009899715, 11022.393768342657, 11041.447927603587, 11042.779144417067, 11044.0, 7921.801954951057, 8258.463199891989, 8259.545724985184, 8265.752027439186, 8434.746957591282, 5875.6474611523445, 5919.792807251725, 6012.609180403259, 6017.849553761191, 6074.3925607438905, 10106.898931010595, 10108.39349639024, 10130.696079117639, 10136.543855526372, 10179.796404071729, 9638.469884156439, 9979.900200998187, 10003.799924001625, 10171.23715721309, 10305.896941030795, 7079.469039821931, 7974.082980457321, 8089.150639183036, 8091.757247282356, 8095.757127286191, 7650.31147196755, 8122.390820688353, 8235.464694794819, 8324.542150181798, 8560.48637081777, 7590.582517961565, 7703.152653208031, 7796.337311328601, 7852.136265010959, 7877.606119694107, 7436.330730234305, 7774.6890124394395, 7867.527948323119, 7883.408744344312, 7887.44787864844, 6746.69639866217, 6857.691403886737, 6858.931410685829, 6859.382655561023, 6863.073485079451, 4898.118338699069, 4898.559129678346, 4905.460399355997, 4946.155960322901, 5074.213496907985, 4750.691205071659, 4771.308160316804, 4831.106245344622, 4859.149648811514, 4874.53691899269], "value": 4643.023308026597, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.2611153870357, 338.51085181912134, 339.70785124792684, 342.49995007289357, 344.91377155711075, 5339.172428273619, 5413.83758487246, 5433.64681295716, 5436.0, 5469.890602187954, 5090.745462726867, 5224.29472021277, 5258.158694608854, 5285.762140703668, 5334.91997620036, 4201.369794530814, 4211.284081706102, 4214.325707886724, 4222.261104306749, 4227.019950934591, 4207.852725154605, 4215.810288537024, 4229.238737027334, 4232.174725928445, 4244.702870799046, 4115.54728979812, 4173.353130264813, 4199.727017743852, 4206.810693518783, 4216.617611049763, 4192.517860446057, 4197.223513649985, 4198.139381426816, 4201.0, 4204.768737719455, 3719.6838268747188, 3728.5831384073877, 3741.4013757798893, 3747.1194269346956, 3752.924941501182, 5053.343065401475, 5190.494756520605, 5244.65909715871, 5254.6847189168775, 5271.6277675046385, 4796.52034796521, 4811.374521312207, 4821.156297647897, 4828.299896515021, 4832.758362081917, 5560.610757246954, 5584.246126772915, 5585.050541407971, 5608.4111168327145, 5628.915566266509, 3778.1688028633657, 3955.5055618047745, 4144.083840770473, 4145.8963525911795, 4149.543550209474, 5778.59549831512, 5807.390224026501, 5823.737931793037, 5824.650520968756, 5830.854228644318, 4120.361343991686, 4122.2579935611275, 4134.545200028055, 4141.254574176617, 4145.502539695256, 4124.257633625916, 4129.670460640007, 4173.499180098408, 4186.748795072244, 4200.4539409876525, 4785.904281914342, 4789.904201915942, 4794.7842347094465, 4803.183458811941, 4808.27875818623, 5673.347565030074, 5683.891641130022, 5684.744186511617, 5695.145728140729, 5695.943040569624, 1397.5248415538765, 1413.2086031822212, 1425.672095418039, 1425.8574142585658, 1428.757111291083, 950.3632566180676, 958.1951161024633, 969.2246203037541, 971.3831716859845, 974.8830140383058, 5256.26412302278, 5262.315898933114, 5262.368665713641, 5262.447443018505, 5271.736413179326, 5227.431770468844, 5490.18823788149, 5494.642848214933, 5535.363433205152, 5561.360443548962, 5173.974130129325, 5183.870403239949, 5191.922121168185, 5198.896022079537, 5212.843614691566, 2829.5048366535775, 2969.9109026729234, 2970.8116753298423, 2971.732544071044, 2975.1966968918705, 5612.971935140298, 5731.971340143356, 5775.834062226665, 5782.826515204551, 5783.566232532577, 5633.549316054788, 5636.718164091779, 5674.2339784129435, 5681.57388195887, 5692.117721753135, 5479.397266300703, 5723.713814309268, 5734.455226753368, 5743.812184237705, 5755.769769209269, 5482.862928426821, 5503.422140675171, 5519.558435325244, 5533.031719449161, 5533.391326953952, 5254.238135470259, 5483.917741233805, 5489.58828087887, 5542.861428464159, 5554.694646757928, 5666.320041595035, 5745.396733343106, 5790.507806836466, 5806.4193580641595, 5818.33089194748, 4034.1528279061727, 4067.9287138211644, 4073.5315438724924, 4076.857309994136, 4087.5708050654252, 5577.191307260506, 5593.300837395325, 5674.120511320752, 5710.628809127559, 5742.856428589152, 5553.8333849984565, 5632.859178520406, 5645.576581756467, 5648.745806438802, 5670.149477578396, 5417.268668729671, 5636.887262254814, 5637.774489020393, 5638.661680299195, 5644.858878527905, 5653.3216014076925, 5668.574856885668, 5669.5180909621495, 5674.205611214516, 5697.772089116389, 5693.259876216065, 5713.200531739501, 5722.742476588647, 5742.712864356849, 5749.9712501437225, 5476.6166368355425, 5594.559346002261, 5596.188552659923, 5613.887722245614, 5627.493525582553], "value": 4256.136139230569, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.3866115099644, 785.9489133206341, 795.5783434779565, 796.0407708710997, 840.3949156607243, 14870.851291487083, 15432.691346173084, 15804.209789510507, 15906.125163116025, 16075.91962040188, 13774.380152893118, 14877.903513996433, 14998.625034374147, 15164.696706065872, 15188.392464301442, 835.5529791561515, 871.651339464213, 876.4697358098355, 876.7194497760719, 876.8158686675774, 853.9957300213521, 857.1128881607538, 860.1785295043219, 860.290260535058, 860.6600392844854, 886.5877367024333, 889.8309321228978, 890.3722875372847, 891.2736120062128, 895.928325733943, 882.7704796752859, 886.3529623374908, 887.5650931043807, 888.564603344363, 889.3107841422917, 656.6683824668512, 657.2966925389787, 657.3459407889181, 657.4510283912938, 657.9703913323912, 13548.254845983467, 13759.243241621707, 13762.380692868845, 14255.287235638176, 14597.708045839025, 12295.815562766566, 12670.429830657551, 12701.682457938534, 12750.0, 12810.10329276951, 11010.339379637167, 11127.833082503688, 11216.214864959456, 11398.0, 11490.557264821959, 3768.9811550942345, 3816.370298900678, 3879.941800872989, 3908.355121404965, 3928.941065884014, 66235.33764662388, 68406.9999999995, 68433.31566684319, 69272.653636732, 70428.6478567609, 9834.508274586386, 10041.598336066476, 10051.246156538142, 10069.446180460145, 10179.491025448699, 19654.21383144658, 19661.803381966285, 19668.508287292647, 19672.70490942637, 19692.704609430584, 8520.8721869172, 8595.871061934076, 8691.608877600524, 8795.856538649934, 8863.202311791969, 4345.826166953287, 4748.857534273909, 4782.880427989328, 4805.111054454937, 4839.927401088987, 3320.833958302075, 3418.4701371287492, 3420.452727563578, 3420.504026916133, 3427.674370934807, 585.1953563849706, 597.0924195223237, 600.0, 601.6901295832649, 602.1479606357043, 607.1590846677384, 616.0236025899001, 625.3902445116066, 657.8881590129689, 685.1572565744063, 9481.573329200202, 9547.809043819223, 9569.425834449956, 9574.712758617252, 9695.61217551304, 633.3255083336232, 645.1580687203245, 687.3367200651395, 693.7675878580732, 708.8865781475042, 4325.97837010813, 4564.475085365226, 4605.078984203105, 4643.141018911512, 4672.556107169813, 87023.84701125194, 91522.0, 91651.54174229086, 92060.0, 95197.5240123795, 50301.24548131781, 51663.22505162426, 51957.0, 76693.6165319181, 76860.0, 71664.0, 72458.63770681113, 72704.0, 73135.63432182805, 73496.63251683814, 8716.171963663443, 8948.955255223682, 8963.686270980485, 9034.593443295198, 9206.045761395575, 48147.277790832464, 48580.5141948576, 48919.0, 49124.508754913426, 49578.25632615441, 61202.0, 65778.34221657722, 65899.34100659123, 66103.33896660972, 67627.32372676407, 11098.500567474644, 11304.43477826089, 11328.32030078198, 11366.659000230007, 11993.520259189534, 12432.564860229848, 12466.626001219978, 12468.127231093737, 12716.74566508646, 12778.361081946052, 10862.945685271523, 11273.605423810128, 11462.140339474407, 12113.757724845278, 12157.75684486323, 13724.382402791698, 13854.65363365924, 13985.370658320604, 14169.362378692776, 15050.397984080952, 12834.422450989914, 13003.0, 13141.868581314064, 13166.407511661806, 13683.934724467465, 11434.82847757301, 11591.130665199975, 11882.702932426759, 11883.405829708652, 11938.343391113573, 11179.329240245612, 11452.885471145182, 11492.195546311677, 11613.593524226611, 11944.16390852632], "value": 7152.348901636426, "unit": "score"}], "name": "dromaeo_css", "value": 7315.022587827433, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 112.0, 110.0, 111.0, 112.0, 110.0, 111.0, 110.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 119.0, 152.0, 117.0, 118.0, 122.0, 119.0, 148.0, 118.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 159.0, 161.0, 159.0, 162.0, 158.0, 158.0, 160.0, 158.0], "value": 159.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 76.0, 98.0, 74.0, 75.0, 75.0, 74.0, 94.0, 74.0], "value": 78.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 114.0, 82.0, 81.0, 81.0, 100.0, 81.0, 80.0, 112.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 147.0, 147.0, 146.0, 145.0, 147.0, 147.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 84.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 50.0, 49.0, 50.0, 51.0, 51.0, 49.0, 49.0, 50.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 59.0, 59.0, 60.0, 60.0, 61.0, 60.0, 60.0, 62.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 76.0, 74.0, 73.0, 75.0, 77.0, 72.0, 73.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 123.0, 121.0, 118.0, 119.0, 119.0, 119.0, 121.0, 169.0, 119.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 155.0, 153.0, 156.0, 153.0, 157.0, 155.0, 156.0, 159.0, 159.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 63.0, 65.0, 62.0, 62.0, 62.0, 64.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1441.4000000000003, "alertThreshold": 2.0}]} 23:58:07 INFO - Return code: 0 23:58:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:58:07 INFO - # TBPL SUCCESS # 23:58:07 INFO - Running post-action listener: _resource_record_post_action 23:58:07 INFO - [mozharness: 2017-01-24 07:58:07.131789Z] Finished run-tests step (success) 23:58:07 INFO - Running post-run listener: _resource_record_post_run 23:58:07 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 9969664; Write bytes: 348418048; Read time: 1740; Write time: 277436 23:58:07 INFO - TinderboxPrint: CPU usage
13.0% 23:58:07 INFO - TinderboxPrint: I/O read bytes / time
9,969,664 / 1,740 23:58:07 INFO - TinderboxPrint: I/O write bytes / time
348,418,048 / 277,436 23:58:07 INFO - TinderboxPrint: CPU idle
8,268.0 (87.0%) 23:58:07 INFO - TinderboxPrint: CPU user
1,186.0 (12.5%) 23:58:07 INFO - TinderboxPrint: Swap in / out
0 / 0 23:58:07 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 2166784; Read time: 0; Write time: 236 23:58:07 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8224768; Write bytes: 346251264; Read time: 1684; Write time: 277200 23:58:07 INFO - Running post-run listener: _upload_blobber_files 23:58:07 INFO - Blob upload gear active. 23:58:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:58:07 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 23:58:07 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'] 23:58:07 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 23:58:08 INFO - (blobuploader) - INFO - Open directory for files ... 23:58:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:58:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:58:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:58:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:58:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:58:08 INFO - (blobuploader) - INFO - Done attempting. 23:58:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:58:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:58:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:58:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:58:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:58:09 INFO - (blobuploader) - INFO - Done attempting. 23:58:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:58:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:58:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:58:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:58:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:58:13 INFO - (blobuploader) - INFO - Done attempting. 23:58:13 INFO - (blobuploader) - INFO - Iteration through files over. 23:58:13 INFO - Return code: 0 23:58:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:58:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:58:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/933d2e37787ff9cf48c9927d6491d0b738ec8357060f5def4355dbaa25a3bf40846408cbbc6ace67e77219ef135a2ae0753dfad0083a3f8440eb3460ed39541d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/94b7f447672b18b60c82cc06cba67bd658f5c8659a17acee1a3b594f412e84dd977405b7ebeacaffb89e8459eeaf2288bc6e54e431462bb7d033a5eb702c863d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bad8f84dea521b28da257bf9bbce3718045de8c103b4ea608889be429c9857d152041a88e2c77a894ebd7db8bc58523573785a6dccd66d06c38a6118ae085f6f"} 23:58:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:58:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:58:13 INFO - Contents: 23:58:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/933d2e37787ff9cf48c9927d6491d0b738ec8357060f5def4355dbaa25a3bf40846408cbbc6ace67e77219ef135a2ae0753dfad0083a3f8440eb3460ed39541d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/94b7f447672b18b60c82cc06cba67bd658f5c8659a17acee1a3b594f412e84dd977405b7ebeacaffb89e8459eeaf2288bc6e54e431462bb7d033a5eb702c863d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bad8f84dea521b28da257bf9bbce3718045de8c103b4ea608889be429c9857d152041a88e2c77a894ebd7db8bc58523573785a6dccd66d06c38a6118ae085f6f"} 23:58:13 INFO - Running post-run listener: copy_logs_to_upload_dir 23:58:13 INFO - Copying logs to upload dir... 23:58:13 INFO - mkdir: /builds/slave/test/build/upload/logs 23:58:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.483359 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-01-23 23:58:13.529594) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 23:58:13.534660) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/933d2e37787ff9cf48c9927d6491d0b738ec8357060f5def4355dbaa25a3bf40846408cbbc6ace67e77219ef135a2ae0753dfad0083a3f8440eb3460ed39541d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/94b7f447672b18b60c82cc06cba67bd658f5c8659a17acee1a3b594f412e84dd977405b7ebeacaffb89e8459eeaf2288bc6e54e431462bb7d033a5eb702c863d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bad8f84dea521b28da257bf9bbce3718045de8c103b4ea608889be429c9857d152041a88e2c77a894ebd7db8bc58523573785a6dccd66d06c38a6118ae085f6f"} build_url:https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/AvnMX7PeSv-bsvlrj6lgbA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/933d2e37787ff9cf48c9927d6491d0b738ec8357060f5def4355dbaa25a3bf40846408cbbc6ace67e77219ef135a2ae0753dfad0083a3f8440eb3460ed39541d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/94b7f447672b18b60c82cc06cba67bd658f5c8659a17acee1a3b594f412e84dd977405b7ebeacaffb89e8459eeaf2288bc6e54e431462bb7d033a5eb702c863d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bad8f84dea521b28da257bf9bbce3718045de8c103b4ea608889be429c9857d152041a88e2c77a894ebd7db8bc58523573785a6dccd66d06c38a6118ae085f6f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 23:58:13.567688) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:58:13.568113) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1485242261.485779-624594006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004352 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:58:13.654348) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 23:58:13.654772) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 23:58:13.655153) ========= ========= Total master_lag: 0.25 =========