builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1484853489.59 results: success (0) buildid: 20170119093328 builduid: 65f180527c6f468bab3197b15be83366 revision: cd4fc47221cb3c5333f0b23fcb1dac38c8c2b35d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 11:18:09.594632) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 11:18:09.595086) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 11:18:09.595381) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 11:18:09.609985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:18:09.610338) ========= 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=db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-19 11:18:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.1M=0s 2017-01-19 11:18:10 (88.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113673 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:18:09.738006) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:18:09.738335) ========= 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=db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016723 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:18:09.787392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:18:09.787768) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cd4fc47221cb3c5333f0b23fcb1dac38c8c2b35d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cd4fc47221cb3c5333f0b23fcb1dac38c8c2b35d --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=db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-19 11:18:10,371 truncating revision to first 12 chars 2017-01-19 11:18:10,371 Setting DEBUG logging. 2017-01-19 11:18:10,371 attempt 1/10 2017-01-19 11:18:10,371 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cd4fc47221cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-19 11:18:10,696 unpacking tar archive at: mozilla-aurora-cd4fc47221cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.696999 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:18:10.498108) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 11:18:10.498438) ========= script_repo_revision: cd4fc47221cb3c5333f0b23fcb1dac38c8c2b35d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 11:18:10.498868) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 11:18:10.499143) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 11:18:10.507958) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-01-19 11:18:10.508235) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:18:11 INFO - MultiFileLogger online at 20170119 11:18:11 in /builds/slave/test 11:18:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:18:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:18:11 INFO - {'append_to_log': False, 11:18:11 INFO - 'base_work_dir': '/builds/slave/test', 11:18:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:18:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:18:11 INFO - 'branch': 'Mozilla-Aurora', 11:18:11 INFO - 'buildbot_json_path': 'buildprops.json', 11:18:11 INFO - 'config_files': ('talos/linux_config.py',), 11:18:11 INFO - 'default_actions': ('clobber', 11:18:11 INFO - 'read-buildbot-config', 11:18:11 INFO - 'download-and-extract', 11:18:11 INFO - 'populate-webroot', 11:18:11 INFO - 'create-virtualenv', 11:18:11 INFO - 'install', 11:18:11 INFO - 'run-tests'), 11:18:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:18:11 INFO - 'download_minidump_stackwalk': True, 11:18:11 INFO - 'download_symbols': 'ondemand', 11:18:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:18:11 INFO - 'tooltool.py': '/tools/tooltool.py', 11:18:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:18:11 INFO - '/tools/misc-python/virtualenv.py')}, 11:18:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:18:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:18:11 INFO - 'installer_path': 'installer.exe', 11:18:11 INFO - 'log_level': 'info', 11:18:11 INFO - 'log_name': 'talos', 11:18:11 INFO - 'log_to_console': True, 11:18:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:18:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:18:11 INFO - 'opt_config_files': (), 11:18:11 INFO - 'pip_index': False, 11:18:11 INFO - 'sps_profile': False, 11:18:11 INFO - 'sps_profile_interval': 0, 11:18:11 INFO - 'suite': 'dromaeojs', 11:18:11 INFO - 'system_bits': '32', 11:18:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:18:11 INFO - 'title': 'talos-linux64-ix-031', 11:18:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:18:11 INFO - 'use_talos_json': True, 11:18:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:18:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:18:11 INFO - 'work_dir': 'build'} 11:18:11 INFO - [mozharness: 2017-01-19 19:18:11.186146Z] Running clobber step. 11:18:11 INFO - Running pre-action listener: _resource_record_pre_action 11:18:11 INFO - Running main action method: clobber 11:18:11 INFO - rmtree: /builds/slave/test/build 11:18:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:18:12 INFO - Running post-action listener: _resource_record_post_action 11:18:12 INFO - [mozharness: 2017-01-19 19:18:12.152720Z] Finished clobber step (success) 11:18:12 INFO - [mozharness: 2017-01-19 19:18:12.152818Z] Running read-buildbot-config step. 11:18:12 INFO - Running pre-action listener: _resource_record_pre_action 11:18:12 INFO - Running main action method: read_buildbot_config 11:18:12 INFO - Using buildbot properties: 11:18:12 INFO - { 11:18:12 INFO - "project": "", 11:18:12 INFO - "product": "firefox", 11:18:12 INFO - "script_repo_revision": "production", 11:18:12 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:18:12 INFO - "repository": "", 11:18:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:18:12 INFO - "buildid": "20170119093328", 11:18:12 INFO - "pgo_build": "True", 11:18:12 INFO - "basedir": "/builds/slave/test", 11:18:12 INFO - "buildnumber": 1015, 11:18:12 INFO - "slavename": "talos-linux64-ix-031", 11:18:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:18:12 INFO - "platform": "ubuntu64_hw", 11:18:12 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:18:12 INFO - "branch": "mozilla-aurora", 11:18:12 INFO - "repo_path": "releases/mozilla-aurora", 11:18:12 INFO - "revision": "cd4fc47221cb3c5333f0b23fcb1dac38c8c2b35d", 11:18:12 INFO - "stage_platform": "linux64-pgo", 11:18:12 INFO - "builduid": "65f180527c6f468bab3197b15be83366", 11:18:12 INFO - "slavebuilddir": "test" 11:18:12 INFO - } 11:18:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 11:18:12 INFO - Running post-action listener: _resource_record_post_action 11:18:12 INFO - [mozharness: 2017-01-19 19:18:12.155245Z] Finished read-buildbot-config step (success) 11:18:12 INFO - [mozharness: 2017-01-19 19:18:12.155332Z] Running download-and-extract step. 11:18:12 INFO - Running pre-action listener: _resource_record_pre_action 11:18:12 INFO - Running main action method: download_and_extract 11:18:12 INFO - mkdir: /builds/slave/test/build/tests 11:18:12 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')]} 11:18:12 INFO - trying https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:18:12 INFO - Downloading https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:18:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:18:12 INFO - Downloaded 1361 bytes. 11:18:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:18:12 INFO - Using the following test package requirements: 11:18:12 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:18:12 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:18:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:18:12 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:18:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:18:12 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:18:12 INFO - u'jsshell-linux-x86_64.zip'], 11:18:12 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:18:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:18:12 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:18:12 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:18:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:18:12 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:18:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:18:12 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:18:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:18:12 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:18:12 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:18:12 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:18:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:18:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:18:12 INFO - Fetch https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:18:13 INFO - Http code: 200 11:18:13 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 11:18:13 INFO - x-amz-cf-id: 34E9u0u_bqLa_WiXf4CfMnI4QHSP9o-MgEvNjZbPw5tFLJzDyXYouQ== 11:18:13 INFO - x-amz-version-id: aYOhtqWL7xSWU0.qA0dzVqYFBKvqPmYM 11:18:14 INFO - Expected file size: 21949518 11:18:14 INFO - Obtained file size: 21949518 11:18:18 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:18:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:18:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:18:18 INFO - Fetch https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:18:19 INFO - Http code: 200 11:18:19 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 11:18:19 INFO - x-amz-cf-id: KUF1W1lPoGA-9460FAvaOUfW1TdDeyrxaKJDeXV4moIr6CggP7sb_Q== 11:18:19 INFO - x-amz-version-id: aYOhtqWL7xSWU0.qA0dzVqYFBKvqPmYM 11:18:21 INFO - Expected file size: 21949518 11:18:21 INFO - Obtained file size: 21949518 11:18:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 11:18:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:18:25 INFO - Fetch https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 11:18:26 INFO - Http code: 200 11:18:26 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 11:18:26 INFO - x-amz-cf-id: x3U04iflqXrfRunCh1Zod2xo_BHtijg1uQuhDLMpCYPgAEQwEe7jRQ== 11:18:26 INFO - x-amz-version-id: rHZkZNZb.QolsLUmtfi6DxQe1F8Bl0L5 11:18:27 INFO - Expected file size: 14409038 11:18:27 INFO - Obtained file size: 14409038 11:18: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')]} 11:18:27 INFO - trying https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:18:27 INFO - Downloading https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:18:32 INFO - Downloaded 64184420 bytes. 11:18:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:18:32 INFO - mkdir: /builds/slave/test/properties 11:18:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:18:32 INFO - Writing to file /builds/slave/test/properties/build_url 11:18:32 INFO - Contents: 11:18:32 INFO - build_url:https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:18:33 INFO - Running post-action listener: _resource_record_post_action 11:18:33 INFO - Running post-action listener: set_extra_try_arguments 11:18:33 INFO - [mozharness: 2017-01-19 19:18:33.149684Z] Finished download-and-extract step (success) 11:18:33 INFO - [mozharness: 2017-01-19 19:18:33.149911Z] Running populate-webroot step. 11:18:33 INFO - Running pre-action listener: _resource_record_pre_action 11:18:33 INFO - Running main action method: populate_webroot 11:18:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:18:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:18:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:18:33 INFO - '--tppagecycles', 11:18:33 INFO - '7'], 11:18:33 INFO - 'tests': ['tsvgm']}}, 11:18:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:18:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:18:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:18:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:18:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:33 INFO - 'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:33 INFO - 'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['damp', 'tps']}, 11:18:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:33 INFO - 'tests': ['damp', 'tps']}, 11:18:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['dromaeo_dom']}, 11:18:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:18:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['basic_compositor_video']}, 11:18:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:18:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['a11yr', 11:18:33 INFO - 'ts_paint', 11:18:33 INFO - 'tpaint', 11:18:33 INFO - 'sessionrestore', 11:18:33 INFO - 'sessionrestore_no_auto_restore', 11:18:33 INFO - 'tabpaint']}, 11:18:33 INFO - 'other-e10s': {'tests': ['a11yr', 11:18:33 INFO - 'ts_paint', 11:18:33 INFO - 'tpaint', 11:18:33 INFO - 'sessionrestore', 11:18:33 INFO - 'sessionrestore_no_auto_restore', 11:18:33 INFO - 'tabpaint']}, 11:18:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:18:33 INFO - 'ts_paint', 11:18:33 INFO - 'tpaint', 11:18:33 INFO - 'sessionrestore', 11:18:33 INFO - 'sessionrestore_no_auto_restore', 11:18:33 INFO - 'tabpaint']}, 11:18:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:18:33 INFO - 'ts_paint', 11:18:33 INFO - 'tpaint', 11:18:33 INFO - 'sessionrestore', 11:18:33 INFO - 'sessionrestore_no_auto_restore', 11:18:33 INFO - 'tabpaint']}, 11:18:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['a11yr', 11:18:33 INFO - 'ts_paint', 11:18:33 INFO - 'tpaint', 11:18:33 INFO - 'sessionrestore', 11:18:33 INFO - 'sessionrestore_no_auto_restore', 11:18:33 INFO - 'tabpaint']}, 11:18:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['a11yr', 11:18:33 INFO - 'ts_paint', 11:18:33 INFO - 'tpaint', 11:18:33 INFO - 'sessionrestore', 11:18:33 INFO - 'sessionrestore_no_auto_restore', 11:18:33 INFO - 'tabpaint']}, 11:18:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['tsvgx', 11:18:33 INFO - 'tsvgr_opacity', 11:18:33 INFO - 'tart', 11:18:33 INFO - 'tscrollx', 11:18:33 INFO - 'cart']}, 11:18:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:18:33 INFO - 'tsvgr_opacity', 11:18:33 INFO - 'tart', 11:18:33 INFO - 'tscrollx', 11:18:33 INFO - 'cart']}, 11:18:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:33 INFO - 'talos_options': ['--disable-e10s'], 11:18:33 INFO - 'tests': ['tp5o']}, 11:18:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:33 INFO - 'tests': ['tp5o']}, 11:18:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:33 INFO - 'talos_options': ['--disable-e10s', 11:18:33 INFO - '--xperf_path', 11:18:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:33 INFO - 'tests': ['tp5n']}, 11:18:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:33 INFO - 'talos_options': ['--xperf_path', 11:18:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:33 INFO - 'tests': ['tp5n']}}, 11:18:33 INFO - 'talos.zip': {'path': '', 11:18:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:18:33 INFO - Running post-action listener: _resource_record_post_action 11:18:33 INFO - [mozharness: 2017-01-19 19:18:33.165401Z] Finished populate-webroot step (success) 11:18:33 INFO - [mozharness: 2017-01-19 19:18:33.165502Z] Running create-virtualenv step. 11:18:33 INFO - Running pre-action listener: _resource_record_pre_action 11:18:33 INFO - Running main action method: create_virtualenv 11:18:33 INFO - Creating virtualenv /builds/slave/test/build/venv 11:18:33 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 11:18:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:18:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:18:33 INFO - Using real prefix '/usr' 11:18:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:18:33 INFO - Installing distribute.............................................................................................................................................................................................done. 11:18:35 INFO - Installing pip.................done. 11:18:35 INFO - Return code: 0 11:18:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:18:35 INFO - Reading from file tmpfile_stdout 11:18:35 INFO - Output received: 11:18:35 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) 11:18:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:35 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 0x7f9fab00af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cf60>, '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 0x1f2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', '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 11:18:35 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 11:18:35 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 11:18:35 INFO - Using env: {'DISPLAY': ':0', 11:18:35 INFO - 'HOME': '/home/cltbld', 11:18:35 INFO - 'LANG': 'en_US.UTF-8', 11:18:35 INFO - 'LANGUAGE': 'en_US:en', 11:18:35 INFO - 'LOGNAME': 'cltbld', 11:18:35 INFO - 'MAIL': '/var/mail/cltbld', 11:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:35 INFO - 'MOZ_NO_REMOTE': '1', 11:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:35 INFO - 'NO_EM_RESTART': '1', 11:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:35 INFO - 'PWD': '/builds/slave/test', 11:18:35 INFO - 'SHELL': '/bin/bash', 11:18:35 INFO - 'SHLVL': '1', 11:18:35 INFO - 'TERM': 'linux', 11:18:35 INFO - 'TMOUT': '86400', 11:18:35 INFO - 'USER': 'cltbld', 11:18:35 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', 11:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:35 INFO - '_': '/tools/buildbot/bin/python'} 11:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:36 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 11:18:36 INFO - Cleaning up... 11:18:36 INFO - Return code: 0 11:18:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:18:36 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')]} 11:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:36 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')]} 11:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:36 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 0x7f9fab00af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cf60>, '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 0x1f2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', '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 11:18:36 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 11:18:36 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 11:18:36 INFO - Using env: {'DISPLAY': ':0', 11:18:36 INFO - 'HOME': '/home/cltbld', 11:18:36 INFO - 'LANG': 'en_US.UTF-8', 11:18:36 INFO - 'LANGUAGE': 'en_US:en', 11:18:36 INFO - 'LOGNAME': 'cltbld', 11:18:36 INFO - 'MAIL': '/var/mail/cltbld', 11:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:36 INFO - 'MOZ_NO_REMOTE': '1', 11:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:36 INFO - 'NO_EM_RESTART': '1', 11:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:36 INFO - 'PWD': '/builds/slave/test', 11:18:36 INFO - 'SHELL': '/bin/bash', 11:18:36 INFO - 'SHLVL': '1', 11:18:36 INFO - 'TERM': 'linux', 11:18:36 INFO - 'TMOUT': '86400', 11:18:36 INFO - 'USER': 'cltbld', 11:18:36 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', 11:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:36 INFO - '_': '/tools/buildbot/bin/python'} 11:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:36 INFO - Downloading/unpacking psutil>=3.1.1 11:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:18:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:38 INFO - Installing collected packages: psutil 11:18:38 INFO - Running setup.py install for psutil 11:18:38 INFO - building 'psutil._psutil_linux' extension 11:18:38 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 11:18:38 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 11:18:38 INFO - building 'psutil._psutil_posix' extension 11:18:38 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 11:18:38 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 11:18:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:39 INFO - Successfully installed psutil 11:18:39 INFO - Cleaning up... 11:18:39 INFO - Return code: 0 11:18:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:18:39 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')]} 11:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:39 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')]} 11:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:39 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 0x7f9fab00af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cf60>, '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 0x1f2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', '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 11:18:39 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 11:18:39 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 11:18:39 INFO - Using env: {'DISPLAY': ':0', 11:18:39 INFO - 'HOME': '/home/cltbld', 11:18:39 INFO - 'LANG': 'en_US.UTF-8', 11:18:39 INFO - 'LANGUAGE': 'en_US:en', 11:18:39 INFO - 'LOGNAME': 'cltbld', 11:18:39 INFO - 'MAIL': '/var/mail/cltbld', 11:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:39 INFO - 'MOZ_NO_REMOTE': '1', 11:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:39 INFO - 'NO_EM_RESTART': '1', 11:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:39 INFO - 'PWD': '/builds/slave/test', 11:18:39 INFO - 'SHELL': '/bin/bash', 11:18:39 INFO - 'SHLVL': '1', 11:18:39 INFO - 'TERM': 'linux', 11:18:39 INFO - 'TMOUT': '86400', 11:18:39 INFO - 'USER': 'cltbld', 11:18:39 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', 11:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:39 INFO - '_': '/tools/buildbot/bin/python'} 11:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:18:41 INFO - Installing collected packages: mozsystemmonitor 11:18:41 INFO - Running setup.py install for mozsystemmonitor 11:18:41 INFO - Successfully installed mozsystemmonitor 11:18:41 INFO - Cleaning up... 11:18:41 INFO - Return code: 0 11:18:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:41 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 0x7f9fab00af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cf60>, '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 0x1f2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', '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 11:18:41 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 11:18:41 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 11:18:41 INFO - Using env: {'DISPLAY': ':0', 11:18:41 INFO - 'HOME': '/home/cltbld', 11:18:41 INFO - 'LANG': 'en_US.UTF-8', 11:18:41 INFO - 'LANGUAGE': 'en_US:en', 11:18:41 INFO - 'LOGNAME': 'cltbld', 11:18:41 INFO - 'MAIL': '/var/mail/cltbld', 11:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:41 INFO - 'MOZ_NO_REMOTE': '1', 11:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:41 INFO - 'NO_EM_RESTART': '1', 11:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:41 INFO - 'PWD': '/builds/slave/test', 11:18:41 INFO - 'SHELL': '/bin/bash', 11:18:41 INFO - 'SHLVL': '1', 11:18:41 INFO - 'TERM': 'linux', 11:18:41 INFO - 'TMOUT': '86400', 11:18:41 INFO - 'USER': 'cltbld', 11:18:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', 11:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:41 INFO - '_': '/tools/buildbot/bin/python'} 11:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:41 INFO - Downloading/unpacking jsonschema==2.5.1 11:18:41 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 11:18:41 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 11:18:41 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 11:18:41 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 11:18:41 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 11:18:41 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 11:18:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:18:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:18:43 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 11:18:43 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 11:18:43 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 11:18:43 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 11:18:43 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 11:18:43 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 11:18:43 INFO - Downloading functools32-3.2.3-2.tar.gz 11:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:18:44 INFO - warning: no files found matching '*.txt' 11:18:44 INFO - no previously-included directories found matching 'build' 11:18:44 INFO - no previously-included directories found matching 'dist' 11:18:44 INFO - no previously-included directories found matching '.git*' 11:18:44 INFO - Installing collected packages: jsonschema, functools32 11:18:44 INFO - Running setup.py install for functools32 11:18:44 INFO - warning: no files found matching '*.txt' 11:18:44 INFO - no previously-included directories found matching 'build' 11:18:44 INFO - no previously-included directories found matching 'dist' 11:18:44 INFO - no previously-included directories found matching '.git*' 11:18:44 INFO - Successfully installed jsonschema functools32 11:18:44 INFO - Cleaning up... 11:18:44 INFO - Return code: 0 11:18:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:44 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 0x7f9fab00af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cf60>, '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 0x1f2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', '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 11:18:44 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 11:18:44 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 11:18:44 INFO - Using env: {'DISPLAY': ':0', 11:18:44 INFO - 'HOME': '/home/cltbld', 11:18:44 INFO - 'LANG': 'en_US.UTF-8', 11:18:44 INFO - 'LANGUAGE': 'en_US:en', 11:18:44 INFO - 'LOGNAME': 'cltbld', 11:18:44 INFO - 'MAIL': '/var/mail/cltbld', 11:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:44 INFO - 'MOZ_NO_REMOTE': '1', 11:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:44 INFO - 'NO_EM_RESTART': '1', 11:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:44 INFO - 'PWD': '/builds/slave/test', 11:18:44 INFO - 'SHELL': '/bin/bash', 11:18:44 INFO - 'SHLVL': '1', 11:18:44 INFO - 'TERM': 'linux', 11:18:44 INFO - 'TMOUT': '86400', 11:18:44 INFO - 'USER': 'cltbld', 11:18:44 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', 11:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:44 INFO - '_': '/tools/buildbot/bin/python'} 11:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:18:44 INFO - Cleaning up... 11:18:44 INFO - Return code: 0 11:18:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:44 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 0x7f9fab00af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cf60>, '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 0x1f2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', '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 11:18:44 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 11:18:44 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 11:18:44 INFO - Using env: {'DISPLAY': ':0', 11:18:44 INFO - 'HOME': '/home/cltbld', 11:18:44 INFO - 'LANG': 'en_US.UTF-8', 11:18:44 INFO - 'LANGUAGE': 'en_US:en', 11:18:44 INFO - 'LOGNAME': 'cltbld', 11:18:44 INFO - 'MAIL': '/var/mail/cltbld', 11:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:44 INFO - 'MOZ_NO_REMOTE': '1', 11:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:44 INFO - 'NO_EM_RESTART': '1', 11:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:44 INFO - 'PWD': '/builds/slave/test', 11:18:44 INFO - 'SHELL': '/bin/bash', 11:18:44 INFO - 'SHLVL': '1', 11:18:44 INFO - 'TERM': 'linux', 11:18:44 INFO - 'TMOUT': '86400', 11:18:44 INFO - 'USER': 'cltbld', 11:18:44 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', 11:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:44 INFO - '_': '/tools/buildbot/bin/python'} 11:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:44 INFO - Downloading/unpacking blobuploader==1.2.4 11:18:44 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 11:18:44 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 11:18:44 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 11:18:44 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 11:18:44 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 11:18:44 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 11:18:46 INFO - Downloading blobuploader-1.2.4.tar.gz 11:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:18:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:18:46 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 11:18:46 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 11:18:46 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 11:18:46 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 11:18:46 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 11:18:46 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 11:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:18:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:18:47 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 11:18:47 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 11:18:47 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 11:18:47 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 11:18:47 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 11:18:47 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 11:18:47 INFO - Downloading docopt-0.6.1.tar.gz 11:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:18:47 INFO - Installing collected packages: blobuploader, requests, docopt 11:18:47 INFO - Running setup.py install for blobuploader 11:18:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:18:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:18:47 INFO - Running setup.py install for requests 11:18:47 INFO - Running setup.py install for docopt 11:18:48 INFO - Successfully installed blobuploader requests docopt 11:18:48 INFO - Cleaning up... 11:18:48 INFO - Return code: 0 11:18:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:48 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 0x7f9fab00af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cf60>, '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 0x1f2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', '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 11:18:48 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 11:18:48 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 11:18:48 INFO - Using env: {'DISPLAY': ':0', 11:18:48 INFO - 'HOME': '/home/cltbld', 11:18:48 INFO - 'LANG': 'en_US.UTF-8', 11:18:48 INFO - 'LANGUAGE': 'en_US:en', 11:18:48 INFO - 'LOGNAME': 'cltbld', 11:18:48 INFO - 'MAIL': '/var/mail/cltbld', 11:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:48 INFO - 'MOZ_NO_REMOTE': '1', 11:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:48 INFO - 'NO_EM_RESTART': '1', 11:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:48 INFO - 'PWD': '/builds/slave/test', 11:18:48 INFO - 'SHELL': '/bin/bash', 11:18:48 INFO - 'SHLVL': '1', 11:18:48 INFO - 'TERM': 'linux', 11:18:48 INFO - 'TMOUT': '86400', 11:18:48 INFO - 'USER': 'cltbld', 11:18:48 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', 11:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:48 INFO - '_': '/tools/buildbot/bin/python'} 11:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:48 INFO - Running setup.py (path:/tmp/pip-9fnPpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:48 INFO - Running setup.py (path:/tmp/pip-OyebUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:48 INFO - Running setup.py (path:/tmp/pip-WvGNs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:48 INFO - Running setup.py (path:/tmp/pip-FHH61H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:48 INFO - Running setup.py (path:/tmp/pip-cvKhV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:48 INFO - Running setup.py (path:/tmp/pip-bF2f2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:48 INFO - Running setup.py (path:/tmp/pip-_tgj2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:48 INFO - Running setup.py (path:/tmp/pip-QWtZhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:48 INFO - Running setup.py (path:/tmp/pip-qKD1GO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:48 INFO - Running setup.py (path:/tmp/pip-kQKLel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:49 INFO - Running setup.py (path:/tmp/pip-SPbF7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:49 INFO - Running setup.py (path:/tmp/pip-nsFHmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:49 INFO - Running setup.py (path:/tmp/pip-dNRWIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:49 INFO - Running setup.py (path:/tmp/pip-nKbzoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:49 INFO - Running setup.py (path:/tmp/pip-1o_Jz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:49 INFO - Running setup.py (path:/tmp/pip-5JQPza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:49 INFO - Running setup.py (path:/tmp/pip-DZS1oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:18:49 INFO - Running setup.py install for manifestparser 11:18:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:18:49 INFO - Running setup.py install for mozcrash 11:18:49 INFO - Running setup.py install for mozdebug 11:18:49 INFO - Running setup.py install for mozdevice 11:18:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:18:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:18:49 INFO - Running setup.py install for mozfile 11:18:50 INFO - Running setup.py install for mozhttpd 11:18:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Running setup.py install for mozinfo 11:18:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Running setup.py install for mozInstall 11:18:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Running setup.py install for mozleak 11:18:50 INFO - Running setup.py install for mozlog 11:18:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Running setup.py install for moznetwork 11:18:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Running setup.py install for mozprocess 11:18:50 INFO - Running setup.py install for mozprofile 11:18:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:18:50 INFO - Running setup.py install for mozrunner 11:18:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:18:51 INFO - Running setup.py install for mozscreenshot 11:18:51 INFO - Running setup.py install for moztest 11:18:51 INFO - Running setup.py install for mozversion 11:18:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:18:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:18:51 INFO - Cleaning up... 11:18:51 INFO - Return code: 0 11:18:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:51 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')]} 11:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:51 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')]} 11:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:51 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 0x7f9fab00af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cf60>, '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 0x1f2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', '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 11:18:51 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 11:18:51 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 11:18:51 INFO - Using env: {'DISPLAY': ':0', 11:18:51 INFO - 'HOME': '/home/cltbld', 11:18:51 INFO - 'LANG': 'en_US.UTF-8', 11:18:51 INFO - 'LANGUAGE': 'en_US:en', 11:18:51 INFO - 'LOGNAME': 'cltbld', 11:18:51 INFO - 'MAIL': '/var/mail/cltbld', 11:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:51 INFO - 'MOZ_NO_REMOTE': '1', 11:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:51 INFO - 'NO_EM_RESTART': '1', 11:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:51 INFO - 'PWD': '/builds/slave/test', 11:18:51 INFO - 'SHELL': '/bin/bash', 11:18:51 INFO - 'SHLVL': '1', 11:18:51 INFO - 'TERM': 'linux', 11:18:51 INFO - 'TMOUT': '86400', 11:18:51 INFO - 'USER': 'cltbld', 11:18:51 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', 11:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:51 INFO - '_': '/tools/buildbot/bin/python'} 11:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:51 INFO - Running setup.py (path:/tmp/pip-H8QwOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:51 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)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:51 INFO - Running setup.py (path:/tmp/pip-a7DLz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:51 INFO - Running setup.py (path:/tmp/pip-PzEENG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:51 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)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:51 INFO - Running setup.py (path:/tmp/pip-VBjHZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:51 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)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:51 INFO - Running setup.py (path:/tmp/pip-qJWku6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:51 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)) 11:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:51 INFO - Running setup.py (path:/tmp/pip-9Nhsgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:52 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)) 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:52 INFO - Running setup.py (path:/tmp/pip-9FAB5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:52 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)) 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:52 INFO - Running setup.py (path:/tmp/pip-j6_4Mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:52 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)) 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:52 INFO - Running setup.py (path:/tmp/pip-4ozbfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:52 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)) 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:52 INFO - Running setup.py (path:/tmp/pip-eXbRa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:52 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)) 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:52 INFO - Running setup.py (path:/tmp/pip-wY4Ypk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:52 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)) 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:52 INFO - Running setup.py (path:/tmp/pip-ER5n3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:52 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)) 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:52 INFO - Running setup.py (path:/tmp/pip-7QBy_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:52 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)) 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:52 INFO - Running setup.py (path:/tmp/pip-cvB9i7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:52 INFO - Running setup.py (path:/tmp/pip-50Lcwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:52 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)) 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:52 INFO - Running setup.py (path:/tmp/pip-ysJGbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:52 INFO - Running setup.py (path:/tmp/pip-1SueAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:52 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)) 11:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:52 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)) 11:18:52 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)) 11:18:52 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)) 11:18:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:18:52 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 11:18:52 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 11:18:52 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 11:18:52 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 11:18:52 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 11:18:52 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 11:18:54 INFO - Downloading blessings-1.6.tar.gz 11:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:18:54 INFO - Installing collected packages: blessings 11:18:54 INFO - Running setup.py install for blessings 11:18:55 INFO - Successfully installed blessings 11:18:55 INFO - Cleaning up... 11:18:55 INFO - Return code: 0 11:18:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:18:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:55 INFO - Reading from file tmpfile_stdout 11:18:55 INFO - Current package versions: 11:18:55 INFO - argparse == 1.2.1 11:18:55 INFO - blessings == 1.6 11:18:55 INFO - blobuploader == 1.2.4 11:18:55 INFO - docopt == 0.6.1 11:18:55 INFO - functools32 == 3.2.3-2 11:18:55 INFO - jsonschema == 2.5.1 11:18:55 INFO - manifestparser == 1.1 11:18:55 INFO - mozInstall == 1.12 11:18:55 INFO - mozcrash == 1.0 11:18:55 INFO - mozdebug == 0.1 11:18:55 INFO - mozdevice == 0.48 11:18:55 INFO - mozfile == 1.2 11:18:55 INFO - mozhttpd == 0.7 11:18:55 INFO - mozinfo == 0.9 11:18:55 INFO - mozleak == 0.1 11:18:55 INFO - mozlog == 3.4 11:18:55 INFO - moznetwork == 0.27 11:18:55 INFO - mozprocess == 0.23 11:18:55 INFO - mozprofile == 0.28 11:18:55 INFO - mozrunner == 6.13 11:18:55 INFO - mozscreenshot == 0.1 11:18:55 INFO - mozsystemmonitor == 0.3 11:18:55 INFO - moztest == 0.8 11:18:55 INFO - mozversion == 1.4 11:18:55 INFO - psutil == 3.1.1 11:18:55 INFO - requests == 1.2.3 11:18:55 INFO - wsgiref == 0.1.2 11:18:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:55 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')]} 11:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:55 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')]} 11:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:55 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 0x7f9fab00af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cf60>, '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 0x1f2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', '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 11:18:55 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 11:18:55 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 11:18:55 INFO - Using env: {'DISPLAY': ':0', 11:18:55 INFO - 'HOME': '/home/cltbld', 11:18:55 INFO - 'LANG': 'en_US.UTF-8', 11:18:55 INFO - 'LANGUAGE': 'en_US:en', 11:18:55 INFO - 'LOGNAME': 'cltbld', 11:18:55 INFO - 'MAIL': '/var/mail/cltbld', 11:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:55 INFO - 'MOZ_NO_REMOTE': '1', 11:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:55 INFO - 'NO_EM_RESTART': '1', 11:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:55 INFO - 'PWD': '/builds/slave/test', 11:18:55 INFO - 'SHELL': '/bin/bash', 11:18:55 INFO - 'SHLVL': '1', 11:18:55 INFO - 'TERM': 'linux', 11:18:55 INFO - 'TMOUT': '86400', 11:18:55 INFO - 'USER': 'cltbld', 11:18:55 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', 11:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:55 INFO - '_': '/tools/buildbot/bin/python'} 11:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:55 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)) 11:18:55 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)) 11:18:55 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)) 11:18:55 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)) 11:18:55 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)) 11:18:55 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)) 11:18:55 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)) 11:18:55 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)) 11:18:55 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)) 11:18:55 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)) 11:18:55 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)) 11:18:55 INFO - Cleaning up... 11:18:55 INFO - Return code: 0 11:18:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:18:55 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')]} 11:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:55 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')]} 11:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:55 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 0x7f9fab00af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2cf60>, '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 0x1f2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', '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 11:18:55 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 11:18:55 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 11:18:55 INFO - Using env: {'DISPLAY': ':0', 11:18:55 INFO - 'HOME': '/home/cltbld', 11:18:55 INFO - 'LANG': 'en_US.UTF-8', 11:18:55 INFO - 'LANGUAGE': 'en_US:en', 11:18:55 INFO - 'LOGNAME': 'cltbld', 11:18:55 INFO - 'MAIL': '/var/mail/cltbld', 11:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:55 INFO - 'MOZ_NO_REMOTE': '1', 11:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:55 INFO - 'NO_EM_RESTART': '1', 11:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:55 INFO - 'PWD': '/builds/slave/test', 11:18:55 INFO - 'SHELL': '/bin/bash', 11:18:55 INFO - 'SHLVL': '1', 11:18:55 INFO - 'TERM': 'linux', 11:18:55 INFO - 'TMOUT': '86400', 11:18:55 INFO - 'USER': 'cltbld', 11:18:55 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', 11:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:55 INFO - '_': '/tools/buildbot/bin/python'} 11:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:18:55 INFO - Cleaning up... 11:18:55 INFO - Return code: 0 11:18:55 INFO - Running post-action listener: _resource_record_post_action 11:18:55 INFO - Running post-action listener: _start_resource_monitoring 11:18:55 INFO - Starting resource monitoring. 11:18:55 INFO - [mozharness: 2017-01-19 19:18:55.802103Z] Finished create-virtualenv step (success) 11:18:55 INFO - [mozharness: 2017-01-19 19:18:55.802607Z] Running install step. 11:18:55 INFO - Running pre-action listener: _resource_record_pre_action 11:18:55 INFO - Running main action method: install 11:18:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:56 INFO - Reading from file tmpfile_stdout 11:18:56 INFO - Detecting whether we're running mozinstall >=1.0... 11:18:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:18:56 INFO - Reading from file tmpfile_stdout 11:18:56 INFO - Output received: 11:18:56 INFO - Usage: mozinstall [options] installer 11:18:56 INFO - Options: 11:18:56 INFO - -h, --help show this help message and exit 11:18:56 INFO - -d DEST, --destination=DEST 11:18:56 INFO - Directory to install application into. [default: 11:18:56 INFO - "/builds/slave/test"] 11:18:56 INFO - --app=APP Application being installed. [default: firefox] 11:18:56 INFO - mkdir: /builds/slave/test/build/application 11:18:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:19:12 INFO - Reading from file tmpfile_stdout 11:19:12 INFO - Output received: 11:19:12 INFO - /builds/slave/test/build/application/firefox/firefox 11:19:12 INFO - Running post-action listener: _resource_record_post_action 11:19:12 INFO - [mozharness: 2017-01-19 19:19:12.078545Z] Finished install step (success) 11:19:12 INFO - [mozharness: 2017-01-19 19:19:12.078786Z] Running run-tests step. 11:19:12 INFO - Running pre-action listener: _resource_record_pre_action 11:19:12 INFO - Running main action method: run_tests 11:19:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:19:12 INFO - Python 2.7.3 11:19:12 INFO - Return code: 0 11:19:12 INFO - grabbing minidump binary from tooltool 11:19:12 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')]} 11:19:12 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 0x1f2cf60>, '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 0x1f2dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:19:12 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 11:19:12 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 11:19:12 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 11:19:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:19:12 INFO - Return code: 0 11:19:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:19:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:19:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:19:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:19:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:19:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 11:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 11:19:12 INFO - Using env: {'DISPLAY': ':0', 11:19:12 INFO - 'HOME': '/home/cltbld', 11:19:12 INFO - 'LANG': 'en_US.UTF-8', 11:19:12 INFO - 'LANGUAGE': 'en_US:en', 11:19:12 INFO - 'LOGNAME': 'cltbld', 11:19:12 INFO - 'MAIL': '/var/mail/cltbld', 11:19:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:19:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:12 INFO - 'MOZ_NO_REMOTE': '1', 11:19:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:12 INFO - 'NO_EM_RESTART': '1', 11:19:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:12 INFO - 'PWD': '/builds/slave/test', 11:19:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:19:12 INFO - 'SHELL': '/bin/bash', 11:19:12 INFO - 'SHLVL': '1', 11:19:12 INFO - 'TERM': 'linux', 11:19:12 INFO - 'TMOUT': '86400', 11:19:12 INFO - 'USER': 'cltbld', 11:19:12 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620', 11:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:12 INFO - '_': '/tools/buildbot/bin/python'} 11:19:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 11:19:12 INFO - mozversion application_buildid: 20170119093328 11:19:12 INFO - mozversion application_changeset: cd4fc47221cb3c5333f0b23fcb1dac38c8c2b35d 11:19:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:19:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:19:12 INFO - mozversion application_name: Firefox 11:19:12 INFO - mozversion application_remotingname: firefox-dev 11:19:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:19:12 INFO - mozversion application_vendor: Mozilla 11:19:12 INFO - mozversion application_version: 52.0a2 11:19:12 INFO - mozversion platform_buildid: 20170119093328 11:19:12 INFO - mozversion platform_changeset: cd4fc47221cb3c5333f0b23fcb1dac38c8c2b35d 11:19:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:19:12 INFO - mozversion platform_version: 52.0a2 11:19:12 INFO - using testdate: 1484853552 11:19:12 INFO - actual date: 1484853552 11:19:12 INFO - starting webserver on 'localhost:49275' 11:19:12 INFO - SUITE-START | Running 2 tests 11:19:12 INFO - TEST-START | dromaeo_css 11:19:12 INFO - operating with platform_type : linux_ 11:19:12 INFO - Initialising browser for dromaeo_css test... 11:19:12 INFO - TEST-INFO | started process 23714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCWCs26/profile http://localhost:49275/getInfo.html) 11:19:16 INFO - PROCESS | 23714 | __metrics Screen width/height:1600/1200 11:19:16 INFO - PROCESS | 23714 | colorDepth:24 11:19:16 INFO - PROCESS | 23714 | Browser inner width/height: 1024/697 11:19:16 INFO - PROCESS | 23714 | __metrics 11:19:16 INFO - PROCESS | 23714 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:19:16 INFO - PROCESS | 23714 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:19:17 INFO - PROCESS | 23714 | console.error: PushService: 11:19:17 INFO - PROCESS | 23714 | stateChangeProcessEnqueue: Error transitioning state 11:19:17 INFO - PROCESS | 23714 | UnknownError 11:19:17 INFO - TEST-INFO | 23714: exit 0 11:19:17 INFO - Browser initialized. 11:19:17 INFO - Running cycle 1/1 for dromaeo_css test... 11:19:17 INFO - TEST-INFO | started process 23806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCWCs26/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:29 INFO - PROCESS | 23806 | RSS: Main: 144175104 11:19:29 INFO - PROCESS | 23806 | 11:22:31 INFO - PROCESS | 23806 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 11:22:32 INFO - PROCESS | 23806 | RSS: Main: 264978432 11:22:32 INFO - PROCESS | 23806 | 11:25:34 INFO - PROCESS | 23806 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 11:25:35 INFO - PROCESS | 23806 | RSS: Main: 230096896 11:25:35 INFO - PROCESS | 23806 | 11:28:37 INFO - PROCESS | 23806 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 11:28:38 INFO - PROCESS | 23806 | RSS: Main: 172843008 11:28:38 INFO - PROCESS | 23806 | 11:31:40 INFO - PROCESS | 23806 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 11:31:40 INFO - PROCESS | 23806 | RSS: Main: 229580800 11:31:40 INFO - PROCESS | 23806 | 11:34:43 INFO - PROCESS | 23806 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 11:34:43 INFO - PROCESS | 23806 | RSS: Main: 177242112 11:34:43 INFO - PROCESS | 23806 | 11:37:46 INFO - PROCESS | 23806 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 11:37:46 INFO - PROCESS | 23806 | RSS: Main: 270221312 11:37:46 INFO - PROCESS | 23806 | 11:37:46 INFO - PROCESS | 23806 | __start_tp_report 11:37:46 INFO - PROCESS | 23806 | _x_x_mozilla_page_load 11:37:46 INFO - PROCESS | 23806 | _x_x_mozilla_page_load_details 11:37:46 INFO - PROCESS | 23806 | |i|pagename|runs| 11:37:46 INFO - PROCESS | 23806 | |0;dojo.html;3225.1292151119196;3247.464168412212;3273.378058168947;3295.6539563345864;3298.835058247087;5612;5690.886182276352;5694.145878118274;5705.629134106281;5720.342160651521;5621.971890140554;5680.659160450376;5693.516051135648;5703.686297253649;5735.283089613798;5123.257127716479;5131.820386286481;5135.998480296344;5156.407013193493;5198.194279886624;4995.375578052744;5035.395752509704;5039.798408063673;5220.321358223426;5237.45006774289;5065.189569668853;5102.948970510284;5113.590912726973;5116.795328186868;5140.228965655163;5129.897402051975;5135.35808023997;5138.743062846843;5141.794328226866;5177.948220517822;4969.105560999019;4980.252962055721;5034.773435195389;5067.34124563808;5076.390833100052;5587.413321601254;5599.32808063035;5610.074337734269;5663.4336566343445;5668.348139963916;5920.526357891402;5947.345791962881;5948.7620495180145;5953.791617293374;5962.4633782959745;6101.877962440726;6104.450599446027;6109.969450152766;6113.991191453405;6117.051856962178;5503.064479038573;5508.338999320107;5590.97204513983;5662.178984047372;5667.943320566824;6252.155958945484;6252.437280644764;6252.874942501125;6254.499640028786;6271.655058971709;5984.970075149597;5989.303749652122;6004.189434426296;6004.399560044048;6046.3349031606485;5802.912956305659;5853.385394533598;5965.970170149121;6020.458158765732;6061;6037.275526936795;6067.787627433018;6085.726142323518;6106.45041946218;6116.48009919153;6029.969850150721;6030;6051.636901785907;6060.181875446847;6080.027195648763;4542.500324964251;4567.406237189144;4597.3333866589155;4610.654200934943;4657.301404789308;4118.588141185857;4140.109876376593;4146.91706165875;4187.602177793105;4210.810513526837;5753.194552762617;5754.4533269339345;5756.856078597984;5759.769609215585;5785.074388097884;5824.184614154022;5865.618734782225;6107.694615269219;6117.327094019654;6125.938740612626;5575;5624.578156638268;5632.239647647597;5637.3235211774845;5643.125315576092;5166;5166.844994650167;5170.638055336166;5179.326687530673;5201.765920533585;6206.379362063757;6250.812475625738;6317.905231421532;6324.462420694293;6345.428911397997;6078.209832721718;6085.817425477243;6088.786892458743;6091.908621370594;6097.847553811191;6107.236595425572;6311.116443697794;6316.336784637547;6321.399467050623;6322.652254126067;5848.707564621837;5870.412958704095;5906.96628090074;5908.025175846109;6015.097735339734;6032.849178770566;6072.089186622042;6096.75612975476;6099.237595300588;6107.694615269308;5951.91072133927;5952.345242023461;5958.612690175125;5961;5962.403759624003;5770.538356931519;5820.76716931318;5899.852503687443;5906.291245050621;5928.021876390348;5959.255093113361;5973.104034394875;5975.282966044103;5980.162777211107;6001.699915004145;6008.819735407945;6018.037114061729;6018.518518518596;6019.067044608093;6020.759169633166;5523.696196709219;5540.806071787468;5630.5777066720975;5684.232628595087;5726.484616384545 11:37:46 INFO - PROCESS | 23806 | |1;ext.html;575.8157389635315;606.8604221029163;619.3496828330252;623.9532035097369;642.7043559962417;34142;44536.3319550207;45247.773761131146;45253.54746452534;48897.26654100191;47261.81845453857;47413.76293118538;47756;47791.52208477914;47833.282500762514;7910.683572657087;8098.230668086522;8797.824043519126;8998.325125615605;9007;10510.421926794023;10762.192835537327;10763.83854242187;11054.889451105466;11082.6121085762;10791.730206744816;10811.621593244237;10841.566337346536;10846.783064338708;10867.402292873889;10752.78494430111;10786.676399707943;10788.784224315548;10816.621418250363;10830.891691083067;10802.67591972242;10835.83746243807;10863.565457381696;10864.728381790439;10865.67402977904;43639.34540981888;43977;43985;43987.56012439867;44116.11767764627;3476.3047390521997;3559.60844307126;3796.658300752918;3798.3922572388287;4180.686448516343;32949.341013179845;33298.500522492184;33309.6669033309;33483;34851;4536.614387777043;4547.454305483363;4553.863384098482;4589.151007063704;4599.816007359702;370474.1476292628;370979;372016;372073;372341;38412;39435.802820985715;60963;61403;61404.385956139864;41338;41418;41514;41735.86980976439;41743.582564174576;16340.346386144658;16407;16446.67106657884;16452.424165154163;16464.259108340153;12456.937715311366;12792.2964236966;12802.42389092493;13165.144265622705;13794.448222071205;9223.584938677775;9424.90575094254;9433.29250306216;9544.761380965532;9678.661246856467;3561.4835848802295;3594.3350480161253;3666.3400587893902;3689.9262014760093;3698.0939669780537;1012.281280290987;1040.54216144896;1053.9262251642465;1094.4199574225672;1143.1483544759208;33409.3318133636;33839.66160338414;34127.14682132967;34165;34168.48747268793;1141.2125633312987;1150.8216226484908;1157.976840463186;1171.2328424881716;1236.2273579013117;17628.17637148467;17801.198946047458;17821.643567128584;17891.361133278067;17913.283468661106;160756;577413;588982;591044;858218;61648;62578.0613290801;62588.37411625825;62628;62632;1320.914140580859;1355.898307626932;1393.4356585582855;1426.3438818143563;1455.5560554031122;32031;34202.48696269508;34574;34666.65333346634;34751.82624086965;52383.73808130935;52988.470115298354;52991;53003.46996529985;53095.73452132715;412801;415917;417394;417422;418091;29614.703852961196;32216;32455.188620284684;32601.34797303993;32833.671663283065;50281.74859125681;50720;50775;51606.48393516017;51772.74113629408;41941.370879436225;42308.1538369237;42390.5760942399;42568.57431425646;43804.56195438005;41602.37596436116;41981.37027944522;42372.15255694807;43332.13335733331;44274;41234.587654123075;41945.37081943712;42623;43037.78481107575;43068;35704.82147589245;38286.42570361502;38645.420318695804;38713.61286387213;39244;28756.281092972844;28866.855665721538;29424.705752943053;29449.705502944696;29463.26341841471 11:37:46 INFO - PROCESS | 23806 | |2;jquery.html;387.98541813158596;432.60200615433797;436.1386262132289;443.87793356826876;451.7537941821709;16400.425985090526;18928.24287028519;20621.690674639856;20698.89650551747;20774.48063798406;19653.60692786147;20036.799632003676;20187;20392.69410958833;20593.38219853403;5640.520555752756;5863.179154918314;5871.471567558919;5873.676947767871;5877.030290002144;4171.218492634766;4500.414946057008;4526.366308716782;6445.967770161166;6544.672766361663;6454.386833250857;6503.609783412987;6507.05647681086;6511.739530418801;6512.6092434454085;6362.554621176497;6478.611283322992;6489.772857949996;6501.187351581052;6503.991881258389;5642.633228840154;5787.88424231513;5822.592418530662;5825.79609713658;5831.387704291031;23553.764462355328;23642.881785590962;23727.050917963432;23777.405564860845;23821.928013239445;2422.5397174536956;2485.875706214682;2542.5931850903953;2651.9922429476674;2919.649642042947;8064.879026814602;10364.585416583328;15260.389584416722;15404.614884627861;15592.064476131469;1904.5143488410367;1995.1520603743352;2036.8370530357536;2041.2447394463995;2066.2664754012408;84976.57511712401;85697.14302856954;85876.57061714714;86726.56636716776;86972.56513717391;9936.503174841373;11100.556927599522;11396.11964025943;11475.139364547693;11638.1271404645;14624.926875365767;14877.107373557621;15760.842391575938;15818;16378.26297816601;8541.487510749375;8751.56242187888;8925.910740892637;8947.776305592282;9087.681931132378;8610.784730381665;8658.610362533702;8675.956620216859;8869.423487473294;8937.642494300286;6716.798496045127;6848.554843935129;6912.205096413977;6948.44412447003;7143.785686429415;1996.5707372914892;2026.1490174126902;2066.4730493724005;2092.7174831397565;2110.5778844231213;467.0658682634731;471.9764011799465;949.7625593601599;1051.7896420715888;1122.141561705296;11932.28406295625;12604.180728252633;12649.747005059848;12737.93631031839;12745.36273186337;498.6110833549837;500.20966872341614;505.7521814310961;515.7318194538818;524.2372348233312;6540.738370465128;6656.667166641745;6707.731690732316;6807.3873351398615;6820.04519367289;471224;484437;488013;489116;493509;79446;81236.18763812404;97807.51096244474;99426.52580633889;101728;451.51462178158613;458.6651744226733;458.73851904414164;460.07065727230804;460.8433132734886;10921.344719316867;11006.339619622848;11042.723931901766;11044.447777611247;11094.5562177512;29907.70092299049;40546.797266013484;42175;42785.786071069444;43170.784146079066;56822.7158864203;58609;59285.11072334005;59394.70302648459;59704.70147649234;8291.461055031645;8394.58027098655;8524.872126917977;8629.13708629132;8908.777280568038;12568.37158142071;13377.063605547908;13383.19700817954;13507.797383039066;13567.59297221085;9821.656242031495;11574.826377604175;11661.6501504955;11685.065194784567;11922.344271064827;11369.54521819118;11425.37160456183;11591.826122608336;11613.129015323715;11664.125190610568;11526.59656912004;11635.069194464253;11922.344271064827;12009.159358844798;12056.819147712968;7770.572618506037;8160.551169685724;8230.753077407688;8234.464759790595;8921.509316987369;8167.060788009455;8632.395732298679;8639.827203456021;8677.479351238946;9365.29760267969 11:37:46 INFO - PROCESS | 23806 | |3;mootools.html;1519.1189110316013;1535.393519559774;1709.1368858726348;1807.7288406738996;1831.0753069699808;8142.877856832145;8654.091320411344;8659.393842431033;8672.739817805461;8683.131686831313;7218.6751596178165;7456.627168641559;7954.244346787061;8172.877406838902;8492.830143397145;2392.7487613800517;2421.443068094339;2423.745506721795;2423.987880060606;2426.684531010966;2435.330284171849;2461.10169788027;2492.3519884829893;2497.4880149569385;2501.562226610345;2057.341650671786;2121;2129.329261282691;2133.391983284764;2346.9882650586724;2430.732619411863;2461.692288463942;2464.2484042367073;2465.815063870199;2467.111839737693;2422.9636555451684;2427.3082171581013;2457.8525288482747;2480.6403071554705;2481.4788894332214;8467.915320846774;8564.743057708216;8615.65537378504;8620.396572239946;8626.094260102662;5166.250893620441;5305.761240744176;5307.522322990911;5309.495597918191;5310.495502927216;3340.5824271966003;3458.4032606089636;3482.0598438421484;3566.589842168132;3570.6072332043454;1047.743302890789;1048.6801525534709;1049.632628579991;2064.607724532334;2138.433315171481;11197.944010279978;11214.215004949576;11243.381614011227;11265.042471389941;11270.154738394653;4332.631726303236;4462.241418958784;4541.477730061085;4563.406757121553;4591.95408045922;9395.953020234992;9401.294902882175;9401.294902882311;9411.576479058458;9415.764605884908;5277.868053298698;5312.150055991023;5313.548348390353;5325.760340784674;5331.866703332447;4636.9536304637195;4798.808047678123;4831.565159135695;4915.803367865316;4967.552920237196;3852.056246219638;3873.8450461981206;3880.96119038806;3945.2898478274187;3951.6641085508054;1188.102982248397;1209.9395030248452;1215.1129675337054;1223.2232532342027;1229.7847876621556;793.262266092528;865.2213008292462;931.3759780946782;971;1011.0698157694939;5793.188953546507;5879;5953.970230148821;5990.73041713124;6134.834381467507;933;934.6635211323918;936.3913456253354;1008.8436292374694;1054.509653011338;3891.3579259422445;3986.581408952018;4028.8992775180855;4059.0664147245707;4145.647619952338;10188.643397481053;10660.893391066145;10675.145988320915;10696.732581685521;10698.358098514114;10568.947155264328;10597.516347711327;10602;10602.522886470128;10656.893431065746;7633.694652213961;7860.7248746294745;7963.522188668699;8095.069067057246;8121.512709237465;5536.114221724505;5730.08318669011;5755.65466072037;5767.192593037062;5820.097884827858;9546;9692.224622030362;9723.805523889341;9785.119339259216;9797.951010244904;9690.563924623268;9766.36518626287;9861.309708320348;10011.449370284705;10017;7679.884801728091;7842.686292548462;7844.529328240324;7857.724979625686;7862.764117076496;8173.305269051959;8229.711960081368;8238.794030149054;8239.876401853857;8243.587820609066;7302.19675835647;7454.552726836408;7504.061992250969;7590.886136708064;7639.656215470206;7328.633568321456;7340.596267205355;7423.851522969619;7474.850502990019;7476.065491813523;6750.8649827004165;6856.382925536725;6862.382385585322;6862.588244705334;6862.970554416877;4582;4648.511906249795;4721.5750582447745;4745.0509898019845;4828.589569886599;4832.855014349575;4854.417469903634;4957.03337849116;4996.775145118406;5041.319421878 11:37:46 INFO - PROCESS | 23806 | |4;prototype.html;312.13849774622065;338.24064974133074;359.98740044098446;360.36036036036035;364.47697554009994;5147.22791581263;5213.791448342066;5394.973025134874;5455.645383050099;5479.671219726819;5357.678539287635;5359.14253719404;5377.354717433914;5393.946060539393;5394.487523685253;4260.424842646234;4283.250431174548;4288.919873861175;4299.204647140289;4301.419308393358;4188.560201178878;4269.398975384231;4284.421603083575;4304.375865499501;4321.286987647034;4224.577542245766;4240.809163587646;4265.848220980333;4279.61483466488;4284.807183676727;4114.835406583733;4243.851465198703;4278.7860606969525;4283.571642835723;4284.571542845706;3773.3208022555928;3796.1458671798623;3805.219929914361;3806.6764325032404;3835.846566137351;5273.31446911899;5274.182501712241;5283.233931080011;5290.206469029637;5317.096093664087;4738.336632871401;4860.198067318888;4864.586510146642;4871.853844384674;4891.608671306322;5595.21666966625;5637.182608521783;5650.6892120933335;5656.858578535528;5675.035244008528;4152.875413737593;4153.013107416883;4163.709250132469;4166.208420400114;4169.2703776839235;5494.203340515643;5680.744366503517;5837.182794408786;5958.40415958405;5959.851003724898;4198.6011328923705;4206.326987681956;4211.515675697273;4220.5146408163455;4220.831166753357;4261.21167583998;4282.807273672693;4298.570142985676;4309.504406993173;4312.266914624522;4759.881002974953;4765.142274390573;4839.435099397325;4839.879003024953;4902.828401006019;5608.775648973995;5619.7471113799975;5621.558968414906;5621.606487545832;5643.633163844337;1413.1662319231702;1430.5851303121979;1431.355889849572;1438.3167995202405;1443.2999995002415;924.8057907839429;965.8551217317319;972.4214092614883;973.177664873181;982.5627595719978;5259.500347466985;5283.445238250005;5294.602904782157;5296.814611488579;5304.708241046702;5510.197963405238;5574.637648552831;5576.1356989666665;5616.775328986876;5631;5050.671706339076;5225.27565903251;5275.788968441296;5321.5476684482255;5331.747039445727;2956.6895475975143;2966.3325751705693;2966.9406611867644;2980.8211507309197;2981.8061825981677;5776.274303074493;5792.536597072309;5809.622374545641;5836.212111364996;5840.474357307863;5642.238297829823;5947.1079338099635;6013.458788709037;6013.969930150409;6020.036794112921;6081.418831103856;6128.3258841527395;6137.41694539018;6158.784442544489;6161.291451483136;5636.464535869086;5797.594168408171;5829.300483941955;5941.881162376641;5943.494802941798;5756.222909907109;5761.386811692732;5767.336756273083;5795.913061304;5802.941970580409;5768.3078030634915;5910.822675319747;5920.644761314335;6027.939720602738;6048.455638992512;4341.261985462415;4350.32569951658;4382.583654552813;4410.382546443565;4417.668674849335;5653.660780353192;5773.711314434346;5828.939806601568;5863.413658634103;5881.353051164283;5641.971790141023;5643.463870932255;5646.491815736604;5647.3505546861;5659.377468478547;5620.494155526022;5629.408912064175;5631.63394379364;5635.013442875283;5653.321601407857;5468.4531546845;5618.606697531133;5622.329393538037;5638.605297629127;5638.7462564185535;5675.233843431084;5681.289838770153;5687.516561092353;5692.402297758841;5693.6299140557385;5289.867753306198;5433.538149257357;5443.727813609383;5443.911217756386;5458.890822183614 11:37:46 INFO - PROCESS | 23806 | |5;yui.html;750.2872271342226;753.8266198774281;780.4926797581571;790.5533373643891;851.5869803145478;15495.22523873806;15607.687846243069;16467;16502.174891255436;16505.257263423144;16089.758653620205;17061.91469042656;17070.82929170708;17088.658226835487;17091.82908170918;708.833424145328;720.0531301338749;823.625250511016;841.6254766628853;864.2351518905782;835.6740871060291;855.1448551448551;855.4610595324937;855.70050482331;857.4212406625534;903.1555495611591;903.9186473217409;905.0135352465811;905.6286922361833;905.9728208153733;738.051603689262;752.2064222245529;873.5981448533682;883.8895138107737;885.2740752582885;654.3358491131505;656.1896058367912;657.0932113683086;657.1916542652564;657.3557913244999;15764.132972686497;15832.20838958059;15846.366145354172;15851.365945362171;15868.682626347409;13940.790888136686;13967.37146828385;14366;14651.194184319858;14685.55943321702;12420.222657509094;12462.189957652723;12491.812622810665;12589.30758808265;12646.873531264753;3905.297046531623;3910.491636087319;3922.901927451808;3950.920981580381;4000.759954402716;67852.660736696;68281.65859170722;68742.31257687409;69001.65499172472;69384.6530767348;11048.558057677763;11312.547498100148;11410.14423918193;11442;11480.28750391169;20469;20599;20684.896575517025;20704.378868633965;21106.78893211048;8410.49537027768;8452.070272270046;8548.957255213809;8578.742637720878;8604.956975215084;4847.297141914402;4947;4975.776090075955;5045.672031317952;5169.379674439091;3550.7336949728356;3641.1625326175126;3655.597884232732;3658.9634103659155;3666.926661466756;591.7100620695828;595.1994567306965;603.8218725475995;607.492743559133;612.9417705317987;694.1565997313288;695.5652717051843;720.661289194078;722.342668171961;756.4137793210197;8004.399670024772;8398.958005209935;8780.604872780741;8819.338549608805;8894.42186257891;657.7763560389491;702.8875379939185;740.6370878269717;745.7389913530221;762.5920132729075;4099.672026237894;4209.24233637942;4210.578942105826;4228.450301460791;4374.993751437188;55442.72278638581;70778.64610677016;71247.64376178086;73254.26745732581;92267.5386623076;46479.76760116178;46657.76671116623;46740.532594674296;46891.29663055057;63181.05228421577;62629.68685156545;63670.68164659147;64061.03908441377;65792;67627;8441.451305665112;8618.525981071101;8629.8705519416;8788.824223515367;8842.159994800484;42900.57099428966;43368.81415505133;43971.34042989422;44531.55468445274;45418;55599.444005559424;60729.39270607237;61531;61758.691206545474;61881;12162.209456385306;12413.255204687748;12529.812052819398;12589.181703189264;12691.93654031724;12865.356732163167;12885.48458061667;12939.158954667917;13052.282124483245;13205.075644704779;11150.219484635998;11192.83210751823;11827.349495777815;11854.762904741685;12124.393780310773;11429.942850285695;11757;12078.75842483163;12249.571265005681;12312.938435307766;11173.039144626842;11420.771584568096;11479.311241325548;11500.597479088192;12303.200291980993;9428.057194280516;9671.806563868542;10095.949520252352;10234.846477302697;10454.163666906477;9626.9037309626;9843.360181588174;9894.50527473609;9907.603695852085;9913.256505762241 11:37:46 INFO - PROCESS | 23806 | __end_tp_report 11:37:46 INFO - PROCESS | 23806 | __start_cc_report 11:37:46 INFO - PROCESS | 23806 | _x_x_mozilla_cycle_collect,1100 11:37:46 INFO - PROCESS | 23806 | __end_cc_report 11:37:46 INFO - PROCESS | 23806 | __startTimestamp1484854666492__endTimestamp 11:37:46 INFO - PROCESS | 23806 | 11:37:46 INFO - PROCESS | 23806 | ------- Summary: start ------- 11:37:46 INFO - PROCESS | 23806 | Number of tests: 6 11:37:46 INFO - PROCESS | 23806 | 11:37:46 INFO - PROCESS | 23806 | [#0] dojo.html Cycles:165 Average:5611.69 Median:5820.77 stddev:647.49 (11.1%) stddev-sans-first:621.82 11:37:46 INFO - PROCESS | 23806 | Values: 3225.1 3247.5 3273.4 3295.7 3298.8 5612.0 5690.9 5694.1 5705.6 5720.3 5622.0 5680.7 5693.5 5703.7 5735.3 5123.3 5131.8 5136.0 5156.4 5198.2 4995.4 5035.4 5039.8 5220.3 5237.5 5065.2 5102.9 5113.6 5116.8 5140.2 5129.9 5135.4 5138.7 5141.8 5177.9 4969.1 4980.3 5034.8 5067.3 5076.4 5587.4 5599.3 5610.1 5663.4 5668.3 5920.5 5947.3 5948.8 5953.8 5962.5 6101.9 6104.5 6110.0 6114.0 6117.1 5503.1 5508.3 5591.0 5662.2 5667.9 6252.2 6252.4 6252.9 6254.5 6271.7 5985.0 5989.3 6004.2 6004.4 6046.3 5802.9 5853.4 5966.0 6020.5 6061.0 6037.3 6067.8 6085.7 6106.5 6116.5 6030.0 6030.0 6051.6 6060.2 6080.0 4542.5 4567.4 4597.3 4610.7 4657.3 4118.6 4140.1 4146.9 4187.6 4210.8 5753.2 5754.5 5756.9 5759.8 5785.1 5824.2 5865.6 6107.7 6117.3 6125.9 5575.0 5624.6 5632.2 5637.3 5643.1 5166.0 5166.8 5170.6 5179.3 5201.8 6206.4 6250.8 6317.9 6324.5 6345.4 6078.2 6085.8 6088.8 6091.9 6097.8 6107.2 6311.1 6316.3 6321.4 6322.7 5848.7 5870.4 5907.0 5908.0 6015.1 6032.8 6072.1 6096.8 6099.2 6107.7 5951.9 5952.3 5958.6 5961.0 5962.4 5770.5 5820.8 5899.9 5906.3 5928.0 5959.3 5973.1 5975.3 5980.2 6001.7 6008.8 6018.0 6018.5 6019.1 6020.8 5523.7 5540.8 5630.6 5684.2 5726.5 11:37:46 INFO - PROCESS | 23806 | 11:37:46 INFO - PROCESS | 23806 | [#1] ext.html Cycles:180 Average:60885.08 Median:3797.53 stddev:126182.27 (3322.7%) stddev-sans-first:126455.00 11:37:46 INFO - PROCESS | 23806 | Values: 575.8 606.9 619.3 624.0 642.7 34142.0 44536.3 45247.8 45253.5 48897.3 47261.8 47413.8 47756.0 47791.5 47833.3 7910.7 8098.2 8797.8 8998.3 9007.0 10510.4 10762.2 10763.8 11054.9 11082.6 10791.7 10811.6 10841.6 10846.8 10867.4 10752.8 10786.7 10788.8 10816.6 10830.9 10802.7 10835.8 10863.6 10864.7 10865.7 43639.3 43977.0 43985.0 43987.6 44116.1 3476.3 3559.6 3796.7 3798.4 4180.7 32949.3 33298.5 33309.7 33483.0 34851.0 4536.6 4547.5 4553.9 4589.2 4599.8 370474.1 370979.0 372016.0 372073.0 372341.0 38412.0 39435.8 60963.0 61403.0 61404.4 41338.0 41418.0 41514.0 41735.9 41743.6 16340.3 16407.0 16446.7 16452.4 16464.3 12456.9 12792.3 12802.4 13165.1 13794.4 9223.6 9424.9 9433.3 9544.8 9678.7 3561.5 3594.3 3666.3 3689.9 3698.1 1012.3 1040.5 1053.9 1094.4 1143.1 33409.3 33839.7 34127.1 34165.0 34168.5 1141.2 1150.8 1158.0 1171.2 1236.2 17628.2 17801.2 17821.6 17891.4 17913.3 160756.0 577413.0 588982.0 591044.0 858218.0 61648.0 62578.1 62588.4 62628.0 62632.0 1320.9 1355.9 1393.4 1426.3 1455.6 32031.0 34202.5 34574.0 34666.7 34751.8 52383.7 52988.5 52991.0 53003.5 53095.7 412801.0 415917.0 417394.0 417422.0 418091.0 29614.7 32216.0 32455.2 32601.3 32833.7 50281.7 50720.0 50775.0 51606.5 51772.7 41941.4 42308.2 42390.6 42568.6 43804.6 41602.4 41981.4 42372.2 43332.1 44274.0 41234.6 41945.4 42623.0 43037.8 43068.0 35704.8 38286.4 38645.4 38713.6 39244.0 28756.3 28866.9 29424.7 29449.7 29463.3 11:37:46 INFO - PROCESS | 23806 | 11:37:46 INFO - PROCESS | 23806 | [#2] jquery.html Cycles:180 Average:28654.87 Median:459.40 stddev:80221.51 (17462.1%) stddev-sans-first:80418.47 11:37:46 INFO - PROCESS | 23806 | Values: 388.0 432.6 436.1 443.9 451.8 16400.4 18928.2 20621.7 20698.9 20774.5 19653.6 20036.8 20187.0 20392.7 20593.4 5640.5 5863.2 5871.5 5873.7 5877.0 4171.2 4500.4 4526.4 6446.0 6544.7 6454.4 6503.6 6507.1 6511.7 6512.6 6362.6 6478.6 6489.8 6501.2 6504.0 5642.6 5787.9 5822.6 5825.8 5831.4 23553.8 23642.9 23727.1 23777.4 23821.9 2422.5 2485.9 2542.6 2652.0 2919.6 8064.9 10364.6 15260.4 15404.6 15592.1 1904.5 1995.2 2036.8 2041.2 2066.3 84976.6 85697.1 85876.6 86726.6 86972.6 9936.5 11100.6 11396.1 11475.1 11638.1 14624.9 14877.1 15760.8 15818.0 16378.3 8541.5 8751.6 8925.9 8947.8 9087.7 8610.8 8658.6 8676.0 8869.4 8937.6 6716.8 6848.6 6912.2 6948.4 7143.8 1996.6 2026.1 2066.5 2092.7 2110.6 467.1 472.0 949.8 1051.8 1122.1 11932.3 12604.2 12649.7 12737.9 12745.4 498.6 500.2 505.8 515.7 524.2 6540.7 6656.7 6707.7 6807.4 6820.0 471224.0 484437.0 488013.0 489116.0 493509.0 79446.0 81236.2 97807.5 99426.5 101728.0 451.5 458.7 458.7 460.1 460.8 10921.3 11006.3 11042.7 11044.4 11094.6 29907.7 40546.8 42175.0 42785.8 43170.8 56822.7 58609.0 59285.1 59394.7 59704.7 8291.5 8394.6 8524.9 8629.1 8908.8 12568.4 13377.1 13383.2 13507.8 13567.6 9821.7 11574.8 11661.7 11685.1 11922.3 11369.5 11425.4 11591.8 11613.1 11664.1 11526.6 11635.1 11922.3 12009.2 12056.8 7770.6 8160.6 8230.8 8234.5 8921.5 8167.1 8632.4 8639.8 8677.5 9365.3 11:37:46 INFO - PROCESS | 23806 | 11:37:46 INFO - PROCESS | 23806 | [#3] mootools.html Cycles:180 Average:5638.69 Median:4936.42 stddev:3082.47 (62.4%) stddev-sans-first:3075.57 11:37:46 INFO - PROCESS | 23806 | Values: 1519.1 1535.4 1709.1 1807.7 1831.1 8142.9 8654.1 8659.4 8672.7 8683.1 7218.7 7456.6 7954.2 8172.9 8492.8 2392.7 2421.4 2423.7 2424.0 2426.7 2435.3 2461.1 2492.4 2497.5 2501.6 2057.3 2121.0 2129.3 2133.4 2347.0 2430.7 2461.7 2464.2 2465.8 2467.1 2423.0 2427.3 2457.9 2480.6 2481.5 8467.9 8564.7 8615.7 8620.4 8626.1 5166.3 5305.8 5307.5 5309.5 5310.5 3340.6 3458.4 3482.1 3566.6 3570.6 1047.7 1048.7 1049.6 2064.6 2138.4 11197.9 11214.2 11243.4 11265.0 11270.2 4332.6 4462.2 4541.5 4563.4 4592.0 9396.0 9401.3 9401.3 9411.6 9415.8 5277.9 5312.2 5313.5 5325.8 5331.9 4637.0 4798.8 4831.6 4915.8 4967.6 3852.1 3873.8 3881.0 3945.3 3951.7 1188.1 1209.9 1215.1 1223.2 1229.8 793.3 865.2 931.4 971.0 1011.1 5793.2 5879.0 5954.0 5990.7 6134.8 933.0 934.7 936.4 1008.8 1054.5 3891.4 3986.6 4028.9 4059.1 4145.6 10188.6 10660.9 10675.1 10696.7 10698.4 10568.9 10597.5 10602.0 10602.5 10656.9 7633.7 7860.7 7963.5 8095.1 8121.5 5536.1 5730.1 5755.7 5767.2 5820.1 9546.0 9692.2 9723.8 9785.1 9798.0 9690.6 9766.4 9861.3 10011.4 10017.0 7679.9 7842.7 7844.5 7857.7 7862.8 8173.3 8229.7 8238.8 8239.9 8243.6 7302.2 7454.6 7504.1 7590.9 7639.7 7328.6 7340.6 7423.9 7474.9 7476.1 6750.9 6856.4 6862.4 6862.6 6863.0 4582.0 4648.5 4721.6 4745.1 4828.6 4832.9 4854.4 4957.0 4996.8 5041.3 11:37:46 INFO - PROCESS | 23806 | 11:37:46 INFO - PROCESS | 23806 | [#4] prototype.html Cycles:180 Average:4767.98 Median:5385.65 stddev:1383.49 (25.7%) stddev-sans-first:1346.34 11:37:46 INFO - PROCESS | 23806 | Values: 312.1 338.2 360.0 360.4 364.5 5147.2 5213.8 5395.0 5455.6 5479.7 5357.7 5359.1 5377.4 5393.9 5394.5 4260.4 4283.3 4288.9 4299.2 4301.4 4188.6 4269.4 4284.4 4304.4 4321.3 4224.6 4240.8 4265.8 4279.6 4284.8 4114.8 4243.9 4278.8 4283.6 4284.6 3773.3 3796.1 3805.2 3806.7 3835.8 5273.3 5274.2 5283.2 5290.2 5317.1 4738.3 4860.2 4864.6 4871.9 4891.6 5595.2 5637.2 5650.7 5656.9 5675.0 4152.9 4153.0 4163.7 4166.2 4169.3 5494.2 5680.7 5837.2 5958.4 5959.9 4198.6 4206.3 4211.5 4220.5 4220.8 4261.2 4282.8 4298.6 4309.5 4312.3 4759.9 4765.1 4839.4 4839.9 4902.8 5608.8 5619.7 5621.6 5621.6 5643.6 1413.2 1430.6 1431.4 1438.3 1443.3 924.8 965.9 972.4 973.2 982.6 5259.5 5283.4 5294.6 5296.8 5304.7 5510.2 5574.6 5576.1 5616.8 5631.0 5050.7 5225.3 5275.8 5321.5 5331.7 2956.7 2966.3 2966.9 2980.8 2981.8 5776.3 5792.5 5809.6 5836.2 5840.5 5642.2 5947.1 6013.5 6014.0 6020.0 6081.4 6128.3 6137.4 6158.8 6161.3 5636.5 5797.6 5829.3 5941.9 5943.5 5756.2 5761.4 5767.3 5795.9 5802.9 5768.3 5910.8 5920.6 6027.9 6048.5 4341.3 4350.3 4382.6 4410.4 4417.7 5653.7 5773.7 5828.9 5863.4 5881.4 5642.0 5643.5 5646.5 5647.4 5659.4 5620.5 5629.4 5631.6 5635.0 5653.3 5468.5 5618.6 5622.3 5638.6 5638.7 5675.2 5681.3 5687.5 5692.4 5693.6 5289.9 5433.5 5443.7 5443.9 5458.9 11:37:46 INFO - PROCESS | 23806 | 11:37:46 INFO - PROCESS | 23806 | [#5] yui.html Cycles:180 Average:16609.08 Median:5107.53 stddev:20779.88 (406.8%) stddev-sans-first:20804.05 11:37:46 INFO - PROCESS | 23806 | Values: 750.3 753.8 780.5 790.6 851.6 15495.2 15607.7 16467.0 16502.2 16505.3 16089.8 17061.9 17070.8 17088.7 17091.8 708.8 720.1 823.6 841.6 864.2 835.7 855.1 855.5 855.7 857.4 903.2 903.9 905.0 905.6 906.0 738.1 752.2 873.6 883.9 885.3 654.3 656.2 657.1 657.2 657.4 15764.1 15832.2 15846.4 15851.4 15868.7 13940.8 13967.4 14366.0 14651.2 14685.6 12420.2 12462.2 12491.8 12589.3 12646.9 3905.3 3910.5 3922.9 3950.9 4000.8 67852.7 68281.7 68742.3 69001.7 69384.7 11048.6 11312.5 11410.1 11442.0 11480.3 20469.0 20599.0 20684.9 20704.4 21106.8 8410.5 8452.1 8549.0 8578.7 8605.0 4847.3 4947.0 4975.8 5045.7 5169.4 3550.7 3641.2 3655.6 3659.0 3666.9 591.7 595.2 603.8 607.5 612.9 694.2 695.6 720.7 722.3 756.4 8004.4 8399.0 8780.6 8819.3 8894.4 657.8 702.9 740.6 745.7 762.6 4099.7 4209.2 4210.6 4228.5 4375.0 55442.7 70778.6 71247.6 73254.3 92267.5 46479.8 46657.8 46740.5 46891.3 63181.1 62629.7 63670.7 64061.0 65792.0 67627.0 8441.5 8618.5 8629.9 8788.8 8842.2 42900.6 43368.8 43971.3 44531.6 45418.0 55599.4 60729.4 61531.0 61758.7 61881.0 12162.2 12413.3 12529.8 12589.2 12691.9 12865.4 12885.5 12939.2 13052.3 13205.1 11150.2 11192.8 11827.3 11854.8 12124.4 11429.9 11757.0 12078.8 12249.6 12312.9 11173.0 11420.8 11479.3 11500.6 12303.2 9428.1 9671.8 10095.9 10234.8 10454.2 9626.9 9843.4 9894.5 9907.6 9913.3 11:37:46 INFO - PROCESS | 23806 | -------- Summary: end -------- 11:37:46 INFO - PROCESS | 23806 | 11:37:47 INFO - TEST-INFO | 23806: exit 0 11:37:47 INFO - TEST-OK | dromaeo_css | took 1114934ms 11:37:47 INFO - TEST-START | kraken 11:37:47 INFO - operating with platform_type : linux_ 11:37:47 INFO - Initialising browser for kraken test... 11:37:47 INFO - TEST-INFO | started process 24123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUHaxyg/profile http://localhost:49275/getInfo.html) 11:37:51 INFO - PROCESS | 24123 | __metrics Screen width/height:1600/1200 11:37:51 INFO - PROCESS | 24123 | colorDepth:24 11:37:51 INFO - PROCESS | 24123 | Browser inner width/height: 1024/697 11:37:51 INFO - PROCESS | 24123 | __metrics 11:37:51 INFO - PROCESS | 24123 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:37:51 INFO - PROCESS | 24123 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:37:52 INFO - PROCESS | 24123 | console.error: PushService: 11:37:52 INFO - PROCESS | 24123 | stateChangeProcessEnqueue: Error transitioning state 11:37:52 INFO - PROCESS | 24123 | UnknownError 11:37:52 INFO - TEST-INFO | 24123: exit 0 11:37:52 INFO - Browser initialized. 11:37:52 INFO - Running cycle 1/1 for kraken test... 11:37:52 INFO - TEST-INFO | started process 24213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUHaxyg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:04 INFO - PROCESS | 24213 | RSS: Main: 143384576 11:38:04 INFO - PROCESS | 24213 | 11:38:07 INFO - PROCESS | 24213 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 11:38:08 INFO - PROCESS | 24213 | RSS: Main: 185028608 11:38:08 INFO - PROCESS | 24213 | 11:38:10 INFO - PROCESS | 24213 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 11:38:11 INFO - PROCESS | 24213 | RSS: Main: 174874624 11:38:11 INFO - PROCESS | 24213 | 11:38:13 INFO - PROCESS | 24213 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 11:38:14 INFO - PROCESS | 24213 | RSS: Main: 266948608 11:38:14 INFO - PROCESS | 24213 | 11:38:16 INFO - PROCESS | 24213 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 11:38:17 INFO - PROCESS | 24213 | RSS: Main: 173248512 11:38:17 INFO - PROCESS | 24213 | 11:38:19 INFO - PROCESS | 24213 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:38:19 INFO - PROCESS | 24213 | RSS: Main: 175575040 11:38:19 INFO - PROCESS | 24213 | 11:38:22 INFO - PROCESS | 24213 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 11:38:23 INFO - PROCESS | 24213 | RSS: Main: 214372352 11:38:23 INFO - PROCESS | 24213 | 11:38:26 INFO - PROCESS | 24213 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 11:38:27 INFO - PROCESS | 24213 | RSS: Main: 212660224 11:38:27 INFO - PROCESS | 24213 | 11:38:30 INFO - PROCESS | 24213 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 11:38:30 INFO - PROCESS | 24213 | RSS: Main: 211746816 11:38:30 INFO - PROCESS | 24213 | 11:38:32 INFO - PROCESS | 24213 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:38:32 INFO - PROCESS | 24213 | RSS: Main: 173649920 11:38:32 INFO - PROCESS | 24213 | 11:38:34 INFO - PROCESS | 24213 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:38:35 INFO - PROCESS | 24213 | RSS: Main: 180449280 11:38:35 INFO - PROCESS | 24213 | 11:38:36 INFO - PROCESS | 24213 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:38:37 INFO - PROCESS | 24213 | RSS: Main: 189714432 11:38:37 INFO - PROCESS | 24213 | 11:38:40 INFO - PROCESS | 24213 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:38:40 INFO - PROCESS | 24213 | RSS: Main: 198574080 11:38:40 INFO - PROCESS | 24213 | 11:38:43 INFO - PROCESS | 24213 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:38:44 INFO - PROCESS | 24213 | RSS: Main: 195186688 11:38:44 INFO - PROCESS | 24213 | 11:38:45 INFO - PROCESS | 24213 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 11:38:45 INFO - PROCESS | 24213 | RSS: Main: 246190080 11:38:45 INFO - PROCESS | 24213 | 11:38:45 INFO - PROCESS | 24213 | __start_tp_report 11:38:45 INFO - PROCESS | 24213 | _x_x_mozilla_page_load 11:38:45 INFO - PROCESS | 24213 | _x_x_mozilla_page_load_details 11:38:45 INFO - PROCESS | 24213 | |i|pagename|runs| 11:38:45 INFO - PROCESS | 24213 | |0;ai-astar;102;111;113;111;111;111;111;111;111;110 11:38:45 INFO - PROCESS | 24213 | |1;audio-beat-detection;146;118;127;161;125;118;118;122;145;117 11:38:45 INFO - PROCESS | 24213 | |2;audio-dft;161;160;160;160;161;161;160;161;161;163 11:38:45 INFO - PROCESS | 24213 | |3;audio-fft;74;74;74;108;76;76;75;77;108;74 11:38:45 INFO - PROCESS | 24213 | |4;audio-oscillator;86;81;115;81;81;81;107;82;82;108 11:38:45 INFO - PROCESS | 24213 | |5;imaging-gaussian-blur;117;116;116;116;117;117;117;117;117;116 11:38:45 INFO - PROCESS | 24213 | |6;imaging-darkroom;147;147;145;145;146;145;145;145;146;146 11:38:45 INFO - PROCESS | 24213 | |7;imaging-desaturate;85;85;84;85;84;85;84;84;84;85 11:38:45 INFO - PROCESS | 24213 | |8;json-parse-financial;52;53;52;51;52;53;53;52;51;51 11:38:45 INFO - PROCESS | 24213 | |9;json-stringify-tinderbox;60;60;61;59;60;60;59;59;60;59 11:38:45 INFO - PROCESS | 24213 | |10;stanford-crypto-aes;75;74;79;75;75;74;75;75;74;75 11:38:45 INFO - PROCESS | 24213 | |11;stanford-crypto-ccm;127;122;128;134;131;121;120;124;170;123 11:38:45 INFO - PROCESS | 24213 | |12;stanford-crypto-pbkdf2;156;157;152;152;159;159;157;153;153;158 11:38:45 INFO - PROCESS | 24213 | |13;stanford-crypto-sha256-iterative;62;62;61;62;63;62;62;62;61;67 11:38:45 INFO - PROCESS | 24213 | __end_tp_report 11:38:45 INFO - PROCESS | 24213 | __start_cc_report 11:38:46 INFO - PROCESS | 24213 | _x_x_mozilla_cycle_collect,1571 11:38:46 INFO - PROCESS | 24213 | __end_cc_report 11:38:46 INFO - PROCESS | 24213 | __startTimestamp1484854725991__endTimestamp 11:38:46 INFO - PROCESS | 24213 | 11:38:46 INFO - PROCESS | 24213 | ------- Summary: start ------- 11:38:46 INFO - PROCESS | 24213 | Number of tests: 14 11:38:46 INFO - PROCESS | 24213 | 11:38:46 INFO - PROCESS | 24213 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.97 (2.7%) stddev-sans-first:0.78 11:38:46 INFO - PROCESS | 24213 | Values: 102.0 111.0 113.0 111.0 111.0 111.0 111.0 111.0 111.0 110.0 11:38:46 INFO - PROCESS | 24213 | 11:38:46 INFO - PROCESS | 24213 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:126.00 stddev:15.42 (12.2%) stddev-sans-first:15.19 11:38:46 INFO - PROCESS | 24213 | Values: 146.0 118.0 127.0 161.0 125.0 118.0 118.0 122.0 145.0 117.0 11:38:46 INFO - PROCESS | 24213 | 11:38:46 INFO - PROCESS | 24213 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 11:38:46 INFO - PROCESS | 24213 | Values: 161.0 160.0 160.0 160.0 161.0 161.0 160.0 161.0 161.0 163.0 11:38:46 INFO - PROCESS | 24213 | 11:38:46 INFO - PROCESS | 24213 | [#3] audio-fft Cycles:10 Average:81.60 Median:74.50 stddev:13.95 (18.7%) stddev-sans-first:14.53 11:38:46 INFO - PROCESS | 24213 | Values: 74.0 74.0 74.0 108.0 76.0 76.0 75.0 77.0 108.0 74.0 11:38:46 INFO - PROCESS | 24213 | 11:38:46 INFO - PROCESS | 24213 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:81.00 stddev:13.76 (17.0%) stddev-sans-first:14.50 11:38:46 INFO - PROCESS | 24213 | Values: 86.0 81.0 115.0 81.0 81.0 81.0 107.0 82.0 82.0 108.0 11:38:46 INFO - PROCESS | 24213 | 11:38:46 INFO - PROCESS | 24213 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:38:46 INFO - PROCESS | 24213 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 11:38:46 INFO - PROCESS | 24213 | 11:38:46 INFO - PROCESS | 24213 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 11:38:46 INFO - PROCESS | 24213 | Values: 147.0 147.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 146.0 11:38:46 INFO - PROCESS | 24213 | 11:38:46 INFO - PROCESS | 24213 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 11:38:46 INFO - PROCESS | 24213 | Values: 85.0 85.0 84.0 85.0 84.0 85.0 84.0 84.0 84.0 85.0 11:38:46 INFO - PROCESS | 24213 | 11:38:46 INFO - PROCESS | 24213 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 11:38:46 INFO - PROCESS | 24213 | Values: 52.0 53.0 52.0 51.0 52.0 53.0 53.0 52.0 51.0 51.0 11:38:46 INFO - PROCESS | 24213 | 11:38:46 INFO - PROCESS | 24213 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 11:38:46 INFO - PROCESS | 24213 | Values: 60.0 60.0 61.0 59.0 60.0 60.0 59.0 59.0 60.0 59.0 11:38:46 INFO - PROCESS | 24213 | 11:38:46 INFO - PROCESS | 24213 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:75.00 stddev:1.45 (1.9%) stddev-sans-first:1.54 11:38:46 INFO - PROCESS | 24213 | Values: 75.0 74.0 79.0 75.0 75.0 74.0 75.0 75.0 74.0 75.0 11:38:46 INFO - PROCESS | 24213 | 11:38:46 INFO - PROCESS | 24213 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:127.50 stddev:14.76 (11.6%) stddev-sans-first:15.61 11:38:46 INFO - PROCESS | 24213 | Values: 127.0 122.0 128.0 134.0 131.0 121.0 120.0 124.0 170.0 123.0 11:38:46 INFO - PROCESS | 24213 | 11:38:46 INFO - PROCESS | 24213 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:157.00 stddev:2.84 (1.8%) stddev-sans-first:3.00 11:38:46 INFO - PROCESS | 24213 | Values: 156.0 157.0 152.0 152.0 159.0 159.0 157.0 153.0 153.0 158.0 11:38:46 INFO - PROCESS | 24213 | 11:38:46 INFO - PROCESS | 24213 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:1.71 (2.8%) stddev-sans-first:1.81 11:38:46 INFO - PROCESS | 24213 | Values: 62.0 62.0 61.0 62.0 63.0 62.0 62.0 62.0 61.0 67.0 11:38:46 INFO - PROCESS | 24213 | -------- Summary: end -------- 11:38:46 INFO - PROCESS | 24213 | 11:38:47 INFO - TEST-INFO | 24213: exit 0 11:38:47 INFO - TEST-OK | kraken | took 59859ms 11:38:47 INFO - SUITE-END | took 1174s 11:38:47 INFO - Completed test suite (00:19:35) 11:38:47 INFO - javascript benchmark 11:38:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3225.1292151119196, 3247.464168412212, 3273.378058168947, 3295.6539563345864, 3298.835058247087, 5612.0, 5690.886182276352, 5694.145878118274, 5705.629134106281, 5720.342160651521, 5621.971890140554, 5680.659160450376, 5693.516051135648, 5703.686297253649, 5735.283089613798, 5123.257127716479, 5131.820386286481, 5135.998480296344, 5156.407013193493, 5198.194279886624, 4995.375578052744, 5035.395752509704, 5039.798408063673, 5220.321358223426, 5237.45006774289, 5065.189569668853, 5102.948970510284, 5113.590912726973, 5116.795328186868, 5140.228965655163, 5129.897402051975, 5135.35808023997, 5138.743062846843, 5141.794328226866, 5177.948220517822, 4969.105560999019, 4980.252962055721, 5034.773435195389, 5067.34124563808, 5076.390833100052, 5587.413321601254, 5599.32808063035, 5610.074337734269, 5663.4336566343445, 5668.348139963916, 5920.526357891402, 5947.345791962881, 5948.7620495180145, 5953.791617293374, 5962.4633782959745, 6101.877962440726, 6104.450599446027, 6109.969450152766, 6113.991191453405, 6117.051856962178, 5503.064479038573, 5508.338999320107, 5590.97204513983, 5662.178984047372, 5667.943320566824, 6252.155958945484, 6252.437280644764, 6252.874942501125, 6254.499640028786, 6271.655058971709, 5984.970075149597, 5989.303749652122, 6004.189434426296, 6004.399560044048, 6046.3349031606485, 5802.912956305659, 5853.385394533598, 5965.970170149121, 6020.458158765732, 6061.0, 6037.275526936795, 6067.787627433018, 6085.726142323518, 6106.45041946218, 6116.48009919153, 6029.969850150721, 6030.0, 6051.636901785907, 6060.181875446847, 6080.027195648763, 4542.500324964251, 4567.406237189144, 4597.3333866589155, 4610.654200934943, 4657.301404789308, 4118.588141185857, 4140.109876376593, 4146.91706165875, 4187.602177793105, 4210.810513526837, 5753.194552762617, 5754.4533269339345, 5756.856078597984, 5759.769609215585, 5785.074388097884, 5824.184614154022, 5865.618734782225, 6107.694615269219, 6117.327094019654, 6125.938740612626, 5575.0, 5624.578156638268, 5632.239647647597, 5637.3235211774845, 5643.125315576092, 5166.0, 5166.844994650167, 5170.638055336166, 5179.326687530673, 5201.765920533585, 6206.379362063757, 6250.812475625738, 6317.905231421532, 6324.462420694293, 6345.428911397997, 6078.209832721718, 6085.817425477243, 6088.786892458743, 6091.908621370594, 6097.847553811191, 6107.236595425572, 6311.116443697794, 6316.336784637547, 6321.399467050623, 6322.652254126067, 5848.707564621837, 5870.412958704095, 5906.96628090074, 5908.025175846109, 6015.097735339734, 6032.849178770566, 6072.089186622042, 6096.75612975476, 6099.237595300588, 6107.694615269308, 5951.91072133927, 5952.345242023461, 5958.612690175125, 5961.0, 5962.403759624003, 5770.538356931519, 5820.76716931318, 5899.852503687443, 5906.291245050621, 5928.021876390348, 5959.255093113361, 5973.104034394875, 5975.282966044103, 5980.162777211107, 6001.699915004145, 6008.819735407945, 6018.037114061729, 6018.518518518596, 6019.067044608093, 6020.759169633166, 5523.696196709219, 5540.806071787468, 5630.5777066720975, 5684.232628595087, 5726.484616384545], "value": 5567.547284158122, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.8157389635315, 606.8604221029163, 619.3496828330252, 623.9532035097369, 642.7043559962417, 34142.0, 44536.3319550207, 45247.773761131146, 45253.54746452534, 48897.26654100191, 47261.81845453857, 47413.76293118538, 47756.0, 47791.52208477914, 47833.282500762514, 7910.683572657087, 8098.230668086522, 8797.824043519126, 8998.325125615605, 9007.0, 10510.421926794023, 10762.192835537327, 10763.83854242187, 11054.889451105466, 11082.6121085762, 10791.730206744816, 10811.621593244237, 10841.566337346536, 10846.783064338708, 10867.402292873889, 10752.78494430111, 10786.676399707943, 10788.784224315548, 10816.621418250363, 10830.891691083067, 10802.67591972242, 10835.83746243807, 10863.565457381696, 10864.728381790439, 10865.67402977904, 43639.34540981888, 43977.0, 43985.0, 43987.56012439867, 44116.11767764627, 3476.3047390521997, 3559.60844307126, 3796.658300752918, 3798.3922572388287, 4180.686448516343, 32949.341013179845, 33298.500522492184, 33309.6669033309, 33483.0, 34851.0, 4536.614387777043, 4547.454305483363, 4553.863384098482, 4589.151007063704, 4599.816007359702, 370474.1476292628, 370979.0, 372016.0, 372073.0, 372341.0, 38412.0, 39435.802820985715, 60963.0, 61403.0, 61404.385956139864, 41338.0, 41418.0, 41514.0, 41735.86980976439, 41743.582564174576, 16340.346386144658, 16407.0, 16446.67106657884, 16452.424165154163, 16464.259108340153, 12456.937715311366, 12792.2964236966, 12802.42389092493, 13165.144265622705, 13794.448222071205, 9223.584938677775, 9424.90575094254, 9433.29250306216, 9544.761380965532, 9678.661246856467, 3561.4835848802295, 3594.3350480161253, 3666.3400587893902, 3689.9262014760093, 3698.0939669780537, 1012.281280290987, 1040.54216144896, 1053.9262251642465, 1094.4199574225672, 1143.1483544759208, 33409.3318133636, 33839.66160338414, 34127.14682132967, 34165.0, 34168.48747268793, 1141.2125633312987, 1150.8216226484908, 1157.976840463186, 1171.2328424881716, 1236.2273579013117, 17628.17637148467, 17801.198946047458, 17821.643567128584, 17891.361133278067, 17913.283468661106, 160756.0, 577413.0, 588982.0, 591044.0, 858218.0, 61648.0, 62578.0613290801, 62588.37411625825, 62628.0, 62632.0, 1320.914140580859, 1355.898307626932, 1393.4356585582855, 1426.3438818143563, 1455.5560554031122, 32031.0, 34202.48696269508, 34574.0, 34666.65333346634, 34751.82624086965, 52383.73808130935, 52988.470115298354, 52991.0, 53003.46996529985, 53095.73452132715, 412801.0, 415917.0, 417394.0, 417422.0, 418091.0, 29614.703852961196, 32216.0, 32455.188620284684, 32601.34797303993, 32833.671663283065, 50281.74859125681, 50720.0, 50775.0, 51606.48393516017, 51772.74113629408, 41941.370879436225, 42308.1538369237, 42390.5760942399, 42568.57431425646, 43804.56195438005, 41602.37596436116, 41981.37027944522, 42372.15255694807, 43332.13335733331, 44274.0, 41234.587654123075, 41945.37081943712, 42623.0, 43037.78481107575, 43068.0, 35704.82147589245, 38286.42570361502, 38645.420318695804, 38713.61286387213, 39244.0, 28756.281092972844, 28866.855665721538, 29424.705752943053, 29449.705502944696, 29463.26341841471], "value": 20130.132656250193, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.98541813158596, 432.60200615433797, 436.1386262132289, 443.87793356826876, 451.7537941821709, 16400.425985090526, 18928.24287028519, 20621.690674639856, 20698.89650551747, 20774.48063798406, 19653.60692786147, 20036.799632003676, 20187.0, 20392.69410958833, 20593.38219853403, 5640.520555752756, 5863.179154918314, 5871.471567558919, 5873.676947767871, 5877.030290002144, 4171.218492634766, 4500.414946057008, 4526.366308716782, 6445.967770161166, 6544.672766361663, 6454.386833250857, 6503.609783412987, 6507.05647681086, 6511.739530418801, 6512.6092434454085, 6362.554621176497, 6478.611283322992, 6489.772857949996, 6501.187351581052, 6503.991881258389, 5642.633228840154, 5787.88424231513, 5822.592418530662, 5825.79609713658, 5831.387704291031, 23553.764462355328, 23642.881785590962, 23727.050917963432, 23777.405564860845, 23821.928013239445, 2422.5397174536956, 2485.875706214682, 2542.5931850903953, 2651.9922429476674, 2919.649642042947, 8064.879026814602, 10364.585416583328, 15260.389584416722, 15404.614884627861, 15592.064476131469, 1904.5143488410367, 1995.1520603743352, 2036.8370530357536, 2041.2447394463995, 2066.2664754012408, 84976.57511712401, 85697.14302856954, 85876.57061714714, 86726.56636716776, 86972.56513717391, 9936.503174841373, 11100.556927599522, 11396.11964025943, 11475.139364547693, 11638.1271404645, 14624.926875365767, 14877.107373557621, 15760.842391575938, 15818.0, 16378.26297816601, 8541.487510749375, 8751.56242187888, 8925.910740892637, 8947.776305592282, 9087.681931132378, 8610.784730381665, 8658.610362533702, 8675.956620216859, 8869.423487473294, 8937.642494300286, 6716.798496045127, 6848.554843935129, 6912.205096413977, 6948.44412447003, 7143.785686429415, 1996.5707372914892, 2026.1490174126902, 2066.4730493724005, 2092.7174831397565, 2110.5778844231213, 467.0658682634731, 471.9764011799465, 949.7625593601599, 1051.7896420715888, 1122.141561705296, 11932.28406295625, 12604.180728252633, 12649.747005059848, 12737.93631031839, 12745.36273186337, 498.6110833549837, 500.20966872341614, 505.7521814310961, 515.7318194538818, 524.2372348233312, 6540.738370465128, 6656.667166641745, 6707.731690732316, 6807.3873351398615, 6820.04519367289, 471224.0, 484437.0, 488013.0, 489116.0, 493509.0, 79446.0, 81236.18763812404, 97807.51096244474, 99426.52580633889, 101728.0, 451.51462178158613, 458.6651744226733, 458.73851904414164, 460.07065727230804, 460.8433132734886, 10921.344719316867, 11006.339619622848, 11042.723931901766, 11044.447777611247, 11094.5562177512, 29907.70092299049, 40546.797266013484, 42175.0, 42785.786071069444, 43170.784146079066, 56822.7158864203, 58609.0, 59285.11072334005, 59394.70302648459, 59704.70147649234, 8291.461055031645, 8394.58027098655, 8524.872126917977, 8629.13708629132, 8908.777280568038, 12568.37158142071, 13377.063605547908, 13383.19700817954, 13507.797383039066, 13567.59297221085, 9821.656242031495, 11574.826377604175, 11661.6501504955, 11685.065194784567, 11922.344271064827, 11369.54521819118, 11425.37160456183, 11591.826122608336, 11613.129015323715, 11664.125190610568, 11526.59656912004, 11635.069194464253, 11922.344271064827, 12009.159358844798, 12056.819147712968, 7770.572618506037, 8160.551169685724, 8230.753077407688, 8234.464759790595, 8921.509316987369, 8167.060788009455, 8632.395732298679, 8639.827203456021, 8677.479351238946, 9365.29760267969], "value": 8733.363108769585, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.1189110316013, 1535.393519559774, 1709.1368858726348, 1807.7288406738996, 1831.0753069699808, 8142.877856832145, 8654.091320411344, 8659.393842431033, 8672.739817805461, 8683.131686831313, 7218.6751596178165, 7456.627168641559, 7954.244346787061, 8172.877406838902, 8492.830143397145, 2392.7487613800517, 2421.443068094339, 2423.745506721795, 2423.987880060606, 2426.684531010966, 2435.330284171849, 2461.10169788027, 2492.3519884829893, 2497.4880149569385, 2501.562226610345, 2057.341650671786, 2121.0, 2129.329261282691, 2133.391983284764, 2346.9882650586724, 2430.732619411863, 2461.692288463942, 2464.2484042367073, 2465.815063870199, 2467.111839737693, 2422.9636555451684, 2427.3082171581013, 2457.8525288482747, 2480.6403071554705, 2481.4788894332214, 8467.915320846774, 8564.743057708216, 8615.65537378504, 8620.396572239946, 8626.094260102662, 5166.250893620441, 5305.761240744176, 5307.522322990911, 5309.495597918191, 5310.495502927216, 3340.5824271966003, 3458.4032606089636, 3482.0598438421484, 3566.589842168132, 3570.6072332043454, 1047.743302890789, 1048.6801525534709, 1049.632628579991, 2064.607724532334, 2138.433315171481, 11197.944010279978, 11214.215004949576, 11243.381614011227, 11265.042471389941, 11270.154738394653, 4332.631726303236, 4462.241418958784, 4541.477730061085, 4563.406757121553, 4591.95408045922, 9395.953020234992, 9401.294902882175, 9401.294902882311, 9411.576479058458, 9415.764605884908, 5277.868053298698, 5312.150055991023, 5313.548348390353, 5325.760340784674, 5331.866703332447, 4636.9536304637195, 4798.808047678123, 4831.565159135695, 4915.803367865316, 4967.552920237196, 3852.056246219638, 3873.8450461981206, 3880.96119038806, 3945.2898478274187, 3951.6641085508054, 1188.102982248397, 1209.9395030248452, 1215.1129675337054, 1223.2232532342027, 1229.7847876621556, 793.262266092528, 865.2213008292462, 931.3759780946782, 971.0, 1011.0698157694939, 5793.188953546507, 5879.0, 5953.970230148821, 5990.73041713124, 6134.834381467507, 933.0, 934.6635211323918, 936.3913456253354, 1008.8436292374694, 1054.509653011338, 3891.3579259422445, 3986.581408952018, 4028.8992775180855, 4059.0664147245707, 4145.647619952338, 10188.643397481053, 10660.893391066145, 10675.145988320915, 10696.732581685521, 10698.358098514114, 10568.947155264328, 10597.516347711327, 10602.0, 10602.522886470128, 10656.893431065746, 7633.694652213961, 7860.7248746294745, 7963.522188668699, 8095.069067057246, 8121.512709237465, 5536.114221724505, 5730.08318669011, 5755.65466072037, 5767.192593037062, 5820.097884827858, 9546.0, 9692.224622030362, 9723.805523889341, 9785.119339259216, 9797.951010244904, 9690.563924623268, 9766.36518626287, 9861.309708320348, 10011.449370284705, 10017.0, 7679.884801728091, 7842.686292548462, 7844.529328240324, 7857.724979625686, 7862.764117076496, 8173.305269051959, 8229.711960081368, 8238.794030149054, 8239.876401853857, 8243.587820609066, 7302.19675835647, 7454.552726836408, 7504.061992250969, 7590.886136708064, 7639.656215470206, 7328.633568321456, 7340.596267205355, 7423.851522969619, 7474.850502990019, 7476.065491813523, 6750.8649827004165, 6856.382925536725, 6862.382385585322, 6862.588244705334, 6862.970554416877, 4582.0, 4648.511906249795, 4721.5750582447745, 4745.0509898019845, 4828.589569886599, 4832.855014349575, 4854.417469903634, 4957.03337849116, 4996.775145118406, 5041.319421878], "value": 4595.588815476308, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.13849774622065, 338.24064974133074, 359.98740044098446, 360.36036036036035, 364.47697554009994, 5147.22791581263, 5213.791448342066, 5394.973025134874, 5455.645383050099, 5479.671219726819, 5357.678539287635, 5359.14253719404, 5377.354717433914, 5393.946060539393, 5394.487523685253, 4260.424842646234, 4283.250431174548, 4288.919873861175, 4299.204647140289, 4301.419308393358, 4188.560201178878, 4269.398975384231, 4284.421603083575, 4304.375865499501, 4321.286987647034, 4224.577542245766, 4240.809163587646, 4265.848220980333, 4279.61483466488, 4284.807183676727, 4114.835406583733, 4243.851465198703, 4278.7860606969525, 4283.571642835723, 4284.571542845706, 3773.3208022555928, 3796.1458671798623, 3805.219929914361, 3806.6764325032404, 3835.846566137351, 5273.31446911899, 5274.182501712241, 5283.233931080011, 5290.206469029637, 5317.096093664087, 4738.336632871401, 4860.198067318888, 4864.586510146642, 4871.853844384674, 4891.608671306322, 5595.21666966625, 5637.182608521783, 5650.6892120933335, 5656.858578535528, 5675.035244008528, 4152.875413737593, 4153.013107416883, 4163.709250132469, 4166.208420400114, 4169.2703776839235, 5494.203340515643, 5680.744366503517, 5837.182794408786, 5958.40415958405, 5959.851003724898, 4198.6011328923705, 4206.326987681956, 4211.515675697273, 4220.5146408163455, 4220.831166753357, 4261.21167583998, 4282.807273672693, 4298.570142985676, 4309.504406993173, 4312.266914624522, 4759.881002974953, 4765.142274390573, 4839.435099397325, 4839.879003024953, 4902.828401006019, 5608.775648973995, 5619.7471113799975, 5621.558968414906, 5621.606487545832, 5643.633163844337, 1413.1662319231702, 1430.5851303121979, 1431.355889849572, 1438.3167995202405, 1443.2999995002415, 924.8057907839429, 965.8551217317319, 972.4214092614883, 973.177664873181, 982.5627595719978, 5259.500347466985, 5283.445238250005, 5294.602904782157, 5296.814611488579, 5304.708241046702, 5510.197963405238, 5574.637648552831, 5576.1356989666665, 5616.775328986876, 5631.0, 5050.671706339076, 5225.27565903251, 5275.788968441296, 5321.5476684482255, 5331.747039445727, 2956.6895475975143, 2966.3325751705693, 2966.9406611867644, 2980.8211507309197, 2981.8061825981677, 5776.274303074493, 5792.536597072309, 5809.622374545641, 5836.212111364996, 5840.474357307863, 5642.238297829823, 5947.1079338099635, 6013.458788709037, 6013.969930150409, 6020.036794112921, 6081.418831103856, 6128.3258841527395, 6137.41694539018, 6158.784442544489, 6161.291451483136, 5636.464535869086, 5797.594168408171, 5829.300483941955, 5941.881162376641, 5943.494802941798, 5756.222909907109, 5761.386811692732, 5767.336756273083, 5795.913061304, 5802.941970580409, 5768.3078030634915, 5910.822675319747, 5920.644761314335, 6027.939720602738, 6048.455638992512, 4341.261985462415, 4350.32569951658, 4382.583654552813, 4410.382546443565, 4417.668674849335, 5653.660780353192, 5773.711314434346, 5828.939806601568, 5863.413658634103, 5881.353051164283, 5641.971790141023, 5643.463870932255, 5646.491815736604, 5647.3505546861, 5659.377468478547, 5620.494155526022, 5629.408912064175, 5631.63394379364, 5635.013442875283, 5653.321601407857, 5468.4531546845, 5618.606697531133, 5622.329393538037, 5638.605297629127, 5638.7462564185535, 5675.233843431084, 5681.289838770153, 5687.516561092353, 5692.402297758841, 5693.6299140557385, 5289.867753306198, 5433.538149257357, 5443.727813609383, 5443.911217756386, 5458.890822183614], "value": 4327.078457372289, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.2872271342226, 753.8266198774281, 780.4926797581571, 790.5533373643891, 851.5869803145478, 15495.22523873806, 15607.687846243069, 16467.0, 16502.174891255436, 16505.257263423144, 16089.758653620205, 17061.91469042656, 17070.82929170708, 17088.658226835487, 17091.82908170918, 708.833424145328, 720.0531301338749, 823.625250511016, 841.6254766628853, 864.2351518905782, 835.6740871060291, 855.1448551448551, 855.4610595324937, 855.70050482331, 857.4212406625534, 903.1555495611591, 903.9186473217409, 905.0135352465811, 905.6286922361833, 905.9728208153733, 738.051603689262, 752.2064222245529, 873.5981448533682, 883.8895138107737, 885.2740752582885, 654.3358491131505, 656.1896058367912, 657.0932113683086, 657.1916542652564, 657.3557913244999, 15764.132972686497, 15832.20838958059, 15846.366145354172, 15851.365945362171, 15868.682626347409, 13940.790888136686, 13967.37146828385, 14366.0, 14651.194184319858, 14685.55943321702, 12420.222657509094, 12462.189957652723, 12491.812622810665, 12589.30758808265, 12646.873531264753, 3905.297046531623, 3910.491636087319, 3922.901927451808, 3950.920981580381, 4000.759954402716, 67852.660736696, 68281.65859170722, 68742.31257687409, 69001.65499172472, 69384.6530767348, 11048.558057677763, 11312.547498100148, 11410.14423918193, 11442.0, 11480.28750391169, 20469.0, 20599.0, 20684.896575517025, 20704.378868633965, 21106.78893211048, 8410.49537027768, 8452.070272270046, 8548.957255213809, 8578.742637720878, 8604.956975215084, 4847.297141914402, 4947.0, 4975.776090075955, 5045.672031317952, 5169.379674439091, 3550.7336949728356, 3641.1625326175126, 3655.597884232732, 3658.9634103659155, 3666.926661466756, 591.7100620695828, 595.1994567306965, 603.8218725475995, 607.492743559133, 612.9417705317987, 694.1565997313288, 695.5652717051843, 720.661289194078, 722.342668171961, 756.4137793210197, 8004.399670024772, 8398.958005209935, 8780.604872780741, 8819.338549608805, 8894.42186257891, 657.7763560389491, 702.8875379939185, 740.6370878269717, 745.7389913530221, 762.5920132729075, 4099.672026237894, 4209.24233637942, 4210.578942105826, 4228.450301460791, 4374.993751437188, 55442.72278638581, 70778.64610677016, 71247.64376178086, 73254.26745732581, 92267.5386623076, 46479.76760116178, 46657.76671116623, 46740.532594674296, 46891.29663055057, 63181.05228421577, 62629.68685156545, 63670.68164659147, 64061.03908441377, 65792.0, 67627.0, 8441.451305665112, 8618.525981071101, 8629.8705519416, 8788.824223515367, 8842.159994800484, 42900.57099428966, 43368.81415505133, 43971.34042989422, 44531.55468445274, 45418.0, 55599.444005559424, 60729.39270607237, 61531.0, 61758.691206545474, 61881.0, 12162.209456385306, 12413.255204687748, 12529.812052819398, 12589.181703189264, 12691.93654031724, 12865.356732163167, 12885.48458061667, 12939.158954667917, 13052.282124483245, 13205.075644704779, 11150.219484635998, 11192.83210751823, 11827.349495777815, 11854.762904741685, 12124.393780310773, 11429.942850285695, 11757.0, 12078.75842483163, 12249.571265005681, 12312.938435307766, 11173.039144626842, 11420.771584568096, 11479.311241325548, 11500.597479088192, 12303.200291980993, 9428.057194280516, 9671.806563868542, 10095.949520252352, 10234.846477302697, 10454.163666906477, 9626.9037309626, 9843.360181588174, 9894.50527473609, 9907.603695852085, 9913.256505762241], "value": 7031.7839567148285, "unit": "score"}], "name": "dromaeo_css", "value": 7178.869825936825, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 113.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 127.0, 161.0, 125.0, 118.0, 118.0, 122.0, 145.0, 117.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 161.0, 161.0, 160.0, 161.0, 161.0, 163.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 108.0, 76.0, 76.0, 75.0, 77.0, 108.0, 74.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 81.0, 115.0, 81.0, 81.0, 81.0, 107.0, 82.0, 82.0, 108.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 51.0, 52.0, 53.0, 53.0, 52.0, 51.0, 51.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 59.0, 60.0, 60.0, 59.0, 59.0, 60.0, 59.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 79.0, 75.0, 75.0, 74.0, 75.0, 75.0, 74.0, 75.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 122.0, 128.0, 134.0, 131.0, 121.0, 120.0, 124.0, 170.0, 123.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 152.0, 152.0, 159.0, 159.0, 157.0, 153.0, 153.0, 158.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 67.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1454.3, "alertThreshold": 2.0}]} 11:38:47 INFO - Return code: 0 11:38:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:38:47 INFO - # TBPL SUCCESS # 11:38:47 INFO - Running post-action listener: _resource_record_post_action 11:38:47 INFO - [mozharness: 2017-01-19 19:38:47.815667Z] Finished run-tests step (success) 11:38:47 INFO - Running post-run listener: _resource_record_post_run 11:38:47 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 356761600; Read time: 0; Write time: 227752 11:38:47 INFO - TinderboxPrint: CPU usage
12.9% 11:38:47 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:38:47 INFO - TinderboxPrint: I/O write bytes / time
356,761,600 / 227,752 11:38:47 INFO - TinderboxPrint: CPU idle
8,274.1 (87.0%) 11:38:47 INFO - TinderboxPrint: CPU user
1,188.7 (12.5%) 11:38:47 INFO - TinderboxPrint: Swap in / out
0 / 0 11:38:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107606016; Read time: 0; Write time: 66576 11:38:47 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 249155584; Read time: 0; Write time: 161176 11:38:48 INFO - Running post-run listener: _upload_blobber_files 11:38:48 INFO - Blob upload gear active. 11:38:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:38:48 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 11:38:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:38:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:38:48 INFO - (blobuploader) - INFO - Open directory for files ... 11:38:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:38:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:38:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:51 INFO - (blobuploader) - INFO - Done attempting. 11:38:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:38:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:38:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:52 INFO - (blobuploader) - INFO - Done attempting. 11:38:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:38:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:38:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:53 INFO - (blobuploader) - INFO - Done attempting. 11:38:53 INFO - (blobuploader) - INFO - Iteration through files over. 11:38:53 INFO - Return code: 0 11:38:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:38:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:38:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80f608bdf441729463cb0f8a5bd8ba64e71e429efe5c80cc7e409f4034036b5fe039ec300bc6c1302642eb228b9a7433fd934f410c6565225a21b9e7e5800136", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe511f83ea8da329e0e7b8ed82b37eb77fc4f5f0a67b8b0fb1db30465b00cdb45eb18b9a4fcb465a492862f3bbb73d908a5b59a925a219949e2bd21a2ef28825", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ebc950731a2687c0340a0f04c92b67f9d55e7604f43ac0819ce9f484bb089d376ada0f044d29ef8ba0b7949bec4fd14ff944513e7988bc14c7808229ba0d489"} 11:38:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:38:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:38:53 INFO - Contents: 11:38:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80f608bdf441729463cb0f8a5bd8ba64e71e429efe5c80cc7e409f4034036b5fe039ec300bc6c1302642eb228b9a7433fd934f410c6565225a21b9e7e5800136", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe511f83ea8da329e0e7b8ed82b37eb77fc4f5f0a67b8b0fb1db30465b00cdb45eb18b9a4fcb465a492862f3bbb73d908a5b59a925a219949e2bd21a2ef28825", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ebc950731a2687c0340a0f04c92b67f9d55e7604f43ac0819ce9f484bb089d376ada0f044d29ef8ba0b7949bec4fd14ff944513e7988bc14c7808229ba0d489"} 11:38:53 INFO - Running post-run listener: copy_logs_to_upload_dir 11:38:53 INFO - Copying logs to upload dir... 11:38:53 INFO - mkdir: /builds/slave/test/build/upload/logs 11:38:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.459650 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-01-19 11:38:53.001656) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 11:38:53.008909) ========= 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=db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80f608bdf441729463cb0f8a5bd8ba64e71e429efe5c80cc7e409f4034036b5fe039ec300bc6c1302642eb228b9a7433fd934f410c6565225a21b9e7e5800136", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe511f83ea8da329e0e7b8ed82b37eb77fc4f5f0a67b8b0fb1db30465b00cdb45eb18b9a4fcb465a492862f3bbb73d908a5b59a925a219949e2bd21a2ef28825", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ebc950731a2687c0340a0f04c92b67f9d55e7604f43ac0819ce9f484bb089d376ada0f044d29ef8ba0b7949bec4fd14ff944513e7988bc14c7808229ba0d489"} build_url:https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011409 build_url: 'https://queue.taskcluster.net/v1/task/O_VKqGxtSwCSm2KW0x3JCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80f608bdf441729463cb0f8a5bd8ba64e71e429efe5c80cc7e409f4034036b5fe039ec300bc6c1302642eb228b9a7433fd934f410c6565225a21b9e7e5800136", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe511f83ea8da329e0e7b8ed82b37eb77fc4f5f0a67b8b0fb1db30465b00cdb45eb18b9a4fcb465a492862f3bbb73d908a5b59a925a219949e2bd21a2ef28825", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ebc950731a2687c0340a0f04c92b67f9d55e7604f43ac0819ce9f484bb089d376ada0f044d29ef8ba0b7949bec4fd14ff944513e7988bc14c7808229ba0d489"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 11:38:53.033424) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:38:53.035601) ========= 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=db0483c52d987ecb441a263b000001ad-1484853489.513931-1565107620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:38:53.115354) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 11:38:53.118697) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 11:38:53.118996) ========= ========= Total master_lag: 0.18 =========