builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1477639439.95 results: success (0) buildid: 20161027213002 builduid: 52ad68243be34089bb817b6dcf839c02 revision: 71536044069576fc877bf7ef0ba13a4ada793706 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 00:23:59.945579) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 00:23:59.946020) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 00:23:59.946321) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 00:23:59.960854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 00:23:59.961121) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-28 00:24:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-10-28 00:24:00 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112696 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 00:24:00.087958) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 00:24:00.088270) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017615 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 00:24:00.138213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 00:24:00.138573) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 71536044069576fc877bf7ef0ba13a4ada793706 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 71536044069576fc877bf7ef0ba13a4ada793706 --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=e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-28 00:24:00,300 truncating revision to first 12 chars 2016-10-28 00:24:00,301 Setting DEBUG logging. 2016-10-28 00:24:00,301 attempt 1/10 2016-10-28 00:24:00,301 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/715360440695?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-28 00:24:01,797 unpacking tar archive at: fx-team-715360440695/testing/mozharness/ program finished with exit code 0 elapsedTime=1.890864 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 00:24:02.043424) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 00:24:02.043782) ========= script_repo_revision: 71536044069576fc877bf7ef0ba13a4ada793706 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 00:24:02.044218) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 00:24:02.044526) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 00:24:02.054270) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-28 00:24:02.054599) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:24:02 INFO - MultiFileLogger online at 20161028 00:24:02 in /builds/slave/test 00:24:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:24:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:24:02 INFO - {'append_to_log': False, 00:24:02 INFO - 'base_work_dir': '/builds/slave/test', 00:24:02 INFO - 'blob_upload_branch': 'Fx-Team', 00:24:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:24:02 INFO - 'branch': 'Fx-Team', 00:24:02 INFO - 'buildbot_json_path': 'buildprops.json', 00:24:02 INFO - 'config_files': ('talos/linux_config.py',), 00:24:02 INFO - 'default_actions': ('clobber', 00:24:02 INFO - 'read-buildbot-config', 00:24:02 INFO - 'download-and-extract', 00:24:02 INFO - 'populate-webroot', 00:24:02 INFO - 'create-virtualenv', 00:24:02 INFO - 'install', 00:24:02 INFO - 'run-tests'), 00:24:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:24:02 INFO - 'download_minidump_stackwalk': True, 00:24:02 INFO - 'download_symbols': 'ondemand', 00:24:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:24:02 INFO - 'tooltool.py': '/tools/tooltool.py', 00:24:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:24:02 INFO - '/tools/misc-python/virtualenv.py')}, 00:24:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:24:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:24:02 INFO - 'installer_path': 'installer.exe', 00:24:02 INFO - 'log_level': 'info', 00:24:02 INFO - 'log_name': 'talos', 00:24:02 INFO - 'log_to_console': True, 00:24:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:24:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:24:02 INFO - 'opt_config_files': (), 00:24:02 INFO - 'pip_index': False, 00:24:02 INFO - 'sps_profile': False, 00:24:02 INFO - 'sps_profile_interval': 0, 00:24:02 INFO - 'suite': 'dromaeojs', 00:24:02 INFO - 'system_bits': '32', 00:24:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:24:02 INFO - 'title': 'talos-linux64-ix-006', 00:24:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:24:02 INFO - 'use_talos_json': True, 00:24:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:24:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:24:02 INFO - 'work_dir': 'build'} 00:24:02 INFO - [mozharness: 2016-10-28 07:24:02.319658Z] Running clobber step. 00:24:02 INFO - Running pre-action listener: _resource_record_pre_action 00:24:02 INFO - Running main action method: clobber 00:24:02 INFO - rmtree: /builds/slave/test/build 00:24:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:24:02 INFO - Running post-action listener: _resource_record_post_action 00:24:02 INFO - [mozharness: 2016-10-28 07:24:02.774303Z] Finished clobber step (success) 00:24:02 INFO - [mozharness: 2016-10-28 07:24:02.774403Z] Running read-buildbot-config step. 00:24:02 INFO - Running pre-action listener: _resource_record_pre_action 00:24:02 INFO - Running main action method: read_buildbot_config 00:24:02 INFO - Using buildbot properties: 00:24:02 INFO - { 00:24:02 INFO - "project": "", 00:24:02 INFO - "product": "firefox", 00:24:02 INFO - "script_repo_revision": "production", 00:24:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:24:02 INFO - "repository": "", 00:24:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 00:24:02 INFO - "buildid": "20161027213002", 00:24:02 INFO - "pgo_build": "True", 00:24:02 INFO - "basedir": "/builds/slave/test", 00:24:02 INFO - "buildnumber": 1665, 00:24:02 INFO - "slavename": "talos-linux64-ix-006", 00:24:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:24:02 INFO - "platform": "ubuntu64_hw", 00:24:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 00:24:02 INFO - "branch": "fx-team", 00:24:02 INFO - "repo_path": "integration/fx-team", 00:24:02 INFO - "revision": "71536044069576fc877bf7ef0ba13a4ada793706", 00:24:02 INFO - "stage_platform": "linux64-pgo", 00:24:02 INFO - "builduid": "52ad68243be34089bb817b6dcf839c02", 00:24:02 INFO - "slavebuilddir": "test" 00:24:02 INFO - } 00:24:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 00:24:02 INFO - Running post-action listener: _resource_record_post_action 00:24:02 INFO - [mozharness: 2016-10-28 07:24:02.776862Z] Finished read-buildbot-config step (success) 00:24:02 INFO - [mozharness: 2016-10-28 07:24:02.776951Z] Running download-and-extract step. 00:24:02 INFO - Running pre-action listener: _resource_record_pre_action 00:24:02 INFO - Running main action method: download_and_extract 00:24:02 INFO - mkdir: /builds/slave/test/build/tests 00:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:24:02 INFO - trying https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:24:02 INFO - Downloading https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:24:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:24:03 INFO - Downloaded 1361 bytes. 00:24:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:24:03 INFO - Using the following test package requirements: 00:24:03 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:24:03 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:24:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:24:03 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:24:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:24:03 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:24:03 INFO - u'jsshell-linux-x86_64.zip'], 00:24:03 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:24:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:24:03 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:24:03 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:24:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:24:03 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:24:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:24:03 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:24:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:24:03 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:24:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:24:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:24:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:24:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:24:03 INFO - Fetch https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:24:03 INFO - Http code: 200 00:24:03 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 00:24:03 INFO - x-amz-cf-id: PH-kvUftLlovjiliCSRZFAhfINVch8bWOfXX0lWZAXupvf4vl9n5Gg== 00:24:03 INFO - x-amz-version-id: LNr2P87jb.Z5igWJf6tSD9nnINNIthLb 00:24:04 INFO - Expected file size: 21992711 00:24:04 INFO - Obtained file size: 21992711 00:24:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:24:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:24:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:24:08 INFO - Fetch https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:24:08 INFO - Http code: 200 00:24:08 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 00:24:08 INFO - x-amz-cf-id: M5f7ZRPjkPXwm6Z5vQjNAqt7cAjr5bJG6vqwT3NvdWbL93bw1Ym3sA== 00:24:08 INFO - x-amz-version-id: LNr2P87jb.Z5igWJf6tSD9nnINNIthLb 00:24:09 INFO - Expected file size: 21992711 00:24:09 INFO - Obtained file size: 21992711 00:24:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 00:24:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:24:13 INFO - Fetch https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:24:14 INFO - Http code: 200 00:24:14 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 00:24:14 INFO - x-amz-cf-id: -zL7DpnWtJo20hjd-xLHfafoq_Cg0gXZNQ1PLcHuddgvG1oqyD3E1Q== 00:24:14 INFO - x-amz-version-id: E4wrgwbZFCn3.IjunEEad0pjyQdT7gDJ 00:24:14 INFO - Expected file size: 14409028 00:24:14 INFO - Obtained file size: 14409028 00:24:14 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')]} 00:24:14 INFO - trying https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:24:14 INFO - Downloading https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:24:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:24:15 INFO - Downloaded 59392973 bytes. 00:24:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:24:15 INFO - mkdir: /builds/slave/test/properties 00:24:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:24:15 INFO - Writing to file /builds/slave/test/properties/build_url 00:24:15 INFO - Contents: 00:24:15 INFO - build_url:https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:24:16 INFO - Running post-action listener: _resource_record_post_action 00:24:16 INFO - Running post-action listener: set_extra_try_arguments 00:24:16 INFO - [mozharness: 2016-10-28 07:24:16.488063Z] Finished download-and-extract step (success) 00:24:16 INFO - [mozharness: 2016-10-28 07:24:16.488326Z] Running populate-webroot step. 00:24:16 INFO - Running pre-action listener: _resource_record_pre_action 00:24:16 INFO - Running main action method: populate_webroot 00:24:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:24:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:24:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:24:16 INFO - '--tppagecycles', 00:24:16 INFO - '7'], 00:24:16 INFO - 'tests': ['tsvgm']}}, 00:24:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:24:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:24:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:24:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:24:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:24:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:24:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:24:16 INFO - 'talos_options': ['--disable-e10s'], 00:24:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:24:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:24:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:24:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:24:16 INFO - 'talos_options': ['--disable-e10s'], 00:24:16 INFO - 'tests': ['damp', 'tps']}, 00:24:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:24:16 INFO - 'tests': ['damp', 'tps']}, 00:24:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:24:16 INFO - 'tests': ['dromaeo_dom']}, 00:24:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:24:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:24:16 INFO - 'tests': ['basic_compositor_video']}, 00:24:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:24:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:24:16 INFO - 'tests': ['a11yr', 00:24:16 INFO - 'ts_paint', 00:24:16 INFO - 'tpaint', 00:24:16 INFO - 'sessionrestore', 00:24:16 INFO - 'sessionrestore_no_auto_restore', 00:24:16 INFO - 'tabpaint']}, 00:24:16 INFO - 'other-e10s': {'tests': ['a11yr', 00:24:16 INFO - 'ts_paint', 00:24:16 INFO - 'tpaint', 00:24:16 INFO - 'sessionrestore', 00:24:16 INFO - 'sessionrestore_no_auto_restore', 00:24:16 INFO - 'tabpaint']}, 00:24:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:24:16 INFO - 'ts_paint', 00:24:16 INFO - 'tpaint', 00:24:16 INFO - 'sessionrestore', 00:24:16 INFO - 'sessionrestore_no_auto_restore', 00:24:16 INFO - 'tabpaint']}, 00:24:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:24:16 INFO - 'ts_paint', 00:24:16 INFO - 'tpaint', 00:24:16 INFO - 'sessionrestore', 00:24:16 INFO - 'sessionrestore_no_auto_restore', 00:24:16 INFO - 'tabpaint']}, 00:24:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:24:16 INFO - 'tests': ['a11yr', 00:24:16 INFO - 'ts_paint', 00:24:16 INFO - 'tpaint', 00:24:16 INFO - 'sessionrestore', 00:24:16 INFO - 'sessionrestore_no_auto_restore', 00:24:16 INFO - 'tabpaint']}, 00:24:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:24:16 INFO - 'tests': ['a11yr', 00:24:16 INFO - 'ts_paint', 00:24:16 INFO - 'tpaint', 00:24:16 INFO - 'sessionrestore', 00:24:16 INFO - 'sessionrestore_no_auto_restore', 00:24:16 INFO - 'tabpaint']}, 00:24:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:24:16 INFO - 'tests': ['tsvgx', 00:24:16 INFO - 'tsvgr_opacity', 00:24:16 INFO - 'tart', 00:24:16 INFO - 'tscrollx', 00:24:16 INFO - 'cart']}, 00:24:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:24:16 INFO - 'tsvgr_opacity', 00:24:16 INFO - 'tart', 00:24:16 INFO - 'tscrollx', 00:24:16 INFO - 'cart']}, 00:24:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:24:16 INFO - 'talos_options': ['--disable-e10s'], 00:24:16 INFO - 'tests': ['tp5o']}, 00:24:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:24:16 INFO - 'tests': ['tp5o']}, 00:24:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:24:16 INFO - 'talos_options': ['--disable-e10s', 00:24:16 INFO - '--xperf_path', 00:24:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:24:16 INFO - 'tests': ['tp5n']}, 00:24:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:24:16 INFO - 'talos_options': ['--xperf_path', 00:24:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:24:16 INFO - 'tests': ['tp5n']}}, 00:24:16 INFO - 'talos.zip': {'path': '', 00:24:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:24:16 INFO - Running post-action listener: _resource_record_post_action 00:24:16 INFO - [mozharness: 2016-10-28 07:24:16.509046Z] Finished populate-webroot step (success) 00:24:16 INFO - [mozharness: 2016-10-28 07:24:16.509135Z] Running create-virtualenv step. 00:24:16 INFO - Running pre-action listener: _resource_record_pre_action 00:24:16 INFO - Running main action method: create_virtualenv 00:24:16 INFO - Creating virtualenv /builds/slave/test/build/venv 00:24:16 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 00:24:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:24:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:24:16 INFO - Using real prefix '/usr' 00:24:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:24:17 INFO - Installing distribute.............................................................................................................................................................................................done. 00:24:19 INFO - Installing pip.................done. 00:24:19 INFO - Return code: 0 00:24:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:24:19 INFO - Reading from file tmpfile_stdout 00:24:19 INFO - Output received: 00:24:19 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) 00:24:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:24:19 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')]} 00:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:19 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')]} 00:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:19 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 0x7fb2c98edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d8930>, '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 0x26d9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d9cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', '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 00:24:19 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 00:24:19 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 00:24:19 INFO - Using env: {'DISPLAY': ':0', 00:24:19 INFO - 'HOME': '/home/cltbld', 00:24:19 INFO - 'LANG': 'en_US.UTF-8', 00:24:19 INFO - 'LANGUAGE': 'en_US:en', 00:24:19 INFO - 'LOGNAME': 'cltbld', 00:24:19 INFO - 'MAIL': '/var/mail/cltbld', 00:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:19 INFO - 'MOZ_NO_REMOTE': '1', 00:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:19 INFO - 'NO_EM_RESTART': '1', 00:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:19 INFO - 'PWD': '/builds/slave/test', 00:24:19 INFO - 'SHELL': '/bin/bash', 00:24:19 INFO - 'SHLVL': '1', 00:24:19 INFO - 'TERM': 'linux', 00:24:19 INFO - 'TMOUT': '86400', 00:24:19 INFO - 'USER': 'cltbld', 00:24:19 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', 00:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:19 INFO - '_': '/tools/buildbot/bin/python'} 00:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:19 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 00:24:19 INFO - Cleaning up... 00:24:19 INFO - Return code: 0 00:24:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:24:19 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')]} 00:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:19 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')]} 00:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:19 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 0x7fb2c98edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d8930>, '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 0x26d9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d9cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', '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 00:24:19 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 00:24:19 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 00:24:19 INFO - Using env: {'DISPLAY': ':0', 00:24:19 INFO - 'HOME': '/home/cltbld', 00:24:19 INFO - 'LANG': 'en_US.UTF-8', 00:24:19 INFO - 'LANGUAGE': 'en_US:en', 00:24:19 INFO - 'LOGNAME': 'cltbld', 00:24:19 INFO - 'MAIL': '/var/mail/cltbld', 00:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:19 INFO - 'MOZ_NO_REMOTE': '1', 00:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:19 INFO - 'NO_EM_RESTART': '1', 00:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:19 INFO - 'PWD': '/builds/slave/test', 00:24:19 INFO - 'SHELL': '/bin/bash', 00:24:19 INFO - 'SHLVL': '1', 00:24:19 INFO - 'TERM': 'linux', 00:24:19 INFO - 'TMOUT': '86400', 00:24:19 INFO - 'USER': 'cltbld', 00:24:19 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', 00:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:19 INFO - '_': '/tools/buildbot/bin/python'} 00:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:19 INFO - Downloading/unpacking psutil>=3.1.1 00:24:19 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 00:24:19 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 00:24:19 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 00:24:19 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 00:24:19 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 00:24:19 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 00:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:24:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:24:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:24:21 INFO - Installing collected packages: psutil 00:24:21 INFO - Running setup.py install for psutil 00:24:21 INFO - building 'psutil._psutil_linux' extension 00:24:21 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 00:24:22 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 00:24:22 INFO - building 'psutil._psutil_posix' extension 00:24:22 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 00:24:22 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 00:24:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:24:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:24:22 INFO - Successfully installed psutil 00:24:22 INFO - Cleaning up... 00:24:22 INFO - Return code: 0 00:24:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:22 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 0x7fb2c98edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d8930>, '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 0x26d9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d9cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', '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 00:24:22 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 00:24:22 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 00:24:22 INFO - Using env: {'DISPLAY': ':0', 00:24:22 INFO - 'HOME': '/home/cltbld', 00:24:22 INFO - 'LANG': 'en_US.UTF-8', 00:24:22 INFO - 'LANGUAGE': 'en_US:en', 00:24:22 INFO - 'LOGNAME': 'cltbld', 00:24:22 INFO - 'MAIL': '/var/mail/cltbld', 00:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:22 INFO - 'MOZ_NO_REMOTE': '1', 00:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:22 INFO - 'NO_EM_RESTART': '1', 00:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:22 INFO - 'PWD': '/builds/slave/test', 00:24:22 INFO - 'SHELL': '/bin/bash', 00:24:22 INFO - 'SHLVL': '1', 00:24:22 INFO - 'TERM': 'linux', 00:24:22 INFO - 'TMOUT': '86400', 00:24:22 INFO - 'USER': 'cltbld', 00:24:22 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', 00:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:22 INFO - '_': '/tools/buildbot/bin/python'} 00:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:24:22 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 00:24:22 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 00:24:22 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 00:24:22 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 00:24:22 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 00:24:22 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 00:24:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:24:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:24:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:24:24 INFO - Installing collected packages: mozsystemmonitor 00:24:24 INFO - Running setup.py install for mozsystemmonitor 00:24:24 INFO - Successfully installed mozsystemmonitor 00:24:24 INFO - Cleaning up... 00:24:24 INFO - Return code: 0 00:24:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:24:24 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')]} 00:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:24 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')]} 00:24:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:24 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 0x7fb2c98edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d8930>, '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 0x26d9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d9cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', '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 00:24:24 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 00:24:24 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 00:24:24 INFO - Using env: {'DISPLAY': ':0', 00:24:24 INFO - 'HOME': '/home/cltbld', 00:24:24 INFO - 'LANG': 'en_US.UTF-8', 00:24:24 INFO - 'LANGUAGE': 'en_US:en', 00:24:24 INFO - 'LOGNAME': 'cltbld', 00:24:24 INFO - 'MAIL': '/var/mail/cltbld', 00:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:24 INFO - 'MOZ_NO_REMOTE': '1', 00:24:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:24 INFO - 'NO_EM_RESTART': '1', 00:24:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:24 INFO - 'PWD': '/builds/slave/test', 00:24:24 INFO - 'SHELL': '/bin/bash', 00:24:24 INFO - 'SHLVL': '1', 00:24:24 INFO - 'TERM': 'linux', 00:24:24 INFO - 'TMOUT': '86400', 00:24:24 INFO - 'USER': 'cltbld', 00:24:24 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', 00:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:24 INFO - '_': '/tools/buildbot/bin/python'} 00:24:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:24 INFO - Downloading/unpacking jsonschema==2.5.1 00:24:24 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 00:24:24 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 00:24:24 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 00:24:24 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 00:24:24 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 00:24:24 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 00:24:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:24:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:27 INFO - Downloading functools32-3.2.3-2.tar.gz 00:24:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:24:27 INFO - warning: no files found matching '*.txt' 00:24:27 INFO - no previously-included directories found matching 'build' 00:24:27 INFO - no previously-included directories found matching 'dist' 00:24:27 INFO - no previously-included directories found matching '.git*' 00:24:27 INFO - Installing collected packages: jsonschema, functools32 00:24:27 INFO - Running setup.py install for functools32 00:24:27 INFO - warning: no files found matching '*.txt' 00:24:27 INFO - no previously-included directories found matching 'build' 00:24:27 INFO - no previously-included directories found matching 'dist' 00:24:27 INFO - no previously-included directories found matching '.git*' 00:24:27 INFO - Successfully installed jsonschema functools32 00:24:27 INFO - Cleaning up... 00:24:27 INFO - Return code: 0 00:24:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:24:27 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')]} 00:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:27 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')]} 00:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:27 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 0x7fb2c98edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d8930>, '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 0x26d9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d9cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', '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 00:24:27 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 00:24:27 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 00:24:27 INFO - Using env: {'DISPLAY': ':0', 00:24:27 INFO - 'HOME': '/home/cltbld', 00:24:27 INFO - 'LANG': 'en_US.UTF-8', 00:24:27 INFO - 'LANGUAGE': 'en_US:en', 00:24:27 INFO - 'LOGNAME': 'cltbld', 00:24:27 INFO - 'MAIL': '/var/mail/cltbld', 00:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:27 INFO - 'MOZ_NO_REMOTE': '1', 00:24:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:27 INFO - 'NO_EM_RESTART': '1', 00:24:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:27 INFO - 'PWD': '/builds/slave/test', 00:24:27 INFO - 'SHELL': '/bin/bash', 00:24:27 INFO - 'SHLVL': '1', 00:24:27 INFO - 'TERM': 'linux', 00:24:27 INFO - 'TMOUT': '86400', 00:24:27 INFO - 'USER': 'cltbld', 00:24:27 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', 00:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:27 INFO - '_': '/tools/buildbot/bin/python'} 00:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:24:27 INFO - Cleaning up... 00:24:27 INFO - Return code: 0 00:24:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:24:27 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')]} 00:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:27 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')]} 00:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:27 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 0x7fb2c98edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d8930>, '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 0x26d9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d9cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', '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 00:24:27 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 00:24:27 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 00:24:27 INFO - Using env: {'DISPLAY': ':0', 00:24:27 INFO - 'HOME': '/home/cltbld', 00:24:27 INFO - 'LANG': 'en_US.UTF-8', 00:24:27 INFO - 'LANGUAGE': 'en_US:en', 00:24:27 INFO - 'LOGNAME': 'cltbld', 00:24:27 INFO - 'MAIL': '/var/mail/cltbld', 00:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:27 INFO - 'MOZ_NO_REMOTE': '1', 00:24:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:27 INFO - 'NO_EM_RESTART': '1', 00:24:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:27 INFO - 'PWD': '/builds/slave/test', 00:24:27 INFO - 'SHELL': '/bin/bash', 00:24:27 INFO - 'SHLVL': '1', 00:24:27 INFO - 'TERM': 'linux', 00:24:27 INFO - 'TMOUT': '86400', 00:24:27 INFO - 'USER': 'cltbld', 00:24:27 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', 00:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:27 INFO - '_': '/tools/buildbot/bin/python'} 00:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:27 INFO - Downloading/unpacking blobuploader==1.2.4 00:24:27 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 00:24:27 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 00:24:27 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 00:24:27 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 00:24:27 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 00:24:27 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 00:24:29 INFO - Downloading blobuploader-1.2.4.tar.gz 00:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:24:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:24:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:24:30 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 00:24:30 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 00:24:30 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 00:24:30 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 00:24:30 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 00:24:30 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 00:24:30 INFO - Downloading docopt-0.6.1.tar.gz 00:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:24:30 INFO - Installing collected packages: blobuploader, requests, docopt 00:24:30 INFO - Running setup.py install for blobuploader 00:24:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:24:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:24:30 INFO - Running setup.py install for requests 00:24:31 INFO - Running setup.py install for docopt 00:24:31 INFO - Successfully installed blobuploader requests docopt 00:24:31 INFO - Cleaning up... 00:24:31 INFO - Return code: 0 00:24:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:31 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 0x7fb2c98edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d8930>, '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 0x26d9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d9cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', '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 00:24:31 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 00:24:31 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 00:24:31 INFO - Using env: {'DISPLAY': ':0', 00:24:31 INFO - 'HOME': '/home/cltbld', 00:24:31 INFO - 'LANG': 'en_US.UTF-8', 00:24:31 INFO - 'LANGUAGE': 'en_US:en', 00:24:31 INFO - 'LOGNAME': 'cltbld', 00:24:31 INFO - 'MAIL': '/var/mail/cltbld', 00:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:31 INFO - 'MOZ_NO_REMOTE': '1', 00:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:31 INFO - 'NO_EM_RESTART': '1', 00:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:31 INFO - 'PWD': '/builds/slave/test', 00:24:31 INFO - 'SHELL': '/bin/bash', 00:24:31 INFO - 'SHLVL': '1', 00:24:31 INFO - 'TERM': 'linux', 00:24:31 INFO - 'TMOUT': '86400', 00:24:31 INFO - 'USER': 'cltbld', 00:24:31 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', 00:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:31 INFO - '_': '/tools/buildbot/bin/python'} 00:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:24:31 INFO - Running setup.py (path:/tmp/pip-h8bdzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:24:31 INFO - Running setup.py (path:/tmp/pip-StCjYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:24:31 INFO - Running setup.py (path:/tmp/pip-e1VExy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:24:31 INFO - Running setup.py (path:/tmp/pip-4h4JsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:24:31 INFO - Running setup.py (path:/tmp/pip-3JZQs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:24:31 INFO - Running setup.py (path:/tmp/pip-CIB7xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:24:31 INFO - Running setup.py (path:/tmp/pip-4PTpN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:24:31 INFO - Running setup.py (path:/tmp/pip-fhzhfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:24:32 INFO - Running setup.py (path:/tmp/pip-Gtx10B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:24:32 INFO - Running setup.py (path:/tmp/pip-9Hwht1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:24:32 INFO - Running setup.py (path:/tmp/pip-ffrH6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:24:32 INFO - Running setup.py (path:/tmp/pip-go8ZCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:24:32 INFO - Running setup.py (path:/tmp/pip-XRKrvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:24:32 INFO - Running setup.py (path:/tmp/pip-qAjg9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:24:32 INFO - Running setup.py (path:/tmp/pip-moXAMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:24:32 INFO - Running setup.py (path:/tmp/pip-cc1WmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:24:32 INFO - Running setup.py (path:/tmp/pip-m44ACR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:24:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:24:32 INFO - Running setup.py install for manifestparser 00:24:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:24:32 INFO - Running setup.py install for mozcrash 00:24:32 INFO - Running setup.py install for mozdebug 00:24:32 INFO - Running setup.py install for mozdevice 00:24:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:24:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:24:33 INFO - Running setup.py install for mozfile 00:24:33 INFO - Running setup.py install for mozhttpd 00:24:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:24:33 INFO - Running setup.py install for mozinfo 00:24:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:24:33 INFO - Running setup.py install for mozInstall 00:24:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:24:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:24:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:24:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:24:33 INFO - Running setup.py install for mozleak 00:24:33 INFO - Running setup.py install for mozlog 00:24:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:24:33 INFO - Running setup.py install for moznetwork 00:24:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:24:33 INFO - Running setup.py install for mozprocess 00:24:33 INFO - Running setup.py install for mozprofile 00:24:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:24:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:24:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:24:34 INFO - Running setup.py install for mozrunner 00:24:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:24:34 INFO - Running setup.py install for mozscreenshot 00:24:34 INFO - Running setup.py install for moztest 00:24:34 INFO - Running setup.py install for mozversion 00:24:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:24:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:24:34 INFO - Cleaning up... 00:24:34 INFO - Return code: 0 00:24:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:34 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 0x7fb2c98edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d8930>, '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 0x26d9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d9cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', '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 00:24:34 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 00:24:34 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 00:24:34 INFO - Using env: {'DISPLAY': ':0', 00:24:34 INFO - 'HOME': '/home/cltbld', 00:24:34 INFO - 'LANG': 'en_US.UTF-8', 00:24:34 INFO - 'LANGUAGE': 'en_US:en', 00:24:34 INFO - 'LOGNAME': 'cltbld', 00:24:34 INFO - 'MAIL': '/var/mail/cltbld', 00:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:34 INFO - 'MOZ_NO_REMOTE': '1', 00:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:34 INFO - 'NO_EM_RESTART': '1', 00:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:34 INFO - 'PWD': '/builds/slave/test', 00:24:34 INFO - 'SHELL': '/bin/bash', 00:24:34 INFO - 'SHLVL': '1', 00:24:34 INFO - 'TERM': 'linux', 00:24:34 INFO - 'TMOUT': '86400', 00:24:34 INFO - 'USER': 'cltbld', 00:24:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', 00:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:34 INFO - '_': '/tools/buildbot/bin/python'} 00:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:24:34 INFO - Running setup.py (path:/tmp/pip-bn4HcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:24:34 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)) 00:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:24:34 INFO - Running setup.py (path:/tmp/pip-aT5J1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 00:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:24:34 INFO - Running setup.py (path:/tmp/pip-e5hNWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:24:34 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)) 00:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:24:34 INFO - Running setup.py (path:/tmp/pip-UFcwcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:24:35 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)) 00:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:24:35 INFO - Running setup.py (path:/tmp/pip-tkVThQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:24:35 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)) 00:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:24:35 INFO - Running setup.py (path:/tmp/pip-etYpAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:24:35 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)) 00:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:24:35 INFO - Running setup.py (path:/tmp/pip-8hGdHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:24:35 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)) 00:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:24:35 INFO - Running setup.py (path:/tmp/pip-D6RxnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:24:35 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)) 00:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:24:35 INFO - Running setup.py (path:/tmp/pip-4ZO47C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:24:35 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)) 00:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:24:35 INFO - Running setup.py (path:/tmp/pip-bCJ5DV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:24:35 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)) 00:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:24:35 INFO - Running setup.py (path:/tmp/pip-nT0weP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:24:35 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)) 00:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:24:35 INFO - Running setup.py (path:/tmp/pip-ylzbzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:24:35 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)) 00:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:24:35 INFO - Running setup.py (path:/tmp/pip-bjNKir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:24:35 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)) 00:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:24:35 INFO - Running setup.py (path:/tmp/pip-ojxpYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 00:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:24:35 INFO - Running setup.py (path:/tmp/pip-q1nqLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:24:35 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)) 00:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:24:35 INFO - Running setup.py (path:/tmp/pip-DM_iuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:24:35 INFO - Running setup.py (path:/tmp/pip-C8OwZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:24:35 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)) 00:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:24:35 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)) 00:24:35 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)) 00:24:35 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)) 00:24:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:24:35 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 00:24:35 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 00:24:35 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 00:24:35 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 00:24:35 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 00:24:35 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 00:24:37 INFO - Downloading blessings-1.6.tar.gz 00:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:24:37 INFO - Installing collected packages: blessings 00:24:37 INFO - Running setup.py install for blessings 00:24:38 INFO - Successfully installed blessings 00:24:38 INFO - Cleaning up... 00:24:38 INFO - Return code: 0 00:24:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:24:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:24:38 INFO - Reading from file tmpfile_stdout 00:24:38 INFO - Current package versions: 00:24:38 INFO - argparse == 1.2.1 00:24:38 INFO - blessings == 1.6 00:24:38 INFO - blobuploader == 1.2.4 00:24:38 INFO - docopt == 0.6.1 00:24:38 INFO - functools32 == 3.2.3-2 00:24:38 INFO - jsonschema == 2.5.1 00:24:38 INFO - manifestparser == 1.1 00:24:38 INFO - mozInstall == 1.12 00:24:38 INFO - mozcrash == 0.17 00:24:38 INFO - mozdebug == 0.1 00:24:38 INFO - mozdevice == 0.48 00:24:38 INFO - mozfile == 1.2 00:24:38 INFO - mozhttpd == 0.7 00:24:38 INFO - mozinfo == 0.9 00:24:38 INFO - mozleak == 0.1 00:24:38 INFO - mozlog == 3.4 00:24:38 INFO - moznetwork == 0.27 00:24:38 INFO - mozprocess == 0.23 00:24:38 INFO - mozprofile == 0.28 00:24:38 INFO - mozrunner == 6.12 00:24:38 INFO - mozscreenshot == 0.1 00:24:38 INFO - mozsystemmonitor == 0.3 00:24:38 INFO - moztest == 0.7 00:24:38 INFO - mozversion == 1.4 00:24:38 INFO - psutil == 3.1.1 00:24:38 INFO - requests == 1.2.3 00:24:38 INFO - wsgiref == 0.1.2 00:24:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:38 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 0x7fb2c98edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d8930>, '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 0x26d9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d9cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', '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 00:24:38 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 00:24:38 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 00:24:38 INFO - Using env: {'DISPLAY': ':0', 00:24:38 INFO - 'HOME': '/home/cltbld', 00:24:38 INFO - 'LANG': 'en_US.UTF-8', 00:24:38 INFO - 'LANGUAGE': 'en_US:en', 00:24:38 INFO - 'LOGNAME': 'cltbld', 00:24:38 INFO - 'MAIL': '/var/mail/cltbld', 00:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:38 INFO - 'MOZ_NO_REMOTE': '1', 00:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:38 INFO - 'NO_EM_RESTART': '1', 00:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:38 INFO - 'PWD': '/builds/slave/test', 00:24:38 INFO - 'SHELL': '/bin/bash', 00:24:38 INFO - 'SHLVL': '1', 00:24:38 INFO - 'TERM': 'linux', 00:24:38 INFO - 'TMOUT': '86400', 00:24:38 INFO - 'USER': 'cltbld', 00:24:38 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', 00:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:38 INFO - '_': '/tools/buildbot/bin/python'} 00:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:38 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)) 00:24:38 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)) 00:24:38 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)) 00:24:38 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)) 00:24:38 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)) 00:24:38 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)) 00:24:38 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)) 00:24:38 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)) 00:24:38 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)) 00:24:38 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)) 00:24:38 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)) 00:24:38 INFO - Cleaning up... 00:24:38 INFO - Return code: 0 00:24:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:38 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 0x7fb2c98edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26db790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d8930>, '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 0x26d9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d9cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', '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 00:24:38 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 00:24:38 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 00:24:38 INFO - Using env: {'DISPLAY': ':0', 00:24:38 INFO - 'HOME': '/home/cltbld', 00:24:38 INFO - 'LANG': 'en_US.UTF-8', 00:24:38 INFO - 'LANGUAGE': 'en_US:en', 00:24:38 INFO - 'LOGNAME': 'cltbld', 00:24:38 INFO - 'MAIL': '/var/mail/cltbld', 00:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:38 INFO - 'MOZ_NO_REMOTE': '1', 00:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:38 INFO - 'NO_EM_RESTART': '1', 00:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:38 INFO - 'PWD': '/builds/slave/test', 00:24:38 INFO - 'SHELL': '/bin/bash', 00:24:38 INFO - 'SHLVL': '1', 00:24:38 INFO - 'TERM': 'linux', 00:24:38 INFO - 'TMOUT': '86400', 00:24:38 INFO - 'USER': 'cltbld', 00:24:38 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', 00:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:38 INFO - '_': '/tools/buildbot/bin/python'} 00:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:24:38 INFO - Cleaning up... 00:24:38 INFO - Return code: 0 00:24:38 INFO - Running post-action listener: _resource_record_post_action 00:24:38 INFO - Running post-action listener: _start_resource_monitoring 00:24:38 INFO - Starting resource monitoring. 00:24:38 INFO - [mozharness: 2016-10-28 07:24:38.847131Z] Finished create-virtualenv step (success) 00:24:38 INFO - [mozharness: 2016-10-28 07:24:38.847588Z] Running install step. 00:24:38 INFO - Running pre-action listener: _resource_record_pre_action 00:24:38 INFO - Running main action method: install 00:24:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:24:39 INFO - Reading from file tmpfile_stdout 00:24:39 INFO - Detecting whether we're running mozinstall >=1.0... 00:24:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:24:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:24:39 INFO - Reading from file tmpfile_stdout 00:24:39 INFO - Output received: 00:24:39 INFO - Usage: mozinstall [options] installer 00:24:39 INFO - Options: 00:24:39 INFO - -h, --help show this help message and exit 00:24:39 INFO - -d DEST, --destination=DEST 00:24:39 INFO - Directory to install application into. [default: 00:24:39 INFO - "/builds/slave/test"] 00:24:39 INFO - --app=APP Application being installed. [default: firefox] 00:24:39 INFO - mkdir: /builds/slave/test/build/application 00:24:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:24:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:24:56 INFO - Reading from file tmpfile_stdout 00:24:56 INFO - Output received: 00:24:56 INFO - /builds/slave/test/build/application/firefox/firefox 00:24:56 INFO - Running post-action listener: _resource_record_post_action 00:24:56 INFO - [mozharness: 2016-10-28 07:24:56.237010Z] Finished install step (success) 00:24:56 INFO - [mozharness: 2016-10-28 07:24:56.237257Z] Running run-tests step. 00:24:56 INFO - Running pre-action listener: _resource_record_pre_action 00:24:56 INFO - Running main action method: run_tests 00:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:24:56 INFO - Python 2.7.3 00:24:56 INFO - Return code: 0 00:24:56 INFO - grabbing minidump binary from tooltool 00:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:24:56 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 0x26d8930>, '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 0x26d9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d9cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:24:56 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 00:24:56 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 00:24:56 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 00:24:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:24:56 INFO - Return code: 0 00:24:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:24:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:24:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:24:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:24:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 00:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 00:24:56 INFO - Using env: {'DISPLAY': ':0', 00:24:56 INFO - 'HOME': '/home/cltbld', 00:24:56 INFO - 'LANG': 'en_US.UTF-8', 00:24:56 INFO - 'LANGUAGE': 'en_US:en', 00:24:56 INFO - 'LOGNAME': 'cltbld', 00:24:56 INFO - 'MAIL': '/var/mail/cltbld', 00:24:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:24:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:56 INFO - 'MOZ_NO_REMOTE': '1', 00:24:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:56 INFO - 'NO_EM_RESTART': '1', 00:24:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:56 INFO - 'PWD': '/builds/slave/test', 00:24:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:24:56 INFO - 'SHELL': '/bin/bash', 00:24:56 INFO - 'SHLVL': '1', 00:24:56 INFO - 'TERM': 'linux', 00:24:56 INFO - 'TMOUT': '86400', 00:24:56 INFO - 'USER': 'cltbld', 00:24:56 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111', 00:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:56 INFO - '_': '/tools/buildbot/bin/python'} 00:24:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 00:24:56 INFO - mozversion application_buildid: 20161027213002 00:24:56 INFO - mozversion application_changeset: 71536044069576fc877bf7ef0ba13a4ada793706 00:24:56 INFO - mozversion application_display_name: Nightly 00:24:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:24:56 INFO - mozversion application_name: Firefox 00:24:56 INFO - mozversion application_remotingname: firefox 00:24:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:24:56 INFO - mozversion application_vendor: Mozilla 00:24:56 INFO - mozversion application_version: 52.0a1 00:24:56 INFO - mozversion platform_buildid: 20161027213002 00:24:56 INFO - mozversion platform_changeset: 71536044069576fc877bf7ef0ba13a4ada793706 00:24:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:24:56 INFO - mozversion platform_version: 52.0a1 00:24:56 INFO - using testdate: 1477639496 00:24:56 INFO - actual date: 1477639496 00:24:56 INFO - starting webserver on 'localhost:60812' 00:24:56 INFO - SUITE-START | Running 2 tests 00:24:56 INFO - TEST-START | dromaeo_css 00:24:56 INFO - operating with platform_type : linux_ 00:24:56 INFO - Initialising browser for dromaeo_css test... 00:24:56 INFO - TEST-INFO | started process 7486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDhbyiy/profile http://localhost:60812/getInfo.html) 00:25:00 INFO - PROCESS | 7486 | __metrics Screen width/height:1600/1200 00:25:00 INFO - PROCESS | 7486 | colorDepth:24 00:25:00 INFO - PROCESS | 7486 | Browser inner width/height: 1024/697 00:25:00 INFO - PROCESS | 7486 | __metrics 00:25:01 INFO - PROCESS | 7486 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:25:01 INFO - PROCESS | 7486 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:25:01 INFO - PROCESS | 7486 | console.error: PushService: 00:25:01 INFO - PROCESS | 7486 | stateChangeProcessEnqueue: Error transitioning state 00:25:01 INFO - PROCESS | 7486 | UnknownError 00:25:02 INFO - TEST-INFO | 7486: exit 0 00:25:02 INFO - Browser initialized. 00:25:02 INFO - Running cycle 1/1 for dromaeo_css test... 00:25:02 INFO - TEST-INFO | started process 7570 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDhbyiy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:25:14 INFO - PROCESS | 7570 | RSS: Main: 172081152 00:25:14 INFO - PROCESS | 7570 | 00:26:05 INFO - PROCESS | 7570 | 1477639565787 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 00:28:15 INFO - PROCESS | 7570 | Cycle 1(1): loaded http://localhost:60812/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60812/tests/dromaeo/cssquery-ext.html) 00:28:18 INFO - PROCESS | 7570 | RSS: Main: 397860864 00:28:18 INFO - PROCESS | 7570 | 00:31:21 INFO - PROCESS | 7570 | Cycle 1(1): loaded http://localhost:60812/tests/dromaeo/cssquery-ext.html (next: http://localhost:60812/tests/dromaeo/cssquery-jquery.html) 00:31:21 INFO - PROCESS | 7570 | RSS: Main: 276045824 00:31:21 INFO - PROCESS | 7570 | 00:34:23 INFO - PROCESS | 7570 | Cycle 1(1): loaded http://localhost:60812/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60812/tests/dromaeo/cssquery-mootools.html) 00:34:24 INFO - PROCESS | 7570 | RSS: Main: 219209728 00:34:24 INFO - PROCESS | 7570 | 00:37:26 INFO - PROCESS | 7570 | Cycle 1(1): loaded http://localhost:60812/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60812/tests/dromaeo/cssquery-prototype.html) 00:37:27 INFO - PROCESS | 7570 | RSS: Main: 260657152 00:37:27 INFO - PROCESS | 7570 | 00:40:29 INFO - PROCESS | 7570 | Cycle 1(1): loaded http://localhost:60812/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60812/tests/dromaeo/cssquery-yui.html) 00:40:30 INFO - PROCESS | 7570 | RSS: Main: 218050560 00:40:30 INFO - PROCESS | 7570 | 00:43:33 INFO - PROCESS | 7570 | Cycle 1(1): loaded http://localhost:60812/tests/dromaeo/cssquery-yui.html (next: http://localhost:60812/tests/dromaeo/cssquery-dojo.html) 00:43:33 INFO - PROCESS | 7570 | RSS: Main: 311386112 00:43:33 INFO - PROCESS | 7570 | 00:43:33 INFO - PROCESS | 7570 | __start_tp_report 00:43:33 INFO - PROCESS | 7570 | _x_x_mozilla_page_load 00:43:33 INFO - PROCESS | 7570 | _x_x_mozilla_page_load_details 00:43:33 INFO - PROCESS | 7570 | |i|pagename|runs| 00:43:33 INFO - PROCESS | 7570 | |0;dojo.html;3025.2739342557784;3051.3897220555896;3074.7232749052587;3089.5829063076494;3095.4986831386786;5132.153194722866;5199.818006369778;5224.529792318691;5332.866678333039;5340.652857564256;5238.371395432544;5294.814681486148;5369.087255166622;5379.784808607651;5452.700101494416;4786.090642777878;4795.6163506919365;4839.7338146401935;4864.124457597631;4889.657723959324;4880.487548807378;4918.409790825088;4967.379077615298;4979.053979743855;5042.520960508746;4699.812007519729;4875.439324477695;4878.048780487807;4908.484609116027;5016.322796422491;4727.95272047282;4827.275908613701;4827.324174615556;4831.975840120777;4834.178189707758;4717.693349932243;4733.124371991193;4788.880277993043;4797.592204662573;4805.279208118775;5205;5298.470152984709;5302.708351040691;5306.151015837448;5315.123004704219;5608.691521966291;5622.550195984352;5623.8594035149035;5628.915566266509;5630.239917611111;5432.266644003049;5661.2923384576925;5669.574781891375;5670.4896559309445;5674.375818659944;5120.206368012927;5295.364556253275;5336.519713225828;5340.038793017294;5415.6479828811;5768.394318596571;5827.825165245049;5836.153757705109;5846.619969701956;5853.619514731528;5612.522935550524;5621.297337832771;5626.381098079208;5626.437356264422;5632.859178520488;5339.119045357473;5345.599080069011;5355.678659280456;5460.071787796084;5460.208269800856;5553.805616803393;5576.275084239023;5594.272744543184;5685.459881311269;5687.77248910039;5634.774609015593;5635.098384258499;5636.239107720406;5693.430656934273;5703.686297253608;4319.805608747614;4347.217500849877;4354.390385346054;4361.367601697736;4410.404595379583;3828.2534905693124;3842.9615703843165;3848;3897.279003384383;3905.941410878839;5297.496737809902;5364.356277246756;5368.597355198376;5400.513953744104;5473.452654734495;5631.380548139701;5635.5773317001385;5645.068563687028;5646.265985421869;5652.123920792284;5188.792448302102;5300.628955973045;5383.7308134593895;5389.589780211033;5394.271773310631;4877.317175595419;4895.559399654048;4906.165951788204;4929.186684197139;4991.276264941635;5921.526277897672;5952.404759524013;5961.076033214858;5965.761369545169;5968.37332080134;5452.972735136457;5679.460451257124;5692.886142277214;5694.515966142924;5696.259486266758;5706.914396284142;5916.585838991401;5949.405059494016;5959.880802384015;6060.545459090674;5636.1827535008015;5641.689707066151;5648.4633959773755;5652.604317697722;5658.264425624642;5466.644668096561;5675.177099320493;5726.914096288642;5736.971315143398;5743.4543718346695;5367.248585197997;5428.131498960148;5454.781808727766;5455.290812194548;5457.890842183055;5453.672779633234;5453.863653408696;5454.154606036071;5466.1527463243265;5468.070428027166;5442.918356224739;5445.156000819721;5453.400125986059;5453.945460545502;5455.672659640434;5448.509634132947;5472.179173124063;5489.1217405214975;5490.231367608618;5497.615166938276;5383.138697808488;5405.5135037846785;5409.161579955114;5409.891802164014;5414.512693857571 00:43:33 INFO - PROCESS | 7570 | |1;ext.html;587.8089620873216;611.6085705148705;618.0759764152592;622.6824319597007;628.7673560782508;30943.535846962313;43810;45259.999999999956;45294;45559;44916.3262551062;45262.77368613161;45292;45328.3200751989;45384;8736.563171841415;8882.289416846668;8882.467051976902;8888.111188881125;8888.688895888645;7980.122186559473;8163.469374490639;10055.597776088947;10265.281430299881;10273.280870339042;10716.946415267912;10760.515776790024;10800.297980631272;10802.459877006118;10807.459627018658;10594.364338139698;10598.205134614935;10650.946745266301;10679.41263230522;10688.412137332405;10427.895721042769;10481.266311358208;10493.685189444328;10501.737456563647;10507.159427245879;41941;42185.36721949173;42232;42258;42292;3342.398368293706;3433.8626454941773;3477.8804615300364;3676.5771936227407;3866.5553461352024;29990.250243743863;31393;31486.685133148603;31532;31765.84117079423;3663.285659296438;3720.553533575961;3788.052986753312;3897.0781850068934;3927.3323534999117;354370;354487;358084;359094;359186;58903;59163;59283;59331.703341483015;59354.703226483594;33713;34767.65232347644;34828;62599.6870015647;62615.373846260954;13551.051426400058;13669.931650341685;13676;13678.042537022511;13681.31593420325;10078.59685612582;10285.897141028643;10516.947415262875;10639.41483218415;10642.521086551124;16764.91617541929;16877.746833797504;16887.746683799753;18636;19196;6770.255271920085;6873.931260687429;6901.792946211622;7043.119610048744;7178.748743793943;962.9518524073768;1033.560736686905;1034.0796690945065;1035.3322107240788;1065.3075500924306;31089.844550777103;31256.010389919455;31327.84336078305;31391.529127063113;31927.361452770816;1053.847192157133;1059.750958524746;1060.1783617696346;1066.7013236293851;1098.780243951213;16105.67788644244;16915.661686766194;17002.574935626708;17032.31870725182;17071.658566828595;502292;508689;508818;509811;509932;57337;58022.7098864503;58055;58072;58100;1267.8225048493218;1302.420422911833;1310.7837206860952;1316.2234281773608;1325.1982550556968;30004.249893752833;30797;31692.841535792173;31805.840970794998;32042.679573203968;50331;50853.23720144127;50938.235926460395;50945;50947;426428;428150;429355;429699;430176;23414.64878026865;24112.397190070387;27289.727102728717;27652.170434886986;27676.446471070063;43651.56348436475;44778.3283250745;44850;49816.501834982635;50081.74959125181;38870.41694374643;38939;39367.80316098401;39661.025423092804;40906.18187636171;39335.213295734495;39549;39825.40261896132;39898.2020359597;41021;39847.40228896627;40377.596224037385;40661.390079148245;41089.79455102825;41584.376234357114;33133.66866331402;35683.82158089297;35768.64231357653;36379.45430818487;36384.636153639185;27571.448571028064;28007.439851203268;28103.71896281011;28259.434811303247;28264.71735282621 00:43:33 INFO - PROCESS | 7570 | |2;jquery.html;365.3697372033241;380.31922858084033;384.8691444908731;391.45392177911816;412.22707423580783;13920.44318227271;17679.204435800402;18390.264389424425;18575.164117614706;19682.507937301576;17683.673724470686;18644.34744783933;18824.623507529875;18974;19013.714794278098;5485.4788795064405;5768.048272035109;5768.192453056576;5768.538516918637;5771.422857714237;5472.2338872557875;5615.943840561604;5646.604737668365;5653.321601407837;5749.683767392792;5609.158626206081;5609.8597535061745;5611.466910643503;5618.241537392461;5625.634333768292;5430.104032834558;5615.073512870392;5617.129344951539;5660.8867822643315;5701.857453563653;5589.993801115797;5590.748416321235;5592.4407559244155;5596;5598.832035038915;13304.534341298007;13584.796228056586;13682.452701891913;13687;13693.726125477435;2300.608896487601;2420.2376251480728;2459.0901366494513;2738.7398197171237;2897.492938735713;9744.610215591369;9770.51147442625;9889.851652225223;10345.068943795019;10393.740156496147;1805.9367922122794;1897.7416873920129;1902.5624106455593;1993.023418524927;1994.2521554417094;77057.22942770613;77853;79115;80930.59534702289;82399;10514.631987880388;10560.947195263974;10850.131989440826;10976.23166378346;11056.889431105747;15166.31751571182;15245.847541524665;15308.617284567976;15317;15324.770128448083;7103.467239957024;7320.853582928418;7344.926550734531;7486.513376630502;7515.473916825879;6619.669016549154;6707.932920670731;6828.795136145924;6885.173779146434;6928.1339832520935;4443.955560444419;4612.723236605814;4649.418822647169;4680.508546602626;4764.571188592974;1868.8228214130656;1926.6917293233016;1929.8359639430525;1987.7614686237744;2001.959960800776;839.5718183726343;944.5324564340696;965.464167387107;968.6706519783307;1065.1265961911313;18010.459686209433;19115.904420477807;19239.536883360848;19342.709859352122;19441.416757497296;959.6593209410698;963.7397902566408;984.4044353166374;1009.248110157937;1035.166690813887;9896.10935015852;10646.787064258826;10753.301035432673;10811.6215932442;10814.459277036274;408883;411500;423905;427570;434741;87458.56270718605;87721;88066.55966720254;88322.55838720893;88322.55838720893;979.4368238263028;997.3892164154983;1023.9283250172565;1029.46467836726;1033.18894667687;17069.402570910454;17215.936548741607;17997.55006124805;18027;18117.184726687068;38928.221435570566;39968.60031399649;40530.594694052685;40760;43170;54711.72644136754;55746.44253557575;56297.43702562922;57347.139792903974;58695;8341.20758527939;8413;8599.656013759379;8626.439281446686;8643.956780216058;12311.19977201479;13150.934245328712;13254.80117798253;13311.66720831987;13403.798943015667;11221.158413119212;11651.485306910048;11705.122115841516;11806.940965295118;12328.753424931272;11009.412787994655;11312.660620181408;11366.943165284121;11565.768684626428;12138.089643276613;11561;11876.703082423008;11885.16803823724;11973.042156627624;12070.155089144027;8375.246227839523;8406.159384061544;8463.830723385621;8662;8743.91256087431;9522.714318570454;11367.488463019019;11418.257813242113;11421.828672569753;11636.650900473 00:43:33 INFO - PROCESS | 7570 | |3;mootools.html;1338.2104558310596;1407.528477959883;1469.2653673163416;1548.8606025457707;1729.7751292331996;7279.963600181998;7822.061352637685;7973.362131029511;8009.519428834274;8273.420860539749;8093.67625294989;8152.266296033371;8152.388570857194;8156.143604921487;8158.224968627986;2285.0745448093467;2307.861528308307;2310.6418505131733;2315.780000899912;2316.8030717388956;2293.1515339324474;2326.3951372643064;2326.7905888470036;2333.7666233376613;2347.072906202049;2237.2281562860785;2242.069541140425;2256.9774302256933;2276.5560715660454;2280.464090938628;2183.355910006536;2221.3447033125185;2230.2194232018746;2240.6526988316837;2245.494763678176;2261.2876943762662;2269.0583407885706;2276.84062115652;2277.202978957368;2285.931422057341;8055.718049868285;8061.556614386206;8105.392095592854;8122.756317310431;8126.268635822746;5131.53816156544;5288.92066619001;5316.627836051478;5318.30861987943;5319.9202011969855;3214.1161180675267;3264.314493956272;3317.950230746541;3339.0650617827046;3344.3144155448076;1010.0656892374524;1024.5748014573942;1038.5015192707542;1048.7745134796055;1059.6662051453768;11397.259178153394;11407.600733974272;11510.654680359603;11511.366874821797;11521.07831373488;4327.17783621111;4445.133199026223;4551.089782043538;4573.794179261941;4601.332806743004;9056.501892395981;9057.501837398875;9061.456312621263;9067.773305667279;9215.49314787693;5223.686578805284;5235.188545775411;5244.423113457517;5244.947550524522;5256.421793602701;4091.263572556909;4257.297545904953;4293.119910418357;4345.174416860849;4870.05034018363;3572;3632.164602141522;3705.9073523162137;3727.7204209684382;3757.1546402059867;1157.2535714464123;1158.0561842098662;1162.7325715085578;1169.4386694386571;1184.6979020349927;972.6595691507915;986.5659109991581;987;999.980000399988;1003.2525768302661;5568.164775283659;5741.425857414309;5823.155642431823;5871.882562348729;5923.170756094064;441.4525987775136;442.287916454508;447.9014616784302;453.95006549279555;457.6087445234343;4143.254214241405;4145.233131870614;4156.501219853576;4161.52142503616;4195.727277726938;9886.901130988743;10348.068673819393;10365.740856478498;10425;10426.165906727443;10267.281290309757;10285;10344.844827327446;10368.896311036944;10369.844452333222;7503.7748867534065;7822.921770782333;7823.726169584037;7966.322862556632;7976.960115199387;5671.971640141773;5790.768369265183;5816.912746308724;5878.559108066826;5886.381929897299;9600.615975360908;9620.615175393186;9641.42151470914;9648.421094734338;9746.853797192905;8649.91350086491;8937.955310223408;9568.808623827623;9704.272179586418;9714.222862171151;7180.928190718026;7366.889496657447;7381.077365329334;7444.478886477895;7532.661030253761;8137.389695772959;8224.917750822655;8270.917290827014;8284.50292982423;8313.293370063371;7064.152301723826;7095.9645201773665;7104.715811367488;7131.465140114616;7333.120025596749;7006.684699188447;7042.295770422917;7120.465965052538;7135.750248741269;7164.928350716635;6425.839354016187;6472.449841763503;6482.060101285381;6516.380943810331;6537.673116344259;4732.503087175797;4917.164082106122;4931.841017360989;4959.70241785494;5073;4771.76141192932;4779.545943135397;4781.135357210621;4786.569208771228;4859.538343857328 00:43:33 INFO - PROCESS | 7570 | |4;prototype.html;319.77775446064993;323.70057696630613;330.73541167066355;332.7703884319819;336.9915752106199;5049.166887463564;5179.213171455846;5215.530602245797;5223.634345595805;5267.762950667219;5032.572231360339;5119.846404607859;5146.228065790134;5201.843944681666;5246.868828279295;4099.590040995891;4108.732932359387;4109.773962432065;4135.669146468283;4142.730722503027;3970.027343300895;4069.9796501017454;4092.401325158516;4112.97943510282;4126.195391898581;4050.372192310182;4050.574689657588;4065.349544072949;4072.1855628874196;4080.5924504542313;4016.819243134066;4031.153457773871;4051.736637118607;4062.7968601569805;4062.8217816833085;3440.397930362177;3564.6791788739138;3568.678818906311;3574.928501429983;3586.1393265616325;5024.773885175176;5029.4216165141115;5037.11850426174;5053.418856831475;5070.0620385228485;4602.171609110359;4614.284785858197;4619.653525985531;4620.491745907947;4621.237495813187;5313.654612450178;5360.9463905360835;5371.274877891474;5425.159100339453;5475;3899.5905429930017;3904.531456225271;3907.6873850091924;3911.726179167431;3924.4113382992496;5619.971900140473;5628.04323265046;5658.773649054033;5667.631603945731;5680.943190568083;3838.5201849768778;3943.3690609502914;3953.8418463261723;3962.385830196324;3965.266425711253;3954.8615798446917;3955.723099383073;3969.4045893115685;3970.940435893464;3991.560928297885;4533.300012495314;4544.590986811203;4545.477270113979;4548.681592288574;4553.271476563734;5314.92027619586;5415.458454154553;5445.482679145475;5459.099248623933;5460.754266058037;1367.3026756354332;1386.1336664584635;1398.5804258722342;1400.5238219005382;1401.1172961034688;866.9783255418539;881.2333270055093;893.9642414303355;899.132337294514;907.2243232036645;4673.415823022122;4684.320773487893;4685.430380822462;4701.059788042405;4706.458512403332;4849.709017458964;4859.222524396079;4875.341828853059;4909.502601706514;4918.286848406961;4478.298246666246;4681.812727490862;4683.976580117146;4684.976575117171;4692.991006933526;2592.8980183421972;2616.4636249569176;2623.2917112379932;2641.300055485298;2647.8014148938523;5074.441811400743;5118.692878427232;5121.743912804345;5160.638755287169;5167.966406718671;4818.229083346648;4996.250562415594;5020.272060551272;5068.493150684976;5093.312402825645;4988.650794444354;5017.745563609171;5063.759378952181;5064.164412871834;5099.342713618089;4855.927161092657;4885.706857588556;4928.876778080433;4953.801847926043;4980.228064649985;4854.927176092291;4900.779464924159;4902.656814022984;5108.872278193075;5442.972785136049;5773.393793651606;5774.39368866263;5783.884322313615;5795.7391917362975;5801.9709901451915;3756.5116534850295;3873.4964454620717;3899.220155968761;3983.2630963271886;3983.8605648802154;5452.427495113115;5538.972305138448;5540.7783688652;5550.500454959073;5563.276774019351;5324.547413469743;5327.9200811987075;5381.246625472359;5384.165454354581;5389.8113566025;5234.18870075139;5265.447128051499;5329.57363410934;5345.9465405345445;5370.731463426891;5279.577633789365;5310.362756469249;5348.251244825806;5359.812406565751;5369.248305237192;5225.686458812484;5335.306410166809;5359.812406565751;5372.677639341652;5377.919331210113;5306.151015837448;5315.51165673612;5316.415194328543;5320.494553017457;5320.574354051744 00:43:33 INFO - PROCESS | 7570 | |5;yui.html;709.2198581560281;730.9817254568636;745.1691364128994;783.5729527407563;826.7726375246805;14441.205733684643;15142.394304227817;15150.772738408932;15151.92424037881;15362.385504579817;12066.095042871797;12177;12189.20770149942;12190.81713774294;12214.75570488592;645.4771634975662;662.2913482573648;773.1842905734447;786.799366161628;797.2864286463612;771.0516065239758;782.4679218131669;783.2950344689797;783.3224261014238;783.725696006399;839.1817977471977;841.6843683618642;843.2874221283037;843.6625349860075;843.9409241353108;687.1239170058216;709.6700034483938;821.7699044267615;838.6854929401505;842.4987132656059;614.1708693264102;616.7995401494487;617.0405020193597;617.1668247865391;617.3301967365414;12472.937635311766;12509.562165324262;12516.81224781629;12521.12352135351;12521.74956500874;12277.754444911052;12349.93825030869;12657;12769.170003949714;13143.934280328633;12255.571055013032;12444.564440244638;12494.187877788005;12642.431090600945;13159.802602960963;4293.806778694966;4297.4413326267695;4326.610605045529;4529.977350113261;4531.909361812778;63170.368296316905;63507.6824615874;65502.67248663726;66078.33921660818;67250.66374668144;9959.950200248952;10022.548985295532;10488.05607495329;10701.571937122584;10823.83764243537;19024.524386890163;19158.425247242605;19372.903135484234;19378.674559053004;19382.8061719381;7429.665665045086;7483.812904677317;7485.401167906554;7701.6534255957495;7758.185390534026;4332.610065094157;4352.499462561846;4371.650267978554;4402.141582391467;4430.867073987721;3302.455094909361;3477.791332520057;3486.4770284457536;3522.489239060322;3524.1718196223865;636.961782293064;654.3718030690591;658.1049772309655;659.8977158540434;666.9133012708317;602.5691630484225;613.5735663713676;657.2146285189153;671.1576970901585;681.417388133149;8591.914080859236;9443.622255109718;9625.79594107306;9789.608415663437;10046.949765251127;715.1882613234017;716.4554938246865;718.3714250031222;734.1447213995742;740.4631642059571;4393.29707246839;4432.556744325541;4733.5503127202865;4755.595774359218;4830.797703505463;85410.14589854021;85823;86763;86784;88352.55823720968;73361.26638733651;74682;75426.24573754192;76607;77298;63884.68057659682;68391.31608684048;69010.65494672494;69999.65000174966;71228.64385678039;8586.871196931927;8897.555122243732;8946.955265223633;9053.818923621622;9345.766355841159;45792.31311530263;46760.53239467562;46894.53105468902;47332;48887.02225955532;56419;58653.413465864796;62268.68865655643;62391;63154.36845631485;11340.546378145113;11429.657110286706;11443.656690299304;12500;12512.562060327844;13863.653408664864;14008.43966241339;14017.929910350791;14019.088759230617;14383.208923509308;13309.600711978268;13322.866771332163;13386.26375549354;13571.79642305386;13677.31613419345;12450.81323780126;12487.31319777421;12492.125551211691;13330.333483325989;13472;11437.656870293904;11802.645920622395;12092.334921579397;12659.493620255087;12670.556530521388;10537.315074520131;10801;10815.513301901276;11158.49786759614;11311.377874216998;9132.22376098039;9298.72103836886;9822.361546499455;10734.141268698642;10881.401522916316 00:43:33 INFO - PROCESS | 7570 | __end_tp_report 00:43:33 INFO - PROCESS | 7570 | __start_cc_report 00:43:33 INFO - PROCESS | 7570 | _x_x_mozilla_cycle_collect,2538 00:43:33 INFO - PROCESS | 7570 | __end_cc_report 00:43:33 INFO - PROCESS | 7570 | __startTimestamp1477640613742__endTimestamp 00:43:33 INFO - PROCESS | 7570 | 00:43:33 INFO - PROCESS | 7570 | ------- Summary: start ------- 00:43:33 INFO - PROCESS | 7570 | Number of tests: 6 00:43:33 INFO - PROCESS | 7570 | 00:43:33 INFO - PROCESS | 7570 | [#0] dojo.html Cycles:165 Average:5255.07 Median:5428.13 stddev:589.76 (10.9%) stddev-sans-first:565.03 00:43:33 INFO - PROCESS | 7570 | Values: 3025.3 3051.4 3074.7 3089.6 3095.5 5132.2 5199.8 5224.5 5332.9 5340.7 5238.4 5294.8 5369.1 5379.8 5452.7 4786.1 4795.6 4839.7 4864.1 4889.7 4880.5 4918.4 4967.4 4979.1 5042.5 4699.8 4875.4 4878.0 4908.5 5016.3 4728.0 4827.3 4827.3 4832.0 4834.2 4717.7 4733.1 4788.9 4797.6 4805.3 5205.0 5298.5 5302.7 5306.2 5315.1 5608.7 5622.6 5623.9 5628.9 5630.2 5432.3 5661.3 5669.6 5670.5 5674.4 5120.2 5295.4 5336.5 5340.0 5415.6 5768.4 5827.8 5836.2 5846.6 5853.6 5612.5 5621.3 5626.4 5626.4 5632.9 5339.1 5345.6 5355.7 5460.1 5460.2 5553.8 5576.3 5594.3 5685.5 5687.8 5634.8 5635.1 5636.2 5693.4 5703.7 4319.8 4347.2 4354.4 4361.4 4410.4 3828.3 3843.0 3848.0 3897.3 3905.9 5297.5 5364.4 5368.6 5400.5 5473.5 5631.4 5635.6 5645.1 5646.3 5652.1 5188.8 5300.6 5383.7 5389.6 5394.3 4877.3 4895.6 4906.2 4929.2 4991.3 5921.5 5952.4 5961.1 5965.8 5968.4 5453.0 5679.5 5692.9 5694.5 5696.3 5706.9 5916.6 5949.4 5959.9 6060.5 5636.2 5641.7 5648.5 5652.6 5658.3 5466.6 5675.2 5726.9 5737.0 5743.5 5367.2 5428.1 5454.8 5455.3 5457.9 5453.7 5453.9 5454.2 5466.2 5468.1 5442.9 5445.2 5453.4 5453.9 5455.7 5448.5 5472.2 5489.1 5490.2 5497.6 5383.1 5405.5 5409.2 5409.9 5414.5 00:43:33 INFO - PROCESS | 7570 | 00:43:33 INFO - PROCESS | 7570 | [#1] ext.html Cycles:180 Average:58728.15 Median:359140.00 stddev:115386.14 (32.1%) stddev-sans-first:115627.26 00:43:33 INFO - PROCESS | 7570 | Values: 587.8 611.6 618.1 622.7 628.8 30943.5 43810.0 45260.0 45294.0 45559.0 44916.3 45262.8 45292.0 45328.3 45384.0 8736.6 8882.3 8882.5 8888.1 8888.7 7980.1 8163.5 10055.6 10265.3 10273.3 10716.9 10760.5 10800.3 10802.5 10807.5 10594.4 10598.2 10650.9 10679.4 10688.4 10427.9 10481.3 10493.7 10501.7 10507.2 41941.0 42185.4 42232.0 42258.0 42292.0 3342.4 3433.9 3477.9 3676.6 3866.6 29990.3 31393.0 31486.7 31532.0 31765.8 3663.3 3720.6 3788.1 3897.1 3927.3 354370.0 354487.0 358084.0 359094.0 359186.0 58903.0 59163.0 59283.0 59331.7 59354.7 33713.0 34767.7 34828.0 62599.7 62615.4 13551.1 13669.9 13676.0 13678.0 13681.3 10078.6 10285.9 10516.9 10639.4 10642.5 16764.9 16877.7 16887.7 18636.0 19196.0 6770.3 6873.9 6901.8 7043.1 7178.7 963.0 1033.6 1034.1 1035.3 1065.3 31089.8 31256.0 31327.8 31391.5 31927.4 1053.8 1059.8 1060.2 1066.7 1098.8 16105.7 16915.7 17002.6 17032.3 17071.7 502292.0 508689.0 508818.0 509811.0 509932.0 57337.0 58022.7 58055.0 58072.0 58100.0 1267.8 1302.4 1310.8 1316.2 1325.2 30004.2 30797.0 31692.8 31805.8 32042.7 50331.0 50853.2 50938.2 50945.0 50947.0 426428.0 428150.0 429355.0 429699.0 430176.0 23414.6 24112.4 27289.7 27652.2 27676.4 43651.6 44778.3 44850.0 49816.5 50081.7 38870.4 38939.0 39367.8 39661.0 40906.2 39335.2 39549.0 39825.4 39898.2 41021.0 39847.4 40377.6 40661.4 41089.8 41584.4 33133.7 35683.8 35768.6 36379.5 36384.6 27571.4 28007.4 28103.7 28259.4 28264.7 00:43:33 INFO - PROCESS | 7570 | 00:43:33 INFO - PROCESS | 7570 | [#2] jquery.html Cycles:180 Average:26452.05 Median:20180.03 stddev:69829.55 (346.0%) stddev-sans-first:69997.97 00:43:33 INFO - PROCESS | 7570 | Values: 365.4 380.3 384.9 391.5 412.2 13920.4 17679.2 18390.3 18575.2 19682.5 17683.7 18644.3 18824.6 18974.0 19013.7 5485.5 5768.0 5768.2 5768.5 5771.4 5472.2 5615.9 5646.6 5653.3 5749.7 5609.2 5609.9 5611.5 5618.2 5625.6 5430.1 5615.1 5617.1 5660.9 5701.9 5590.0 5590.7 5592.4 5596.0 5598.8 13304.5 13584.8 13682.5 13687.0 13693.7 2300.6 2420.2 2459.1 2738.7 2897.5 9744.6 9770.5 9889.9 10345.1 10393.7 1805.9 1897.7 1902.6 1993.0 1994.3 77057.2 77853.0 79115.0 80930.6 82399.0 10514.6 10560.9 10850.1 10976.2 11056.9 15166.3 15245.8 15308.6 15317.0 15324.8 7103.5 7320.9 7344.9 7486.5 7515.5 6619.7 6707.9 6828.8 6885.2 6928.1 4444.0 4612.7 4649.4 4680.5 4764.6 1868.8 1926.7 1929.8 1987.8 2002.0 839.6 944.5 965.5 968.7 1065.1 18010.5 19115.9 19239.5 19342.7 19441.4 959.7 963.7 984.4 1009.2 1035.2 9896.1 10646.8 10753.3 10811.6 10814.5 408883.0 411500.0 423905.0 427570.0 434741.0 87458.6 87721.0 88066.6 88322.6 88322.6 979.4 997.4 1023.9 1029.5 1033.2 17069.4 17215.9 17997.6 18027.0 18117.2 38928.2 39968.6 40530.6 40760.0 43170.0 54711.7 55746.4 56297.4 57347.1 58695.0 8341.2 8413.0 8599.7 8626.4 8644.0 12311.2 13150.9 13254.8 13311.7 13403.8 11221.2 11651.5 11705.1 11806.9 12328.8 11009.4 11312.7 11366.9 11565.8 12138.1 11561.0 11876.7 11885.2 11973.0 12070.2 8375.2 8406.2 8463.8 8662.0 8743.9 9522.7 11367.5 11418.3 11421.8 11636.7 00:43:33 INFO - PROCESS | 7570 | 00:43:33 INFO - PROCESS | 7570 | [#3] mootools.html Cycles:180 Average:5466.45 Median:4893.61 stddev:3058.88 (62.5%) stddev-sans-first:3051.73 00:43:33 INFO - PROCESS | 7570 | Values: 1338.2 1407.5 1469.3 1548.9 1729.8 7280.0 7822.1 7973.4 8009.5 8273.4 8093.7 8152.3 8152.4 8156.1 8158.2 2285.1 2307.9 2310.6 2315.8 2316.8 2293.2 2326.4 2326.8 2333.8 2347.1 2237.2 2242.1 2257.0 2276.6 2280.5 2183.4 2221.3 2230.2 2240.7 2245.5 2261.3 2269.1 2276.8 2277.2 2285.9 8055.7 8061.6 8105.4 8122.8 8126.3 5131.5 5288.9 5316.6 5318.3 5319.9 3214.1 3264.3 3318.0 3339.1 3344.3 1010.1 1024.6 1038.5 1048.8 1059.7 11397.3 11407.6 11510.7 11511.4 11521.1 4327.2 4445.1 4551.1 4573.8 4601.3 9056.5 9057.5 9061.5 9067.8 9215.5 5223.7 5235.2 5244.4 5244.9 5256.4 4091.3 4257.3 4293.1 4345.2 4870.1 3572.0 3632.2 3705.9 3727.7 3757.2 1157.3 1158.1 1162.7 1169.4 1184.7 972.7 986.6 987.0 1000.0 1003.3 5568.2 5741.4 5823.2 5871.9 5923.2 441.5 442.3 447.9 454.0 457.6 4143.3 4145.2 4156.5 4161.5 4195.7 9886.9 10348.1 10365.7 10425.0 10426.2 10267.3 10285.0 10344.8 10368.9 10369.8 7503.8 7822.9 7823.7 7966.3 7977.0 5672.0 5790.8 5816.9 5878.6 5886.4 9600.6 9620.6 9641.4 9648.4 9746.9 8649.9 8938.0 9568.8 9704.3 9714.2 7180.9 7366.9 7381.1 7444.5 7532.7 8137.4 8224.9 8270.9 8284.5 8313.3 7064.2 7096.0 7104.7 7131.5 7333.1 7006.7 7042.3 7120.5 7135.8 7164.9 6425.8 6472.4 6482.1 6516.4 6537.7 4732.5 4917.2 4931.8 4959.7 5073.0 4771.8 4779.5 4781.1 4786.6 4859.5 00:43:33 INFO - PROCESS | 7570 | 00:43:33 INFO - PROCESS | 7570 | [#4] prototype.html Cycles:180 Average:4419.91 Median:4923.58 stddev:1277.17 (25.9%) stddev-sans-first:1243.12 00:43:33 INFO - PROCESS | 7570 | Values: 319.8 323.7 330.7 332.8 337.0 5049.2 5179.2 5215.5 5223.6 5267.8 5032.6 5119.8 5146.2 5201.8 5246.9 4099.6 4108.7 4109.8 4135.7 4142.7 3970.0 4070.0 4092.4 4113.0 4126.2 4050.4 4050.6 4065.3 4072.2 4080.6 4016.8 4031.2 4051.7 4062.8 4062.8 3440.4 3564.7 3568.7 3574.9 3586.1 5024.8 5029.4 5037.1 5053.4 5070.1 4602.2 4614.3 4619.7 4620.5 4621.2 5313.7 5360.9 5371.3 5425.2 5475.0 3899.6 3904.5 3907.7 3911.7 3924.4 5620.0 5628.0 5658.8 5667.6 5680.9 3838.5 3943.4 3953.8 3962.4 3965.3 3954.9 3955.7 3969.4 3970.9 3991.6 4533.3 4544.6 4545.5 4548.7 4553.3 5314.9 5415.5 5445.5 5459.1 5460.8 1367.3 1386.1 1398.6 1400.5 1401.1 867.0 881.2 894.0 899.1 907.2 4673.4 4684.3 4685.4 4701.1 4706.5 4849.7 4859.2 4875.3 4909.5 4918.3 4478.3 4681.8 4684.0 4685.0 4693.0 2592.9 2616.5 2623.3 2641.3 2647.8 5074.4 5118.7 5121.7 5160.6 5168.0 4818.2 4996.3 5020.3 5068.5 5093.3 4988.7 5017.7 5063.8 5064.2 5099.3 4855.9 4885.7 4928.9 4953.8 4980.2 4854.9 4900.8 4902.7 5108.9 5443.0 5773.4 5774.4 5783.9 5795.7 5802.0 3756.5 3873.5 3899.2 3983.3 3983.9 5452.4 5539.0 5540.8 5550.5 5563.3 5324.5 5327.9 5381.2 5384.2 5389.8 5234.2 5265.4 5329.6 5345.9 5370.7 5279.6 5310.4 5348.3 5359.8 5369.2 5225.7 5335.3 5359.8 5372.7 5377.9 5306.2 5315.5 5316.4 5320.5 5320.6 00:43:33 INFO - PROCESS | 7570 | 00:43:33 INFO - PROCESS | 7570 | [#5] yui.html Cycles:180 Average:17575.54 Median:26858.91 stddev:23402.79 (87.1%) stddev-sans-first:23434.17 00:43:33 INFO - PROCESS | 7570 | Values: 709.2 731.0 745.2 783.6 826.8 14441.2 15142.4 15150.8 15151.9 15362.4 12066.1 12177.0 12189.2 12190.8 12214.8 645.5 662.3 773.2 786.8 797.3 771.1 782.5 783.3 783.3 783.7 839.2 841.7 843.3 843.7 843.9 687.1 709.7 821.8 838.7 842.5 614.2 616.8 617.0 617.2 617.3 12472.9 12509.6 12516.8 12521.1 12521.7 12277.8 12349.9 12657.0 12769.2 13143.9 12255.6 12444.6 12494.2 12642.4 13159.8 4293.8 4297.4 4326.6 4530.0 4531.9 63170.4 63507.7 65502.7 66078.3 67250.7 9960.0 10022.5 10488.1 10701.6 10823.8 19024.5 19158.4 19372.9 19378.7 19382.8 7429.7 7483.8 7485.4 7701.7 7758.2 4332.6 4352.5 4371.7 4402.1 4430.9 3302.5 3477.8 3486.5 3522.5 3524.2 637.0 654.4 658.1 659.9 666.9 602.6 613.6 657.2 671.2 681.4 8591.9 9443.6 9625.8 9789.6 10046.9 715.2 716.5 718.4 734.1 740.5 4393.3 4432.6 4733.6 4755.6 4830.8 85410.1 85823.0 86763.0 86784.0 88352.6 73361.3 74682.0 75426.2 76607.0 77298.0 63884.7 68391.3 69010.7 69999.7 71228.6 8586.9 8897.6 8947.0 9053.8 9345.8 45792.3 46760.5 46894.5 47332.0 48887.0 56419.0 58653.4 62268.7 62391.0 63154.4 11340.5 11429.7 11443.7 12500.0 12512.6 13863.7 14008.4 14017.9 14019.1 14383.2 13309.6 13322.9 13386.3 13571.8 13677.3 12450.8 12487.3 12492.1 13330.3 13472.0 11437.7 11802.6 12092.3 12659.5 12670.6 10537.3 10801.0 10815.5 11158.5 11311.4 9132.2 9298.7 9822.4 10734.1 10881.4 00:43:33 INFO - PROCESS | 7570 | -------- Summary: end -------- 00:43:33 INFO - PROCESS | 7570 | 00:43:34 INFO - TEST-INFO | 7570: exit 0 00:43:34 INFO - TEST-OK | dromaeo_css | took 1118193ms 00:43:34 INFO - TEST-START | kraken 00:43:34 INFO - operating with platform_type : linux_ 00:43:34 INFO - Initialising browser for kraken test... 00:43:34 INFO - TEST-INFO | started process 7884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6mGNvh/profile http://localhost:60812/getInfo.html) 00:43:38 INFO - PROCESS | 7884 | __metrics Screen width/height:1600/1200 00:43:38 INFO - PROCESS | 7884 | colorDepth:24 00:43:38 INFO - PROCESS | 7884 | Browser inner width/height: 1024/697 00:43:38 INFO - PROCESS | 7884 | __metrics 00:43:39 INFO - PROCESS | 7884 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:43:39 INFO - PROCESS | 7884 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:43:39 INFO - PROCESS | 7884 | console.error: PushService: 00:43:39 INFO - PROCESS | 7884 | stateChangeProcessEnqueue: Error transitioning state 00:43:39 INFO - PROCESS | 7884 | UnknownError 00:43:40 INFO - TEST-INFO | 7884: exit 0 00:43:40 INFO - Browser initialized. 00:43:40 INFO - Running cycle 1/1 for kraken test... 00:43:40 INFO - TEST-INFO | started process 7966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6mGNvh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:43:52 INFO - PROCESS | 7966 | RSS: Main: 172433408 00:43:52 INFO - PROCESS | 7966 | 00:43:54 INFO - PROCESS | 7966 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60812/tests/kraken/driver.html?testName=audio-beat-detection) 00:43:55 INFO - PROCESS | 7966 | RSS: Main: 229634048 00:43:55 INFO - PROCESS | 7966 | 00:43:58 INFO - PROCESS | 7966 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60812/tests/kraken/driver.html?testName=audio-dft) 00:43:58 INFO - PROCESS | 7966 | RSS: Main: 216248320 00:43:58 INFO - PROCESS | 7966 | 00:44:02 INFO - PROCESS | 7966 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60812/tests/kraken/driver.html?testName=audio-fft) 00:44:02 INFO - PROCESS | 7966 | RSS: Main: 297787392 00:44:02 INFO - PROCESS | 7966 | 00:44:04 INFO - PROCESS | 7966 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60812/tests/kraken/driver.html?testName=audio-oscillator) 00:44:05 INFO - PROCESS | 7966 | RSS: Main: 206475264 00:44:05 INFO - PROCESS | 7966 | 00:44:07 INFO - PROCESS | 7966 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60812/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:44:08 INFO - PROCESS | 7966 | RSS: Main: 212041728 00:44:08 INFO - PROCESS | 7966 | 00:44:11 INFO - PROCESS | 7966 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60812/tests/kraken/driver.html?testName=imaging-darkroom) 00:44:11 INFO - PROCESS | 7966 | RSS: Main: 248496128 00:44:11 INFO - PROCESS | 7966 | 00:44:14 INFO - PROCESS | 7966 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60812/tests/kraken/driver.html?testName=imaging-desaturate) 00:44:15 INFO - PROCESS | 7966 | RSS: Main: 247431168 00:44:15 INFO - PROCESS | 7966 | 00:44:18 INFO - PROCESS | 7966 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60812/tests/kraken/driver.html?testName=json-parse-financial) 00:44:18 INFO - PROCESS | 7966 | RSS: Main: 246550528 00:44:18 INFO - PROCESS | 7966 | 00:44:20 INFO - PROCESS | 7966 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60812/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:44:20 INFO - PROCESS | 7966 | RSS: Main: 209416192 00:44:20 INFO - PROCESS | 7966 | 00:44:22 INFO - PROCESS | 7966 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60812/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:44:23 INFO - PROCESS | 7966 | RSS: Main: 217280512 00:44:23 INFO - PROCESS | 7966 | 00:44:25 INFO - PROCESS | 7966 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60812/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:44:25 INFO - PROCESS | 7966 | RSS: Main: 226598912 00:44:25 INFO - PROCESS | 7966 | 00:44:28 INFO - PROCESS | 7966 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:44:29 INFO - PROCESS | 7966 | RSS: Main: 234070016 00:44:29 INFO - PROCESS | 7966 | 00:44:32 INFO - PROCESS | 7966 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:44:32 INFO - PROCESS | 7966 | RSS: Main: 231751680 00:44:32 INFO - PROCESS | 7966 | 00:44:34 INFO - PROCESS | 7966 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60812/tests/kraken/driver.html?testName=ai-astar) 00:44:34 INFO - PROCESS | 7966 | RSS: Main: 281325568 00:44:34 INFO - PROCESS | 7966 | 00:44:34 INFO - PROCESS | 7966 | __start_tp_report 00:44:34 INFO - PROCESS | 7966 | _x_x_mozilla_page_load 00:44:34 INFO - PROCESS | 7966 | _x_x_mozilla_page_load_details 00:44:34 INFO - PROCESS | 7966 | |i|pagename|runs| 00:44:34 INFO - PROCESS | 7966 | |0;ai-astar;103;110;112;111;112;111;111;111;111;112 00:44:34 INFO - PROCESS | 7966 | |1;audio-beat-detection;147;124;123;163;125;126;123;123;166;124 00:44:34 INFO - PROCESS | 7966 | |2;audio-dft;161;159;163;162;160;160;161;162;162;162 00:44:34 INFO - PROCESS | 7966 | |3;audio-fft;75;75;76;117;76;75;75;74;98;73 00:44:34 INFO - PROCESS | 7966 | |4;audio-oscillator;83;82;114;83;82;82;106;82;83;109 00:44:34 INFO - PROCESS | 7966 | |5;imaging-gaussian-blur;117;118;116;116;117;117;117;117;116;116 00:44:34 INFO - PROCESS | 7966 | |6;imaging-darkroom;145;146;146;146;147;147;146;146;146;146 00:44:34 INFO - PROCESS | 7966 | |7;imaging-desaturate;85;85;85;84;85;85;85;85;85;84 00:44:34 INFO - PROCESS | 7966 | |8;json-parse-financial;55;53;54;53;53;56;53;55;53;54 00:44:34 INFO - PROCESS | 7966 | |9;json-stringify-tinderbox;61;63;60;60;61;61;61;61;62;61 00:44:34 INFO - PROCESS | 7966 | |10;stanford-crypto-aes;80;79;86;78;78;79;87;79;90;85 00:44:34 INFO - PROCESS | 7966 | |11;stanford-crypto-ccm;133;129;133;133;131;132;136;127;174;131 00:44:34 INFO - PROCESS | 7966 | |12;stanford-crypto-pbkdf2;163;165;169;164;164;167;165;165;169;168 00:44:34 INFO - PROCESS | 7966 | |13;stanford-crypto-sha256-iterative;66;65;65;66;64;65;64;63;64;62 00:44:34 INFO - PROCESS | 7966 | __end_tp_report 00:44:34 INFO - PROCESS | 7966 | __start_cc_report 00:44:34 INFO - PROCESS | 7966 | _x_x_mozilla_cycle_collect,1676 00:44:34 INFO - PROCESS | 7966 | __end_cc_report 00:44:34 INFO - PROCESS | 7966 | __startTimestamp1477640674530__endTimestamp 00:44:34 INFO - PROCESS | 7966 | 00:44:34 INFO - PROCESS | 7966 | ------- Summary: start ------- 00:44:34 INFO - PROCESS | 7966 | Number of tests: 14 00:44:34 INFO - PROCESS | 7966 | 00:44:34 INFO - PROCESS | 7966 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.67 (2.4%) stddev-sans-first:0.67 00:44:34 INFO - PROCESS | 7966 | Values: 103.0 110.0 112.0 111.0 112.0 111.0 111.0 111.0 111.0 112.0 00:44:34 INFO - PROCESS | 7966 | 00:44:34 INFO - PROCESS | 7966 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:125.50 stddev:17.45 (13.9%) stddev-sans-first:17.90 00:44:34 INFO - PROCESS | 7966 | Values: 147.0 124.0 123.0 163.0 125.0 126.0 123.0 123.0 166.0 124.0 00:44:34 INFO - PROCESS | 7966 | 00:44:34 INFO - PROCESS | 7966 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 00:44:34 INFO - PROCESS | 7966 | Values: 161.0 159.0 163.0 162.0 160.0 160.0 161.0 162.0 162.0 162.0 00:44:34 INFO - PROCESS | 7966 | 00:44:34 INFO - PROCESS | 7966 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:14.49 (19.3%) stddev-sans-first:15.19 00:44:34 INFO - PROCESS | 7966 | Values: 75.0 75.0 76.0 117.0 76.0 75.0 75.0 74.0 98.0 73.0 00:44:34 INFO - PROCESS | 7966 | 00:44:34 INFO - PROCESS | 7966 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:82.00 stddev:13.30 (16.2%) stddev-sans-first:13.82 00:44:34 INFO - PROCESS | 7966 | Values: 83.0 82.0 114.0 83.0 82.0 82.0 106.0 82.0 83.0 109.0 00:44:34 INFO - PROCESS | 7966 | 00:44:34 INFO - PROCESS | 7966 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 00:44:34 INFO - PROCESS | 7966 | Values: 117.0 118.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 00:44:34 INFO - PROCESS | 7966 | 00:44:34 INFO - PROCESS | 7966 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 00:44:34 INFO - PROCESS | 7966 | Values: 145.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 00:44:34 INFO - PROCESS | 7966 | 00:44:34 INFO - PROCESS | 7966 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 00:44:34 INFO - PROCESS | 7966 | Values: 85.0 85.0 85.0 84.0 85.0 85.0 85.0 85.0 85.0 84.0 00:44:34 INFO - PROCESS | 7966 | 00:44:34 INFO - PROCESS | 7966 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.10 (2.0%) stddev-sans-first:1.09 00:44:34 INFO - PROCESS | 7966 | Values: 55.0 53.0 54.0 53.0 53.0 56.0 53.0 55.0 53.0 54.0 00:44:34 INFO - PROCESS | 7966 | 00:44:34 INFO - PROCESS | 7966 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.88 (1.4%) stddev-sans-first:0.93 00:44:34 INFO - PROCESS | 7966 | Values: 61.0 63.0 60.0 60.0 61.0 61.0 61.0 61.0 62.0 61.0 00:44:34 INFO - PROCESS | 7966 | 00:44:34 INFO - PROCESS | 7966 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.50 stddev:4.43 (5.4%) stddev-sans-first:4.64 00:44:34 INFO - PROCESS | 7966 | Values: 80.0 79.0 86.0 78.0 78.0 79.0 87.0 79.0 90.0 85.0 00:44:34 INFO - PROCESS | 7966 | 00:44:34 INFO - PROCESS | 7966 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:133.00 stddev:13.61 (10.2%) stddev-sans-first:14.39 00:44:34 INFO - PROCESS | 7966 | Values: 133.0 129.0 133.0 133.0 131.0 132.0 136.0 127.0 174.0 131.0 00:44:34 INFO - PROCESS | 7966 | 00:44:34 INFO - PROCESS | 7966 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:166.00 stddev:2.18 (1.3%) stddev-sans-first:2.05 00:44:34 INFO - PROCESS | 7966 | Values: 163.0 165.0 169.0 164.0 164.0 167.0 165.0 165.0 169.0 168.0 00:44:34 INFO - PROCESS | 7966 | 00:44:34 INFO - PROCESS | 7966 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:1.26 (1.9%) stddev-sans-first:1.20 00:44:34 INFO - PROCESS | 7966 | Values: 66.0 65.0 65.0 66.0 64.0 65.0 64.0 63.0 64.0 62.0 00:44:34 INFO - PROCESS | 7966 | -------- Summary: end -------- 00:44:34 INFO - PROCESS | 7966 | 00:44:35 INFO - TEST-INFO | 7966: exit 0 00:44:35 INFO - TEST-OK | kraken | took 61038ms 00:44:35 INFO - SUITE-END | took 1179s 00:44:36 INFO - Completed test suite (00:19:39) 00:44:36 INFO - javascript benchmark 00:44:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3025.2739342557784, 3051.3897220555896, 3074.7232749052587, 3089.5829063076494, 3095.4986831386786, 5132.153194722866, 5199.818006369778, 5224.529792318691, 5332.866678333039, 5340.652857564256, 5238.371395432544, 5294.814681486148, 5369.087255166622, 5379.784808607651, 5452.700101494416, 4786.090642777878, 4795.6163506919365, 4839.7338146401935, 4864.124457597631, 4889.657723959324, 4880.487548807378, 4918.409790825088, 4967.379077615298, 4979.053979743855, 5042.520960508746, 4699.812007519729, 4875.439324477695, 4878.048780487807, 4908.484609116027, 5016.322796422491, 4727.95272047282, 4827.275908613701, 4827.324174615556, 4831.975840120777, 4834.178189707758, 4717.693349932243, 4733.124371991193, 4788.880277993043, 4797.592204662573, 4805.279208118775, 5205.0, 5298.470152984709, 5302.708351040691, 5306.151015837448, 5315.123004704219, 5608.691521966291, 5622.550195984352, 5623.8594035149035, 5628.915566266509, 5630.239917611111, 5432.266644003049, 5661.2923384576925, 5669.574781891375, 5670.4896559309445, 5674.375818659944, 5120.206368012927, 5295.364556253275, 5336.519713225828, 5340.038793017294, 5415.6479828811, 5768.394318596571, 5827.825165245049, 5836.153757705109, 5846.619969701956, 5853.619514731528, 5612.522935550524, 5621.297337832771, 5626.381098079208, 5626.437356264422, 5632.859178520488, 5339.119045357473, 5345.599080069011, 5355.678659280456, 5460.071787796084, 5460.208269800856, 5553.805616803393, 5576.275084239023, 5594.272744543184, 5685.459881311269, 5687.77248910039, 5634.774609015593, 5635.098384258499, 5636.239107720406, 5693.430656934273, 5703.686297253608, 4319.805608747614, 4347.217500849877, 4354.390385346054, 4361.367601697736, 4410.404595379583, 3828.2534905693124, 3842.9615703843165, 3848.0, 3897.279003384383, 3905.941410878839, 5297.496737809902, 5364.356277246756, 5368.597355198376, 5400.513953744104, 5473.452654734495, 5631.380548139701, 5635.5773317001385, 5645.068563687028, 5646.265985421869, 5652.123920792284, 5188.792448302102, 5300.628955973045, 5383.7308134593895, 5389.589780211033, 5394.271773310631, 4877.317175595419, 4895.559399654048, 4906.165951788204, 4929.186684197139, 4991.276264941635, 5921.526277897672, 5952.404759524013, 5961.076033214858, 5965.761369545169, 5968.37332080134, 5452.972735136457, 5679.460451257124, 5692.886142277214, 5694.515966142924, 5696.259486266758, 5706.914396284142, 5916.585838991401, 5949.405059494016, 5959.880802384015, 6060.545459090674, 5636.1827535008015, 5641.689707066151, 5648.4633959773755, 5652.604317697722, 5658.264425624642, 5466.644668096561, 5675.177099320493, 5726.914096288642, 5736.971315143398, 5743.4543718346695, 5367.248585197997, 5428.131498960148, 5454.781808727766, 5455.290812194548, 5457.890842183055, 5453.672779633234, 5453.863653408696, 5454.154606036071, 5466.1527463243265, 5468.070428027166, 5442.918356224739, 5445.156000819721, 5453.400125986059, 5453.945460545502, 5455.672659640434, 5448.509634132947, 5472.179173124063, 5489.1217405214975, 5490.231367608618, 5497.615166938276, 5383.138697808488, 5405.5135037846785, 5409.161579955114, 5409.891802164014, 5414.512693857571], "value": 5215.785023941029, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.8089620873216, 611.6085705148705, 618.0759764152592, 622.6824319597007, 628.7673560782508, 30943.535846962313, 43810.0, 45259.999999999956, 45294.0, 45559.0, 44916.3262551062, 45262.77368613161, 45292.0, 45328.3200751989, 45384.0, 8736.563171841415, 8882.289416846668, 8882.467051976902, 8888.111188881125, 8888.688895888645, 7980.122186559473, 8163.469374490639, 10055.597776088947, 10265.281430299881, 10273.280870339042, 10716.946415267912, 10760.515776790024, 10800.297980631272, 10802.459877006118, 10807.459627018658, 10594.364338139698, 10598.205134614935, 10650.946745266301, 10679.41263230522, 10688.412137332405, 10427.895721042769, 10481.266311358208, 10493.685189444328, 10501.737456563647, 10507.159427245879, 41941.0, 42185.36721949173, 42232.0, 42258.0, 42292.0, 3342.398368293706, 3433.8626454941773, 3477.8804615300364, 3676.5771936227407, 3866.5553461352024, 29990.250243743863, 31393.0, 31486.685133148603, 31532.0, 31765.84117079423, 3663.285659296438, 3720.553533575961, 3788.052986753312, 3897.0781850068934, 3927.3323534999117, 354370.0, 354487.0, 358084.0, 359094.0, 359186.0, 58903.0, 59163.0, 59283.0, 59331.703341483015, 59354.703226483594, 33713.0, 34767.65232347644, 34828.0, 62599.6870015647, 62615.373846260954, 13551.051426400058, 13669.931650341685, 13676.0, 13678.042537022511, 13681.31593420325, 10078.59685612582, 10285.897141028643, 10516.947415262875, 10639.41483218415, 10642.521086551124, 16764.91617541929, 16877.746833797504, 16887.746683799753, 18636.0, 19196.0, 6770.255271920085, 6873.931260687429, 6901.792946211622, 7043.119610048744, 7178.748743793943, 962.9518524073768, 1033.560736686905, 1034.0796690945065, 1035.3322107240788, 1065.3075500924306, 31089.844550777103, 31256.010389919455, 31327.84336078305, 31391.529127063113, 31927.361452770816, 1053.847192157133, 1059.750958524746, 1060.1783617696346, 1066.7013236293851, 1098.780243951213, 16105.67788644244, 16915.661686766194, 17002.574935626708, 17032.31870725182, 17071.658566828595, 502292.0, 508689.0, 508818.0, 509811.0, 509932.0, 57337.0, 58022.7098864503, 58055.0, 58072.0, 58100.0, 1267.8225048493218, 1302.420422911833, 1310.7837206860952, 1316.2234281773608, 1325.1982550556968, 30004.249893752833, 30797.0, 31692.841535792173, 31805.840970794998, 32042.679573203968, 50331.0, 50853.23720144127, 50938.235926460395, 50945.0, 50947.0, 426428.0, 428150.0, 429355.0, 429699.0, 430176.0, 23414.64878026865, 24112.397190070387, 27289.727102728717, 27652.170434886986, 27676.446471070063, 43651.56348436475, 44778.3283250745, 44850.0, 49816.501834982635, 50081.74959125181, 38870.41694374643, 38939.0, 39367.80316098401, 39661.025423092804, 40906.18187636171, 39335.213295734495, 39549.0, 39825.40261896132, 39898.2020359597, 41021.0, 39847.40228896627, 40377.596224037385, 40661.390079148245, 41089.79455102825, 41584.376234357114, 33133.66866331402, 35683.82158089297, 35768.64231357653, 36379.45430818487, 36384.636153639185, 27571.448571028064, 28007.439851203268, 28103.71896281011, 28259.434811303247, 28264.71735282621], "value": 19720.673687866754, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.3697372033241, 380.31922858084033, 384.8691444908731, 391.45392177911816, 412.22707423580783, 13920.44318227271, 17679.204435800402, 18390.264389424425, 18575.164117614706, 19682.507937301576, 17683.673724470686, 18644.34744783933, 18824.623507529875, 18974.0, 19013.714794278098, 5485.4788795064405, 5768.048272035109, 5768.192453056576, 5768.538516918637, 5771.422857714237, 5472.2338872557875, 5615.943840561604, 5646.604737668365, 5653.321601407837, 5749.683767392792, 5609.158626206081, 5609.8597535061745, 5611.466910643503, 5618.241537392461, 5625.634333768292, 5430.104032834558, 5615.073512870392, 5617.129344951539, 5660.8867822643315, 5701.857453563653, 5589.993801115797, 5590.748416321235, 5592.4407559244155, 5596.0, 5598.832035038915, 13304.534341298007, 13584.796228056586, 13682.452701891913, 13687.0, 13693.726125477435, 2300.608896487601, 2420.2376251480728, 2459.0901366494513, 2738.7398197171237, 2897.492938735713, 9744.610215591369, 9770.51147442625, 9889.851652225223, 10345.068943795019, 10393.740156496147, 1805.9367922122794, 1897.7416873920129, 1902.5624106455593, 1993.023418524927, 1994.2521554417094, 77057.22942770613, 77853.0, 79115.0, 80930.59534702289, 82399.0, 10514.631987880388, 10560.947195263974, 10850.131989440826, 10976.23166378346, 11056.889431105747, 15166.31751571182, 15245.847541524665, 15308.617284567976, 15317.0, 15324.770128448083, 7103.467239957024, 7320.853582928418, 7344.926550734531, 7486.513376630502, 7515.473916825879, 6619.669016549154, 6707.932920670731, 6828.795136145924, 6885.173779146434, 6928.1339832520935, 4443.955560444419, 4612.723236605814, 4649.418822647169, 4680.508546602626, 4764.571188592974, 1868.8228214130656, 1926.6917293233016, 1929.8359639430525, 1987.7614686237744, 2001.959960800776, 839.5718183726343, 944.5324564340696, 965.464167387107, 968.6706519783307, 1065.1265961911313, 18010.459686209433, 19115.904420477807, 19239.536883360848, 19342.709859352122, 19441.416757497296, 959.6593209410698, 963.7397902566408, 984.4044353166374, 1009.248110157937, 1035.166690813887, 9896.10935015852, 10646.787064258826, 10753.301035432673, 10811.6215932442, 10814.459277036274, 408883.0, 411500.0, 423905.0, 427570.0, 434741.0, 87458.56270718605, 87721.0, 88066.55966720254, 88322.55838720893, 88322.55838720893, 979.4368238263028, 997.3892164154983, 1023.9283250172565, 1029.46467836726, 1033.18894667687, 17069.402570910454, 17215.936548741607, 17997.55006124805, 18027.0, 18117.184726687068, 38928.221435570566, 39968.60031399649, 40530.594694052685, 40760.0, 43170.0, 54711.72644136754, 55746.44253557575, 56297.43702562922, 57347.139792903974, 58695.0, 8341.20758527939, 8413.0, 8599.656013759379, 8626.439281446686, 8643.956780216058, 12311.19977201479, 13150.934245328712, 13254.80117798253, 13311.66720831987, 13403.798943015667, 11221.158413119212, 11651.485306910048, 11705.122115841516, 11806.940965295118, 12328.753424931272, 11009.412787994655, 11312.660620181408, 11366.943165284121, 11565.768684626428, 12138.089643276613, 11561.0, 11876.703082423008, 11885.16803823724, 11973.042156627624, 12070.155089144027, 8375.246227839523, 8406.159384061544, 8463.830723385621, 8662.0, 8743.91256087431, 9522.714318570454, 11367.488463019019, 11418.257813242113, 11421.828672569753, 11636.650900473], "value": 8882.607891708058, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.2104558310596, 1407.528477959883, 1469.2653673163416, 1548.8606025457707, 1729.7751292331996, 7279.963600181998, 7822.061352637685, 7973.362131029511, 8009.519428834274, 8273.420860539749, 8093.67625294989, 8152.266296033371, 8152.388570857194, 8156.143604921487, 8158.224968627986, 2285.0745448093467, 2307.861528308307, 2310.6418505131733, 2315.780000899912, 2316.8030717388956, 2293.1515339324474, 2326.3951372643064, 2326.7905888470036, 2333.7666233376613, 2347.072906202049, 2237.2281562860785, 2242.069541140425, 2256.9774302256933, 2276.5560715660454, 2280.464090938628, 2183.355910006536, 2221.3447033125185, 2230.2194232018746, 2240.6526988316837, 2245.494763678176, 2261.2876943762662, 2269.0583407885706, 2276.84062115652, 2277.202978957368, 2285.931422057341, 8055.718049868285, 8061.556614386206, 8105.392095592854, 8122.756317310431, 8126.268635822746, 5131.53816156544, 5288.92066619001, 5316.627836051478, 5318.30861987943, 5319.9202011969855, 3214.1161180675267, 3264.314493956272, 3317.950230746541, 3339.0650617827046, 3344.3144155448076, 1010.0656892374524, 1024.5748014573942, 1038.5015192707542, 1048.7745134796055, 1059.6662051453768, 11397.259178153394, 11407.600733974272, 11510.654680359603, 11511.366874821797, 11521.07831373488, 4327.17783621111, 4445.133199026223, 4551.089782043538, 4573.794179261941, 4601.332806743004, 9056.501892395981, 9057.501837398875, 9061.456312621263, 9067.773305667279, 9215.49314787693, 5223.686578805284, 5235.188545775411, 5244.423113457517, 5244.947550524522, 5256.421793602701, 4091.263572556909, 4257.297545904953, 4293.119910418357, 4345.174416860849, 4870.05034018363, 3572.0, 3632.164602141522, 3705.9073523162137, 3727.7204209684382, 3757.1546402059867, 1157.2535714464123, 1158.0561842098662, 1162.7325715085578, 1169.4386694386571, 1184.6979020349927, 972.6595691507915, 986.5659109991581, 987.0, 999.980000399988, 1003.2525768302661, 5568.164775283659, 5741.425857414309, 5823.155642431823, 5871.882562348729, 5923.170756094064, 441.4525987775136, 442.287916454508, 447.9014616784302, 453.95006549279555, 457.6087445234343, 4143.254214241405, 4145.233131870614, 4156.501219853576, 4161.52142503616, 4195.727277726938, 9886.901130988743, 10348.068673819393, 10365.740856478498, 10425.0, 10426.165906727443, 10267.281290309757, 10285.0, 10344.844827327446, 10368.896311036944, 10369.844452333222, 7503.7748867534065, 7822.921770782333, 7823.726169584037, 7966.322862556632, 7976.960115199387, 5671.971640141773, 5790.768369265183, 5816.912746308724, 5878.559108066826, 5886.381929897299, 9600.615975360908, 9620.615175393186, 9641.42151470914, 9648.421094734338, 9746.853797192905, 8649.91350086491, 8937.955310223408, 9568.808623827623, 9704.272179586418, 9714.222862171151, 7180.928190718026, 7366.889496657447, 7381.077365329334, 7444.478886477895, 7532.661030253761, 8137.389695772959, 8224.917750822655, 8270.917290827014, 8284.50292982423, 8313.293370063371, 7064.152301723826, 7095.9645201773665, 7104.715811367488, 7131.465140114616, 7333.120025596749, 7006.684699188447, 7042.295770422917, 7120.465965052538, 7135.750248741269, 7164.928350716635, 6425.839354016187, 6472.449841763503, 6482.060101285381, 6516.380943810331, 6537.673116344259, 4732.503087175797, 4917.164082106122, 4931.841017360989, 4959.70241785494, 5073.0, 4771.76141192932, 4779.545943135397, 4781.135357210621, 4786.569208771228, 4859.538343857328], "value": 4337.4235124904935, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.77775446064993, 323.70057696630613, 330.73541167066355, 332.7703884319819, 336.9915752106199, 5049.166887463564, 5179.213171455846, 5215.530602245797, 5223.634345595805, 5267.762950667219, 5032.572231360339, 5119.846404607859, 5146.228065790134, 5201.843944681666, 5246.868828279295, 4099.590040995891, 4108.732932359387, 4109.773962432065, 4135.669146468283, 4142.730722503027, 3970.027343300895, 4069.9796501017454, 4092.401325158516, 4112.97943510282, 4126.195391898581, 4050.372192310182, 4050.574689657588, 4065.349544072949, 4072.1855628874196, 4080.5924504542313, 4016.819243134066, 4031.153457773871, 4051.736637118607, 4062.7968601569805, 4062.8217816833085, 3440.397930362177, 3564.6791788739138, 3568.678818906311, 3574.928501429983, 3586.1393265616325, 5024.773885175176, 5029.4216165141115, 5037.11850426174, 5053.418856831475, 5070.0620385228485, 4602.171609110359, 4614.284785858197, 4619.653525985531, 4620.491745907947, 4621.237495813187, 5313.654612450178, 5360.9463905360835, 5371.274877891474, 5425.159100339453, 5475.0, 3899.5905429930017, 3904.531456225271, 3907.6873850091924, 3911.726179167431, 3924.4113382992496, 5619.971900140473, 5628.04323265046, 5658.773649054033, 5667.631603945731, 5680.943190568083, 3838.5201849768778, 3943.3690609502914, 3953.8418463261723, 3962.385830196324, 3965.266425711253, 3954.8615798446917, 3955.723099383073, 3969.4045893115685, 3970.940435893464, 3991.560928297885, 4533.300012495314, 4544.590986811203, 4545.477270113979, 4548.681592288574, 4553.271476563734, 5314.92027619586, 5415.458454154553, 5445.482679145475, 5459.099248623933, 5460.754266058037, 1367.3026756354332, 1386.1336664584635, 1398.5804258722342, 1400.5238219005382, 1401.1172961034688, 866.9783255418539, 881.2333270055093, 893.9642414303355, 899.132337294514, 907.2243232036645, 4673.415823022122, 4684.320773487893, 4685.430380822462, 4701.059788042405, 4706.458512403332, 4849.709017458964, 4859.222524396079, 4875.341828853059, 4909.502601706514, 4918.286848406961, 4478.298246666246, 4681.812727490862, 4683.976580117146, 4684.976575117171, 4692.991006933526, 2592.8980183421972, 2616.4636249569176, 2623.2917112379932, 2641.300055485298, 2647.8014148938523, 5074.441811400743, 5118.692878427232, 5121.743912804345, 5160.638755287169, 5167.966406718671, 4818.229083346648, 4996.250562415594, 5020.272060551272, 5068.493150684976, 5093.312402825645, 4988.650794444354, 5017.745563609171, 5063.759378952181, 5064.164412871834, 5099.342713618089, 4855.927161092657, 4885.706857588556, 4928.876778080433, 4953.801847926043, 4980.228064649985, 4854.927176092291, 4900.779464924159, 4902.656814022984, 5108.872278193075, 5442.972785136049, 5773.393793651606, 5774.39368866263, 5783.884322313615, 5795.7391917362975, 5801.9709901451915, 3756.5116534850295, 3873.4964454620717, 3899.220155968761, 3983.2630963271886, 3983.8605648802154, 5452.427495113115, 5538.972305138448, 5540.7783688652, 5550.500454959073, 5563.276774019351, 5324.547413469743, 5327.9200811987075, 5381.246625472359, 5384.165454354581, 5389.8113566025, 5234.18870075139, 5265.447128051499, 5329.57363410934, 5345.9465405345445, 5370.731463426891, 5279.577633789365, 5310.362756469249, 5348.251244825806, 5359.812406565751, 5369.248305237192, 5225.686458812484, 5335.306410166809, 5359.812406565751, 5372.677639341652, 5377.919331210113, 5306.151015837448, 5315.51165673612, 5316.415194328543, 5320.494553017457, 5320.574354051744], "value": 4016.3270295809666, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.2198581560281, 730.9817254568636, 745.1691364128994, 783.5729527407563, 826.7726375246805, 14441.205733684643, 15142.394304227817, 15150.772738408932, 15151.92424037881, 15362.385504579817, 12066.095042871797, 12177.0, 12189.20770149942, 12190.81713774294, 12214.75570488592, 645.4771634975662, 662.2913482573648, 773.1842905734447, 786.799366161628, 797.2864286463612, 771.0516065239758, 782.4679218131669, 783.2950344689797, 783.3224261014238, 783.725696006399, 839.1817977471977, 841.6843683618642, 843.2874221283037, 843.6625349860075, 843.9409241353108, 687.1239170058216, 709.6700034483938, 821.7699044267615, 838.6854929401505, 842.4987132656059, 614.1708693264102, 616.7995401494487, 617.0405020193597, 617.1668247865391, 617.3301967365414, 12472.937635311766, 12509.562165324262, 12516.81224781629, 12521.12352135351, 12521.74956500874, 12277.754444911052, 12349.93825030869, 12657.0, 12769.170003949714, 13143.934280328633, 12255.571055013032, 12444.564440244638, 12494.187877788005, 12642.431090600945, 13159.802602960963, 4293.806778694966, 4297.4413326267695, 4326.610605045529, 4529.977350113261, 4531.909361812778, 63170.368296316905, 63507.6824615874, 65502.67248663726, 66078.33921660818, 67250.66374668144, 9959.950200248952, 10022.548985295532, 10488.05607495329, 10701.571937122584, 10823.83764243537, 19024.524386890163, 19158.425247242605, 19372.903135484234, 19378.674559053004, 19382.8061719381, 7429.665665045086, 7483.812904677317, 7485.401167906554, 7701.6534255957495, 7758.185390534026, 4332.610065094157, 4352.499462561846, 4371.650267978554, 4402.141582391467, 4430.867073987721, 3302.455094909361, 3477.791332520057, 3486.4770284457536, 3522.489239060322, 3524.1718196223865, 636.961782293064, 654.3718030690591, 658.1049772309655, 659.8977158540434, 666.9133012708317, 602.5691630484225, 613.5735663713676, 657.2146285189153, 671.1576970901585, 681.417388133149, 8591.914080859236, 9443.622255109718, 9625.79594107306, 9789.608415663437, 10046.949765251127, 715.1882613234017, 716.4554938246865, 718.3714250031222, 734.1447213995742, 740.4631642059571, 4393.29707246839, 4432.556744325541, 4733.5503127202865, 4755.595774359218, 4830.797703505463, 85410.14589854021, 85823.0, 86763.0, 86784.0, 88352.55823720968, 73361.26638733651, 74682.0, 75426.24573754192, 76607.0, 77298.0, 63884.68057659682, 68391.31608684048, 69010.65494672494, 69999.65000174966, 71228.64385678039, 8586.871196931927, 8897.555122243732, 8946.955265223633, 9053.818923621622, 9345.766355841159, 45792.31311530263, 46760.53239467562, 46894.53105468902, 47332.0, 48887.02225955532, 56419.0, 58653.413465864796, 62268.68865655643, 62391.0, 63154.36845631485, 11340.546378145113, 11429.657110286706, 11443.656690299304, 12500.0, 12512.562060327844, 13863.653408664864, 14008.43966241339, 14017.929910350791, 14019.088759230617, 14383.208923509308, 13309.600711978268, 13322.866771332163, 13386.26375549354, 13571.79642305386, 13677.31613419345, 12450.81323780126, 12487.31319777421, 12492.125551211691, 13330.333483325989, 13472.0, 11437.656870293904, 11802.645920622395, 12092.334921579397, 12659.493620255087, 12670.556530521388, 10537.315074520131, 10801.0, 10815.513301901276, 11158.49786759614, 11311.377874216998, 9132.22376098039, 9298.72103836886, 9822.361546499455, 10734.141268698642, 10881.401522916316], "value": 6989.178151826962, "unit": "score"}], "name": "dromaeo_css", "value": 6935.103703771254, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 112.0, 111.0, 112.0, 111.0, 111.0, 111.0, 111.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 124.0, 123.0, 163.0, 125.0, 126.0, 123.0, 123.0, 166.0, 124.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 163.0, 162.0, 160.0, 160.0, 161.0, 162.0, 162.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 117.0, 76.0, 75.0, 75.0, 74.0, 98.0, 73.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 114.0, 83.0, 82.0, 82.0, 106.0, 82.0, 83.0, 109.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 53.0, 53.0, 56.0, 53.0, 55.0, 53.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 60.0, 60.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 86.0, 78.0, 78.0, 79.0, 87.0, 79.0, 90.0, 85.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 129.0, 133.0, 133.0, 131.0, 132.0, 136.0, 127.0, 174.0, 131.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 169.0, 164.0, 164.0, 167.0, 165.0, 165.0, 169.0, 168.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 66.0, 64.0, 65.0, 64.0, 63.0, 64.0, 62.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1488.9, "alertThreshold": 2.0}]} 00:44:36 INFO - Return code: 0 00:44:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:44:36 INFO - # TBPL SUCCESS # 00:44:36 INFO - Running post-action listener: _resource_record_post_action 00:44:36 INFO - [mozharness: 2016-10-28 07:44:36.339891Z] Finished run-tests step (success) 00:44:36 INFO - Running post-run listener: _resource_record_post_run 00:44:36 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 397086720; Read time: 12; Write time: 359212 00:44:36 INFO - TinderboxPrint: CPU usage
13.1% 00:44:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 00:44:36 INFO - TinderboxPrint: I/O write bytes / time
397,086,720 / 359,212 00:44:36 INFO - TinderboxPrint: CPU idle
8,296.4 (86.9%) 00:44:36 INFO - TinderboxPrint: CPU user
1,204.9 (12.6%) 00:44:36 INFO - TinderboxPrint: Swap in / out
0 / 0 00:44:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109944832; Read time: 0; Write time: 98456 00:44:36 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287141888; Read time: 0; Write time: 260756 00:44:36 INFO - Running post-run listener: _upload_blobber_files 00:44:36 INFO - Blob upload gear active. 00:44:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:44:36 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 00:44:36 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:44:36 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:44:37 INFO - (blobuploader) - INFO - Open directory for files ... 00:44:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:44:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:44:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:44:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:44:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:44:42 INFO - (blobuploader) - INFO - Done attempting. 00:44:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:44:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:44:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:44:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:44:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:44:42 INFO - (blobuploader) - INFO - Done attempting. 00:44:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:44:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:44:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:44:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:44:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:44:43 INFO - (blobuploader) - INFO - Done attempting. 00:44:43 INFO - (blobuploader) - INFO - Iteration through files over. 00:44:43 INFO - Return code: 0 00:44:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:44:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:44:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fda2aef593c8bbe7349739a3a0bb41b46603170e60ab1fa4f611f80ece9af94daf77b7edd7dfde27085df34d25b4eb9d8932f43f90d4c7f929676c1ff517986e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e05304ce329857db0fbda63b18dbab079a68a99834b9da73735559a4fb4f20d9beffb5e1d28564d6c4da13a8e5d1c75feba63e24f7f85fdeb50182e74469201", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfadbb908af90f8efa4d0f5c617b149e0595071677a58d4f852abec28db099aa24c14ce35f637c9f49881672e331dfc238bd13e27dbafd4924de953febd50983"} 00:44:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:44:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:44:43 INFO - Contents: 00:44:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fda2aef593c8bbe7349739a3a0bb41b46603170e60ab1fa4f611f80ece9af94daf77b7edd7dfde27085df34d25b4eb9d8932f43f90d4c7f929676c1ff517986e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e05304ce329857db0fbda63b18dbab079a68a99834b9da73735559a4fb4f20d9beffb5e1d28564d6c4da13a8e5d1c75feba63e24f7f85fdeb50182e74469201", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfadbb908af90f8efa4d0f5c617b149e0595071677a58d4f852abec28db099aa24c14ce35f637c9f49881672e331dfc238bd13e27dbafd4924de953febd50983"} 00:44:43 INFO - Running post-run listener: copy_logs_to_upload_dir 00:44:43 INFO - Copying logs to upload dir... 00:44:43 INFO - mkdir: /builds/slave/test/build/upload/logs 00:44:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.347327 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-28 00:44:43.414387) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 00:44:43.417795) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fda2aef593c8bbe7349739a3a0bb41b46603170e60ab1fa4f611f80ece9af94daf77b7edd7dfde27085df34d25b4eb9d8932f43f90d4c7f929676c1ff517986e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e05304ce329857db0fbda63b18dbab079a68a99834b9da73735559a4fb4f20d9beffb5e1d28564d6c4da13a8e5d1c75feba63e24f7f85fdeb50182e74469201", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfadbb908af90f8efa4d0f5c617b149e0595071677a58d4f852abec28db099aa24c14ce35f637c9f49881672e331dfc238bd13e27dbafd4924de953febd50983"} build_url:https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/ZSyBev_OR_-NqR2rJpFqjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fda2aef593c8bbe7349739a3a0bb41b46603170e60ab1fa4f611f80ece9af94daf77b7edd7dfde27085df34d25b4eb9d8932f43f90d4c7f929676c1ff517986e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e05304ce329857db0fbda63b18dbab079a68a99834b9da73735559a4fb4f20d9beffb5e1d28564d6c4da13a8e5d1c75feba63e24f7f85fdeb50182e74469201", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfadbb908af90f8efa4d0f5c617b149e0595071677a58d4f852abec28db099aa24c14ce35f637c9f49881672e331dfc238bd13e27dbafd4924de953febd50983"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 00:44:43.481039) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 00:44:43.481381) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1477639439.385639-1854774111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 00:44:43.498163) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 00:44:43.498457) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 00:44:43.498726) ========= ========= Total master_lag: 0.14 =========