builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1487909312.78 results: success (0) buildid: 20170223182536 builduid: 1056714be5e9476e98c3c7389f52c6a0 revision: 7db9edbfd87ed7caea571d3caa04ba8b00076dc4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 20:08:32.779923) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 20:08:32.780661) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 20:08:32.781154) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 20:08:32.810813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:08:32.811430) ========= 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=ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-23 20:08:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.3M=0s 2017-02-23 20:08:33 (54.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142337 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:08:32.968303) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:08:32.968627) ========= 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=ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018181 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:08:33.020509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:08:33.021016) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7db9edbfd87ed7caea571d3caa04ba8b00076dc4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7db9edbfd87ed7caea571d3caa04ba8b00076dc4 --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=ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-23 20:08:33,212 truncating revision to first 12 chars 2017-02-23 20:08:33,213 Setting DEBUG logging. 2017-02-23 20:08:33,213 attempt 1/10 2017-02-23 20:08:33,213 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7db9edbfd87e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-23 20:08:33,527 unpacking tar archive at: mozilla-beta-7db9edbfd87e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.596693 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:08:33.630927) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 20:08:33.631259) ========= script_repo_revision: 7db9edbfd87ed7caea571d3caa04ba8b00076dc4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 20:08:33.631668) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 20:08:33.631932) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 20:08:33.641996) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-23 20:08:33.642380) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:08:33 INFO - MultiFileLogger online at 20170223 20:08:33 in /builds/slave/test 20:08:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 20:08:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:08:33 INFO - {'append_to_log': False, 20:08:33 INFO - 'base_work_dir': '/builds/slave/test', 20:08:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:08:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:08:33 INFO - 'branch': 'Mozilla-Beta', 20:08:33 INFO - 'buildbot_json_path': 'buildprops.json', 20:08:33 INFO - 'config_files': ('talos/linux_config.py',), 20:08:33 INFO - 'default_actions': ('clobber', 20:08:33 INFO - 'read-buildbot-config', 20:08:33 INFO - 'download-and-extract', 20:08:33 INFO - 'populate-webroot', 20:08:33 INFO - 'create-virtualenv', 20:08:33 INFO - 'install', 20:08:33 INFO - 'run-tests'), 20:08:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:08:33 INFO - 'download_minidump_stackwalk': True, 20:08:33 INFO - 'download_symbols': 'ondemand', 20:08:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:08:33 INFO - 'tooltool.py': '/tools/tooltool.py', 20:08:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:08:33 INFO - '/tools/misc-python/virtualenv.py')}, 20:08:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:08:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:08:33 INFO - 'installer_path': 'installer.exe', 20:08:33 INFO - 'log_level': 'info', 20:08:33 INFO - 'log_name': 'talos', 20:08:33 INFO - 'log_to_console': True, 20:08:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:08:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:08:33 INFO - 'opt_config_files': (), 20:08:33 INFO - 'pip_index': False, 20:08:33 INFO - 'sps_profile': False, 20:08:33 INFO - 'sps_profile_interval': 0, 20:08:33 INFO - 'suite': 'dromaeojs', 20:08:33 INFO - 'system_bits': '32', 20:08:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:08:33 INFO - 'title': 'talos-linux64-ix-035', 20:08:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:08:33 INFO - 'use_talos_json': True, 20:08:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:08:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:08:33 INFO - 'work_dir': 'build'} 20:08:33 INFO - [mozharness: 2017-02-24 04:08:33.935824Z] Running clobber step. 20:08:33 INFO - Running pre-action listener: _resource_record_pre_action 20:08:33 INFO - Running main action method: clobber 20:08:33 INFO - rmtree: /builds/slave/test/build 20:08:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:08:34 INFO - Running post-action listener: _resource_record_post_action 20:08:34 INFO - [mozharness: 2017-02-24 04:08:34.845725Z] Finished clobber step (success) 20:08:34 INFO - [mozharness: 2017-02-24 04:08:34.845824Z] Running read-buildbot-config step. 20:08:34 INFO - Running pre-action listener: _resource_record_pre_action 20:08:34 INFO - Running main action method: read_buildbot_config 20:08:34 INFO - Using buildbot properties: 20:08:34 INFO - { 20:08:34 INFO - "project": "", 20:08:34 INFO - "product": "firefox", 20:08:34 INFO - "script_repo_revision": "production", 20:08:34 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 20:08:34 INFO - "repository": "", 20:08:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 20:08:34 INFO - "buildid": "20170223182536", 20:08:34 INFO - "pgo_build": "True", 20:08:34 INFO - "basedir": "/builds/slave/test", 20:08:34 INFO - "buildnumber": 564, 20:08:34 INFO - "slavename": "talos-linux64-ix-035", 20:08:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:08:34 INFO - "platform": "ubuntu64_hw", 20:08:34 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 20:08:34 INFO - "branch": "mozilla-beta", 20:08:34 INFO - "repo_path": "releases/mozilla-beta", 20:08:34 INFO - "revision": "7db9edbfd87ed7caea571d3caa04ba8b00076dc4", 20:08:34 INFO - "stage_platform": "linux64-pgo", 20:08:34 INFO - "builduid": "1056714be5e9476e98c3c7389f52c6a0", 20:08:34 INFO - "slavebuilddir": "test" 20:08:34 INFO - } 20:08:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 20:08:34 INFO - Running post-action listener: _resource_record_post_action 20:08:34 INFO - [mozharness: 2017-02-24 04:08:34.848245Z] Finished read-buildbot-config step (success) 20:08:34 INFO - [mozharness: 2017-02-24 04:08:34.848332Z] Running download-and-extract step. 20:08:34 INFO - Running pre-action listener: _resource_record_pre_action 20:08:34 INFO - Running main action method: download_and_extract 20:08:34 INFO - mkdir: /builds/slave/test/build/tests 20:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:34 INFO - trying https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 20:08:34 INFO - Downloading https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 20:08:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:08:35 INFO - Downloaded 1327 bytes. 20:08:35 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 20:08:35 INFO - Using the following test package requirements: 20:08:35 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 20:08:35 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:08:35 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 20:08:35 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:08:35 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 20:08:35 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:08:35 INFO - u'jsshell-linux-x86_64.zip'], 20:08:35 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:08:35 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 20:08:35 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 20:08:35 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:08:35 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 20:08:35 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:08:35 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 20:08:35 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:08:35 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 20:08:35 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 20:08:35 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 20:08:35 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:08:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 20:08:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:08:35 INFO - Fetch https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 20:08:36 INFO - Http code: 200 20:08:36 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 20:08:36 INFO - x-amz-cf-id: q87UoBK8hvQujXiF9d2kCmYoyWb_iQ6kGJYffKisQLooxG9GErfEQg== 20:08:36 INFO - x-amz-version-id: j8c2CGvbjTVf.GVysr1vG8GqK.7yc7b3 20:08:36 INFO - Expected file size: 21964219 20:08:36 INFO - Obtained file size: 21964219 20:08:40 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:08:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 20:08:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:08:40 INFO - Fetch https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 20:08:41 INFO - Http code: 200 20:08:41 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 20:08:41 INFO - x-amz-cf-id: tsTSRQUtz7TcVwgjOyVhvKoMkiGO9OHpCiEeFHAsTAuOdymbN1tMxg== 20:08:41 INFO - x-amz-version-id: j8c2CGvbjTVf.GVysr1vG8GqK.7yc7b3 20:08:41 INFO - Expected file size: 21964219 20:08:41 INFO - Obtained file size: 21964219 20:08:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 20:08:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:08:46 INFO - Fetch https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 20:08:46 INFO - Http code: 200 20:08:46 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 20:08:46 INFO - x-amz-cf-id: vmyvuNzlB1yYgwLGnyBuTCh79ux_tIYrd3eInteT3LPGfnTRKiVgsg== 20:08:46 INFO - x-amz-version-id: rGYW8iXo3V2o5EQRgqwQ.5buJbtpYR45 20:08:47 INFO - Expected file size: 14402992 20:08:47 INFO - Obtained file size: 14402992 20:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:48 INFO - trying https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 20:08:48 INFO - Downloading https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 20:08:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:08:51 INFO - Downloaded 57765869 bytes. 20:08:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 20:08:51 INFO - mkdir: /builds/slave/test/properties 20:08:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:08:51 INFO - Writing to file /builds/slave/test/properties/build_url 20:08:51 INFO - Contents: 20:08:51 INFO - build_url:https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 20:08:52 INFO - Running post-action listener: _resource_record_post_action 20:08:52 INFO - Running post-action listener: set_extra_try_arguments 20:08:52 INFO - [mozharness: 2017-02-24 04:08:52.358638Z] Finished download-and-extract step (success) 20:08:52 INFO - [mozharness: 2017-02-24 04:08:52.358864Z] Running populate-webroot step. 20:08:52 INFO - Running pre-action listener: _resource_record_pre_action 20:08:52 INFO - Running main action method: populate_webroot 20:08:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:08:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:08:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:08:52 INFO - '--tppagecycles', 20:08:52 INFO - '7'], 20:08:52 INFO - 'tests': ['tsvgm']}}, 20:08:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:08:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:08:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:08:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:08:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:08:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:08:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:52 INFO - 'talos_options': ['--disable-e10s'], 20:08:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:52 INFO - 'talos_options': ['--disable-e10s'], 20:08:52 INFO - 'tests': ['damp', 'tps']}, 20:08:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:52 INFO - 'tests': ['damp', 'tps']}, 20:08:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:08:52 INFO - 'tests': ['dromaeo_dom']}, 20:08:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:08:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:08:52 INFO - 'tests': ['basic_compositor_video']}, 20:08:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:08:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:08:52 INFO - 'tests': ['a11yr', 20:08:52 INFO - 'ts_paint', 20:08:52 INFO - 'tpaint', 20:08:52 INFO - 'sessionrestore', 20:08:52 INFO - 'sessionrestore_no_auto_restore', 20:08:52 INFO - 'tabpaint']}, 20:08:52 INFO - 'other-e10s': {'tests': ['a11yr', 20:08:52 INFO - 'ts_paint', 20:08:52 INFO - 'tpaint', 20:08:52 INFO - 'sessionrestore', 20:08:52 INFO - 'sessionrestore_no_auto_restore', 20:08:52 INFO - 'tabpaint']}, 20:08:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:08:52 INFO - 'ts_paint', 20:08:52 INFO - 'tpaint', 20:08:52 INFO - 'sessionrestore', 20:08:52 INFO - 'sessionrestore_no_auto_restore', 20:08:52 INFO - 'tabpaint']}, 20:08:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:08:52 INFO - 'ts_paint', 20:08:52 INFO - 'tpaint', 20:08:52 INFO - 'sessionrestore', 20:08:52 INFO - 'sessionrestore_no_auto_restore', 20:08:52 INFO - 'tabpaint']}, 20:08:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:08:52 INFO - 'tests': ['a11yr', 20:08:52 INFO - 'ts_paint', 20:08:52 INFO - 'tpaint', 20:08:52 INFO - 'sessionrestore', 20:08:52 INFO - 'sessionrestore_no_auto_restore', 20:08:52 INFO - 'tabpaint']}, 20:08:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:08:52 INFO - 'tests': ['a11yr', 20:08:52 INFO - 'ts_paint', 20:08:52 INFO - 'tpaint', 20:08:52 INFO - 'sessionrestore', 20:08:52 INFO - 'sessionrestore_no_auto_restore', 20:08:52 INFO - 'tabpaint']}, 20:08:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:08:52 INFO - 'tests': ['tsvgx', 20:08:52 INFO - 'tsvgr_opacity', 20:08:52 INFO - 'tart', 20:08:52 INFO - 'tscrollx', 20:08:52 INFO - 'cart']}, 20:08:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:08:52 INFO - 'tsvgr_opacity', 20:08:52 INFO - 'tart', 20:08:52 INFO - 'tscrollx', 20:08:52 INFO - 'cart']}, 20:08:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:52 INFO - 'talos_options': ['--disable-e10s'], 20:08:52 INFO - 'tests': ['tp5o']}, 20:08:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:52 INFO - 'tests': ['tp5o']}, 20:08:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:52 INFO - 'talos_options': ['--disable-e10s', 20:08:52 INFO - '--xperf_path', 20:08:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:52 INFO - 'tests': ['tp5n']}, 20:08:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:52 INFO - 'talos_options': ['--xperf_path', 20:08:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:52 INFO - 'tests': ['tp5n']}}, 20:08:52 INFO - 'talos.zip': {'path': '', 20:08:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:08:52 INFO - Running post-action listener: _resource_record_post_action 20:08:52 INFO - [mozharness: 2017-02-24 04:08:52.375279Z] Finished populate-webroot step (success) 20:08:52 INFO - [mozharness: 2017-02-24 04:08:52.375366Z] Running create-virtualenv step. 20:08:52 INFO - Running pre-action listener: _resource_record_pre_action 20:08:52 INFO - Running main action method: create_virtualenv 20:08:52 INFO - Creating virtualenv /builds/slave/test/build/venv 20:08:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:08:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:08:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:08:52 INFO - Using real prefix '/usr' 20:08:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:08:52 INFO - Installing distribute.............................................................................................................................................................................................done. 20:08:54 INFO - Installing pip.................done. 20:08:54 INFO - Return code: 0 20:08:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:08:55 INFO - Reading from file tmpfile_stdout 20:08:55 INFO - Output received: 20:08:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:08:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:08: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')]} 20:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f77be9caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:08: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', 'pip>=1.5'] in /builds/slave/test/build 20:08: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 pip>=1.5 20:08:55 INFO - Using env: {'DISPLAY': ':0', 20:08:55 INFO - 'HOME': '/home/cltbld', 20:08:55 INFO - 'LANG': 'en_US.UTF-8', 20:08:55 INFO - 'LANGUAGE': 'en_US:en', 20:08:55 INFO - 'LOGNAME': 'cltbld', 20:08:55 INFO - 'MAIL': '/var/mail/cltbld', 20:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:55 INFO - 'MOZ_NO_REMOTE': '1', 20:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:55 INFO - 'NO_EM_RESTART': '1', 20:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:55 INFO - 'PWD': '/builds/slave/test', 20:08:55 INFO - 'SHELL': '/bin/bash', 20:08:55 INFO - 'SHLVL': '1', 20:08:55 INFO - 'TERM': 'linux', 20:08:55 INFO - 'TMOUT': '86400', 20:08:55 INFO - 'USER': 'cltbld', 20:08:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 20:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:55 INFO - '_': '/tools/buildbot/bin/python'} 20:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:08:55 INFO - Cleaning up... 20:08:55 INFO - Return code: 0 20:08:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:08: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')]} 20:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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', '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 0x7f77be9caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:08: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', 'psutil>=3.1.1'] in /builds/slave/test/build 20:08: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 psutil>=3.1.1 20:08:55 INFO - Using env: {'DISPLAY': ':0', 20:08:55 INFO - 'HOME': '/home/cltbld', 20:08:55 INFO - 'LANG': 'en_US.UTF-8', 20:08:55 INFO - 'LANGUAGE': 'en_US:en', 20:08:55 INFO - 'LOGNAME': 'cltbld', 20:08:55 INFO - 'MAIL': '/var/mail/cltbld', 20:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:55 INFO - 'MOZ_NO_REMOTE': '1', 20:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:55 INFO - 'NO_EM_RESTART': '1', 20:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:55 INFO - 'PWD': '/builds/slave/test', 20:08:55 INFO - 'SHELL': '/bin/bash', 20:08:55 INFO - 'SHLVL': '1', 20:08:55 INFO - 'TERM': 'linux', 20:08:55 INFO - 'TMOUT': '86400', 20:08:55 INFO - 'USER': 'cltbld', 20:08:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 20:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:55 INFO - '_': '/tools/buildbot/bin/python'} 20:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:55 INFO - Downloading/unpacking psutil>=3.1.1 20:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:08:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:57 INFO - Installing collected packages: psutil 20:08:57 INFO - Running setup.py install for psutil 20:08:57 INFO - building 'psutil._psutil_linux' extension 20:08:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:08:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:08:57 INFO - building 'psutil._psutil_posix' extension 20:08:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:08:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:08:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:58 INFO - Successfully installed psutil 20:08:58 INFO - Cleaning up... 20:08:58 INFO - Return code: 0 20:08:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:58 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 0x7f77be9caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:08:58 INFO - Using env: {'DISPLAY': ':0', 20:08:58 INFO - 'HOME': '/home/cltbld', 20:08:58 INFO - 'LANG': 'en_US.UTF-8', 20:08:58 INFO - 'LANGUAGE': 'en_US:en', 20:08:58 INFO - 'LOGNAME': 'cltbld', 20:08:58 INFO - 'MAIL': '/var/mail/cltbld', 20:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:58 INFO - 'MOZ_NO_REMOTE': '1', 20:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:58 INFO - 'NO_EM_RESTART': '1', 20:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:58 INFO - 'PWD': '/builds/slave/test', 20:08:58 INFO - 'SHELL': '/bin/bash', 20:08:58 INFO - 'SHLVL': '1', 20:08:58 INFO - 'TERM': 'linux', 20:08:58 INFO - 'TMOUT': '86400', 20:08:58 INFO - 'USER': 'cltbld', 20:08:58 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 20:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:58 INFO - '_': '/tools/buildbot/bin/python'} 20:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:09:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:09:00 INFO - Installing collected packages: mozsystemmonitor 20:09:00 INFO - Running setup.py install for mozsystemmonitor 20:09:00 INFO - Successfully installed mozsystemmonitor 20:09:00 INFO - Cleaning up... 20:09:00 INFO - Return code: 0 20:09:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:00 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 0x7f77be9caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:09:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:09:00 INFO - Using env: {'DISPLAY': ':0', 20:09:00 INFO - 'HOME': '/home/cltbld', 20:09:00 INFO - 'LANG': 'en_US.UTF-8', 20:09:00 INFO - 'LANGUAGE': 'en_US:en', 20:09:00 INFO - 'LOGNAME': 'cltbld', 20:09:00 INFO - 'MAIL': '/var/mail/cltbld', 20:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:00 INFO - 'MOZ_NO_REMOTE': '1', 20:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:00 INFO - 'NO_EM_RESTART': '1', 20:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:00 INFO - 'PWD': '/builds/slave/test', 20:09:00 INFO - 'SHELL': '/bin/bash', 20:09:00 INFO - 'SHLVL': '1', 20:09:00 INFO - 'TERM': 'linux', 20:09:00 INFO - 'TMOUT': '86400', 20:09:00 INFO - 'USER': 'cltbld', 20:09:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 20:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:00 INFO - '_': '/tools/buildbot/bin/python'} 20:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:00 INFO - Downloading/unpacking jsonschema==2.5.1 20:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:09:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:03 INFO - Downloading functools32-3.2.3-2.tar.gz 20:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:09:03 INFO - warning: no files found matching '*.txt' 20:09:03 INFO - no previously-included directories found matching 'build' 20:09:03 INFO - no previously-included directories found matching 'dist' 20:09:03 INFO - no previously-included directories found matching '.git*' 20:09:03 INFO - Installing collected packages: jsonschema, functools32 20:09:03 INFO - Running setup.py install for functools32 20:09:03 INFO - warning: no files found matching '*.txt' 20:09:03 INFO - no previously-included directories found matching 'build' 20:09:03 INFO - no previously-included directories found matching 'dist' 20:09:03 INFO - no previously-included directories found matching '.git*' 20:09:03 INFO - Successfully installed jsonschema functools32 20:09:03 INFO - Cleaning up... 20:09:03 INFO - Return code: 0 20:09:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:03 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 0x7f77be9caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:09:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:09:03 INFO - Using env: {'DISPLAY': ':0', 20:09:03 INFO - 'HOME': '/home/cltbld', 20:09:03 INFO - 'LANG': 'en_US.UTF-8', 20:09:03 INFO - 'LANGUAGE': 'en_US:en', 20:09:03 INFO - 'LOGNAME': 'cltbld', 20:09:03 INFO - 'MAIL': '/var/mail/cltbld', 20:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:03 INFO - 'MOZ_NO_REMOTE': '1', 20:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:03 INFO - 'NO_EM_RESTART': '1', 20:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:03 INFO - 'PWD': '/builds/slave/test', 20:09:03 INFO - 'SHELL': '/bin/bash', 20:09:03 INFO - 'SHLVL': '1', 20:09:03 INFO - 'TERM': 'linux', 20:09:03 INFO - 'TMOUT': '86400', 20:09:03 INFO - 'USER': 'cltbld', 20:09:03 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 20:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:03 INFO - '_': '/tools/buildbot/bin/python'} 20:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:09:03 INFO - Cleaning up... 20:09:03 INFO - Return code: 0 20:09:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:03 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 0x7f77be9caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:09:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:09:03 INFO - Using env: {'DISPLAY': ':0', 20:09:03 INFO - 'HOME': '/home/cltbld', 20:09:03 INFO - 'LANG': 'en_US.UTF-8', 20:09:03 INFO - 'LANGUAGE': 'en_US:en', 20:09:03 INFO - 'LOGNAME': 'cltbld', 20:09:03 INFO - 'MAIL': '/var/mail/cltbld', 20:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:03 INFO - 'MOZ_NO_REMOTE': '1', 20:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:03 INFO - 'NO_EM_RESTART': '1', 20:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:03 INFO - 'PWD': '/builds/slave/test', 20:09:03 INFO - 'SHELL': '/bin/bash', 20:09:03 INFO - 'SHLVL': '1', 20:09:03 INFO - 'TERM': 'linux', 20:09:03 INFO - 'TMOUT': '86400', 20:09:03 INFO - 'USER': 'cltbld', 20:09:03 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 20:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:03 INFO - '_': '/tools/buildbot/bin/python'} 20:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:03 INFO - Downloading/unpacking blobuploader==1.2.4 20:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:05 INFO - Downloading blobuploader-1.2.4.tar.gz 20:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:09:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:09:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:06 INFO - Downloading docopt-0.6.1.tar.gz 20:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:09:06 INFO - Installing collected packages: blobuploader, requests, docopt 20:09:06 INFO - Running setup.py install for blobuploader 20:09:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:09:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:09:06 INFO - Running setup.py install for requests 20:09:07 INFO - Running setup.py install for docopt 20:09:07 INFO - Successfully installed blobuploader requests docopt 20:09:07 INFO - Cleaning up... 20:09:07 INFO - Return code: 0 20:09:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:07 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 0x7f77be9caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:09:07 INFO - Using env: {'DISPLAY': ':0', 20:09:07 INFO - 'HOME': '/home/cltbld', 20:09:07 INFO - 'LANG': 'en_US.UTF-8', 20:09:07 INFO - 'LANGUAGE': 'en_US:en', 20:09:07 INFO - 'LOGNAME': 'cltbld', 20:09:07 INFO - 'MAIL': '/var/mail/cltbld', 20:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:07 INFO - 'MOZ_NO_REMOTE': '1', 20:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:07 INFO - 'NO_EM_RESTART': '1', 20:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:07 INFO - 'PWD': '/builds/slave/test', 20:09:07 INFO - 'SHELL': '/bin/bash', 20:09:07 INFO - 'SHLVL': '1', 20:09:07 INFO - 'TERM': 'linux', 20:09:07 INFO - 'TMOUT': '86400', 20:09:07 INFO - 'USER': 'cltbld', 20:09:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 20:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:07 INFO - '_': '/tools/buildbot/bin/python'} 20:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:07 INFO - Running setup.py (path:/tmp/pip-O76GPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:07 INFO - Running setup.py (path:/tmp/pip-74zKeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:07 INFO - Running setup.py (path:/tmp/pip-5yp9wN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:07 INFO - Running setup.py (path:/tmp/pip-Qd78HH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:07 INFO - Running setup.py (path:/tmp/pip-fI4v4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:07 INFO - Running setup.py (path:/tmp/pip-XWEqiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:07 INFO - Running setup.py (path:/tmp/pip-LLx49N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:07 INFO - Running setup.py (path:/tmp/pip-MYz1Nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:07 INFO - Running setup.py (path:/tmp/pip-Ev26cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:08 INFO - Running setup.py (path:/tmp/pip-3RlPD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:08 INFO - Running setup.py (path:/tmp/pip-q5s8AE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:08 INFO - Running setup.py (path:/tmp/pip-zukxqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:08 INFO - Running setup.py (path:/tmp/pip-I9oWbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:08 INFO - Running setup.py (path:/tmp/pip-QncsGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:08 INFO - Running setup.py (path:/tmp/pip-TzmS1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:08 INFO - Running setup.py (path:/tmp/pip-Eztu4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:08 INFO - Running setup.py (path:/tmp/pip-B1AzUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:09:08 INFO - Running setup.py install for manifestparser 20:09:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:09:08 INFO - Running setup.py install for mozcrash 20:09:08 INFO - Running setup.py install for mozdebug 20:09:08 INFO - Running setup.py install for mozdevice 20:09:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:09:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:09:09 INFO - Running setup.py install for mozfile 20:09:09 INFO - Running setup.py install for mozhttpd 20:09:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:09:09 INFO - Running setup.py install for mozinfo 20:09:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:09:09 INFO - Running setup.py install for mozInstall 20:09:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:09:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:09:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:09:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:09:09 INFO - Running setup.py install for mozleak 20:09:09 INFO - Running setup.py install for mozlog 20:09:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:09:09 INFO - Running setup.py install for moznetwork 20:09:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:09:09 INFO - Running setup.py install for mozprocess 20:09:09 INFO - Running setup.py install for mozprofile 20:09:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:09:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:09:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:09:09 INFO - Running setup.py install for mozrunner 20:09:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:09:10 INFO - Running setup.py install for mozscreenshot 20:09:10 INFO - Running setup.py install for moztest 20:09:10 INFO - Running setup.py install for mozversion 20:09:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:09:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:09:10 INFO - Cleaning up... 20:09:10 INFO - Return code: 0 20:09:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:10 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 0x7f77be9caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:09:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:09:10 INFO - Using env: {'DISPLAY': ':0', 20:09:10 INFO - 'HOME': '/home/cltbld', 20:09:10 INFO - 'LANG': 'en_US.UTF-8', 20:09:10 INFO - 'LANGUAGE': 'en_US:en', 20:09:10 INFO - 'LOGNAME': 'cltbld', 20:09:10 INFO - 'MAIL': '/var/mail/cltbld', 20:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:10 INFO - 'MOZ_NO_REMOTE': '1', 20:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:10 INFO - 'NO_EM_RESTART': '1', 20:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:10 INFO - 'PWD': '/builds/slave/test', 20:09:10 INFO - 'SHELL': '/bin/bash', 20:09:10 INFO - 'SHLVL': '1', 20:09:10 INFO - 'TERM': 'linux', 20:09:10 INFO - 'TMOUT': '86400', 20:09:10 INFO - 'USER': 'cltbld', 20:09:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 20:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:10 INFO - '_': '/tools/buildbot/bin/python'} 20:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:10 INFO - Running setup.py (path:/tmp/pip-rzQozC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:10 INFO - Running setup.py (path:/tmp/pip-YblacB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:10 INFO - Running setup.py (path:/tmp/pip-Cl8_46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:10 INFO - Running setup.py (path:/tmp/pip-o8mMAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:10 INFO - Running setup.py (path:/tmp/pip-aBG07c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:11 INFO - Running setup.py (path:/tmp/pip-oH6LRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:11 INFO - Running setup.py (path:/tmp/pip-stABa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:11 INFO - Running setup.py (path:/tmp/pip-fh8zza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:11 INFO - Running setup.py (path:/tmp/pip-Wz8rEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:11 INFO - Running setup.py (path:/tmp/pip-wrBd6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:11 INFO - Running setup.py (path:/tmp/pip-3OMJbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:11 INFO - Running setup.py (path:/tmp/pip-RVuDEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:11 INFO - Running setup.py (path:/tmp/pip-Ic5zKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:11 INFO - Running setup.py (path:/tmp/pip-F8kj_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:11 INFO - Running setup.py (path:/tmp/pip-vuidPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:11 INFO - Running setup.py (path:/tmp/pip-wkaWNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:11 INFO - Running setup.py (path:/tmp/pip-6Fo8hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:09:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:13 INFO - Downloading blessings-1.6.tar.gz 20:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:09:13 INFO - Installing collected packages: blessings 20:09:13 INFO - Running setup.py install for blessings 20:09:14 INFO - Successfully installed blessings 20:09:14 INFO - Cleaning up... 20:09:14 INFO - Return code: 0 20:09:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:14 INFO - Reading from file tmpfile_stdout 20:09:14 INFO - Current package versions: 20:09:14 INFO - argparse == 1.2.1 20:09:14 INFO - blessings == 1.6 20:09:14 INFO - blobuploader == 1.2.4 20:09:14 INFO - docopt == 0.6.1 20:09:14 INFO - functools32 == 3.2.3-2 20:09:14 INFO - jsonschema == 2.5.1 20:09:14 INFO - manifestparser == 1.1 20:09:14 INFO - mozInstall == 1.12 20:09:14 INFO - mozcrash == 1.0 20:09:14 INFO - mozdebug == 0.1 20:09:14 INFO - mozdevice == 0.48 20:09:14 INFO - mozfile == 1.2 20:09:14 INFO - mozhttpd == 0.7 20:09:14 INFO - mozinfo == 0.9 20:09:14 INFO - mozleak == 0.1 20:09:14 INFO - mozlog == 3.4 20:09:14 INFO - moznetwork == 0.27 20:09:14 INFO - mozprocess == 0.23 20:09:14 INFO - mozprofile == 0.28 20:09:14 INFO - mozrunner == 6.13 20:09:14 INFO - mozscreenshot == 0.1 20:09:14 INFO - mozsystemmonitor == 0.3 20:09:14 INFO - moztest == 0.8 20:09:14 INFO - mozversion == 1.4 20:09:14 INFO - psutil == 3.1.1 20:09:14 INFO - requests == 1.2.3 20:09:14 INFO - wsgiref == 0.1.2 20:09:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:14 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 0x7f77be9caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:09:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:09:14 INFO - Using env: {'DISPLAY': ':0', 20:09:14 INFO - 'HOME': '/home/cltbld', 20:09:14 INFO - 'LANG': 'en_US.UTF-8', 20:09:14 INFO - 'LANGUAGE': 'en_US:en', 20:09:14 INFO - 'LOGNAME': 'cltbld', 20:09:14 INFO - 'MAIL': '/var/mail/cltbld', 20:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:14 INFO - 'MOZ_NO_REMOTE': '1', 20:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:14 INFO - 'NO_EM_RESTART': '1', 20:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:14 INFO - 'PWD': '/builds/slave/test', 20:09:14 INFO - 'SHELL': '/bin/bash', 20:09:14 INFO - 'SHLVL': '1', 20:09:14 INFO - 'TERM': 'linux', 20:09:14 INFO - 'TMOUT': '86400', 20:09:14 INFO - 'USER': 'cltbld', 20:09:14 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 20:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:14 INFO - '_': '/tools/buildbot/bin/python'} 20:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:09:14 INFO - Cleaning up... 20:09:14 INFO - Return code: 0 20:09:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:14 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 0x7f77be9caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:09:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:09:14 INFO - Using env: {'DISPLAY': ':0', 20:09:14 INFO - 'HOME': '/home/cltbld', 20:09:14 INFO - 'LANG': 'en_US.UTF-8', 20:09:14 INFO - 'LANGUAGE': 'en_US:en', 20:09:14 INFO - 'LOGNAME': 'cltbld', 20:09:14 INFO - 'MAIL': '/var/mail/cltbld', 20:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:14 INFO - 'MOZ_NO_REMOTE': '1', 20:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:14 INFO - 'NO_EM_RESTART': '1', 20:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:14 INFO - 'PWD': '/builds/slave/test', 20:09:14 INFO - 'SHELL': '/bin/bash', 20:09:14 INFO - 'SHLVL': '1', 20:09:14 INFO - 'TERM': 'linux', 20:09:14 INFO - 'TMOUT': '86400', 20:09:14 INFO - 'USER': 'cltbld', 20:09:14 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 20:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:14 INFO - '_': '/tools/buildbot/bin/python'} 20:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:09:14 INFO - Cleaning up... 20:09:14 INFO - Return code: 0 20:09:14 INFO - Running post-action listener: _resource_record_post_action 20:09:14 INFO - Running post-action listener: _start_resource_monitoring 20:09:14 INFO - Starting resource monitoring. 20:09:14 INFO - [mozharness: 2017-02-24 04:09:14.855699Z] Finished create-virtualenv step (success) 20:09:14 INFO - [mozharness: 2017-02-24 04:09:14.856258Z] Running install step. 20:09:14 INFO - Running pre-action listener: _resource_record_pre_action 20:09:14 INFO - Running main action method: install 20:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:15 INFO - Reading from file tmpfile_stdout 20:09:15 INFO - Detecting whether we're running mozinstall >=1.0... 20:09:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:09:15 INFO - Reading from file tmpfile_stdout 20:09:15 INFO - Output received: 20:09:15 INFO - Usage: mozinstall [options] installer 20:09:15 INFO - Options: 20:09:15 INFO - -h, --help show this help message and exit 20:09:15 INFO - -d DEST, --destination=DEST 20:09:15 INFO - Directory to install application into. [default: 20:09:15 INFO - "/builds/slave/test"] 20:09:15 INFO - --app=APP Application being installed. [default: firefox] 20:09:15 INFO - mkdir: /builds/slave/test/build/application 20:09:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:09:28 INFO - Reading from file tmpfile_stdout 20:09:28 INFO - Output received: 20:09:28 INFO - /builds/slave/test/build/application/firefox/firefox 20:09:28 INFO - Running post-action listener: _resource_record_post_action 20:09:28 INFO - [mozharness: 2017-02-24 04:09:28.824526Z] Finished install step (success) 20:09:28 INFO - [mozharness: 2017-02-24 04:09:28.824767Z] Running run-tests step. 20:09:28 INFO - Running pre-action listener: _resource_record_pre_action 20:09:28 INFO - Running main action method: run_tests 20:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:09:28 INFO - Python 2.7.3 20:09:28 INFO - Return code: 0 20:09:28 INFO - grabbing minidump binary from tooltool 20:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:28 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 0x13ccf60>, '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 0x13cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ce1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:09:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:09:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:09:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:09:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:09:28 INFO - Return code: 0 20:09:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:09:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:09:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:09:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:09:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 20:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 20:09:28 INFO - Using env: {'DISPLAY': ':0', 20:09:28 INFO - 'HOME': '/home/cltbld', 20:09:28 INFO - 'LANG': 'en_US.UTF-8', 20:09:28 INFO - 'LANGUAGE': 'en_US:en', 20:09:28 INFO - 'LOGNAME': 'cltbld', 20:09:28 INFO - 'MAIL': '/var/mail/cltbld', 20:09:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:09:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:28 INFO - 'MOZ_NO_REMOTE': '1', 20:09:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:28 INFO - 'NO_EM_RESTART': '1', 20:09:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:28 INFO - 'PWD': '/builds/slave/test', 20:09:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:09:28 INFO - 'SHELL': '/bin/bash', 20:09:28 INFO - 'SHLVL': '1', 20:09:28 INFO - 'TERM': 'linux', 20:09:28 INFO - 'TMOUT': '86400', 20:09:28 INFO - 'USER': 'cltbld', 20:09:28 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443', 20:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:28 INFO - '_': '/tools/buildbot/bin/python'} 20:09:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 20:09:29 INFO - mozversion application_buildid: 20170223182536 20:09:29 INFO - mozversion application_changeset: 7db9edbfd87ed7caea571d3caa04ba8b00076dc4 20:09:29 INFO - mozversion application_display_name: Firefox 20:09:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:09:29 INFO - mozversion application_name: Firefox 20:09:29 INFO - mozversion application_remotingname: firefox 20:09:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:09:29 INFO - mozversion application_vendor: Mozilla 20:09:29 INFO - mozversion application_version: 52.0 20:09:29 INFO - mozversion platform_buildid: 20170223182536 20:09:29 INFO - mozversion platform_changeset: 7db9edbfd87ed7caea571d3caa04ba8b00076dc4 20:09:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:09:29 INFO - mozversion platform_version: 52.0 20:09:29 INFO - using testdate: 1487909369 20:09:29 INFO - actual date: 1487909369 20:09:29 INFO - starting webserver on 'localhost:38717' 20:09:29 INFO - SUITE-START | Running 2 tests 20:09:29 INFO - TEST-START | dromaeo_css 20:09:29 INFO - operating with platform_type : linux_ 20:09:29 INFO - Initialising browser for dromaeo_css test... 20:09:29 INFO - TEST-INFO | started process 17145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIQEpGP/profile http://localhost:38717/getInfo.html) 20:09:32 INFO - PROCESS | 17145 | __metrics Screen width/height:1600/1200 20:09:32 INFO - PROCESS | 17145 | colorDepth:24 20:09:32 INFO - PROCESS | 17145 | Browser inner width/height: 1024/697 20:09:32 INFO - PROCESS | 17145 | __metrics 20:09:33 INFO - PROCESS | 17145 | 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" 20:09:33 INFO - PROCESS | 17145 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:09:33 INFO - PROCESS | 17145 | console.error: PushService: 20:09:33 INFO - PROCESS | 17145 | stateChangeProcessEnqueue: Error transitioning state 20:09:33 INFO - PROCESS | 17145 | UnknownError 20:09:34 INFO - TEST-INFO | 17145: exit 0 20:09:34 INFO - Browser initialized. 20:09:34 INFO - Running cycle 1/1 for dromaeo_css test... 20:09:34 INFO - TEST-INFO | started process 17234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIQEpGP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:46 INFO - PROCESS | 17234 | RSS: Main: 141557760 20:09:46 INFO - PROCESS | 17234 | 20:12:48 INFO - PROCESS | 17234 | Cycle 1(1): loaded http://localhost:38717/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38717/tests/dromaeo/cssquery-ext.html) 20:12:49 INFO - PROCESS | 17234 | RSS: Main: 239390720 20:12:49 INFO - PROCESS | 17234 | 20:15:51 INFO - PROCESS | 17234 | Cycle 1(1): loaded http://localhost:38717/tests/dromaeo/cssquery-ext.html (next: http://localhost:38717/tests/dromaeo/cssquery-jquery.html) 20:15:52 INFO - PROCESS | 17234 | RSS: Main: 232185856 20:15:52 INFO - PROCESS | 17234 | 20:18:54 INFO - PROCESS | 17234 | Cycle 1(1): loaded http://localhost:38717/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38717/tests/dromaeo/cssquery-mootools.html) 20:18:54 INFO - PROCESS | 17234 | RSS: Main: 175685632 20:18:54 INFO - PROCESS | 17234 | 20:21:56 INFO - PROCESS | 17234 | Cycle 1(1): loaded http://localhost:38717/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38717/tests/dromaeo/cssquery-prototype.html) 20:21:57 INFO - PROCESS | 17234 | RSS: Main: 173469696 20:21:57 INFO - PROCESS | 17234 | 20:24:59 INFO - PROCESS | 17234 | Cycle 1(1): loaded http://localhost:38717/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38717/tests/dromaeo/cssquery-yui.html) 20:25:00 INFO - PROCESS | 17234 | RSS: Main: 175357952 20:25:00 INFO - PROCESS | 17234 | 20:28:03 INFO - PROCESS | 17234 | Cycle 1(1): loaded http://localhost:38717/tests/dromaeo/cssquery-yui.html (next: http://localhost:38717/tests/dromaeo/cssquery-dojo.html) 20:28:03 INFO - PROCESS | 17234 | RSS: Main: 268709888 20:28:03 INFO - PROCESS | 17234 | 20:28:03 INFO - PROCESS | 17234 | __start_tp_report 20:28:03 INFO - PROCESS | 17234 | _x_x_mozilla_page_load 20:28:03 INFO - PROCESS | 17234 | _x_x_mozilla_page_load_details 20:28:03 INFO - PROCESS | 17234 | |i|pagename|runs| 20:28:03 INFO - PROCESS | 17234 | |0;dojo.html;3191.313867518483;3204.230984563704;3209.3260415312784;3241.1086951088464;3252.528383384409;5577.414371490996;5649.096144616857;5655.26481557397;5657.547396208303;5658.717064146792;5606.663600183992;5677.716114194284;5682.289713785777;5685.260916080914;5714.371419143901;5087.465816089303;5112.718800465973;5116.411612664554;5155.922661160085;5195.922061169085;4975.751212439382;4986.775595098229;5203.063448579254;5206.45332240115;5219.295395121648;4993.875153121165;4999.775010124553;5031.4465408805;5079.568236699866;5118.232265160219;5099.184130539114;5183.429822719517;5187.896242075138;5196.474568164519;5214.6871187728475;4843.467218605986;5070.645054846163;5099.184130539133;5135.3837539495125;5161.483851614846;5432.456754324576;5445.673259604437;5472.890542189174;5511.53151982082;5555.527780138693;5896.469317761379;5929.436703513159;6005.369436209179;6005.4895333896675;6010.158577799111;6040.788572399989;6053;6056.72744726484;6064.060070689006;6065.727042283108;5387.919181212285;5435.565154787608;5499.50504454593;5546.694931778791;5548.833534993957;6053.727582258809;6109.725062372204;6118.479929205978;6118.724657390429;6146.016637338004;5851.385604511465;5860.120981852756;5886;5891.116332550152;5892.705364731832;5777.480026797609;5835.649861008353;5892.558058145656;5954.940450595439;5961;5994.0409534474275;6004.909926351108;6006.429389208019;6009.849753756191;6027.156198132265;5926.851828704317;5977.252843394575;5987.880242395215;5994.550408719363;5996.340402555716;4535.7732113394195;4573.977130114395;4622.930656040162;4669.626429885601;4674.789634466457;4105.486814148231;4128.02991297045;4141.192467468814;4162.396452514368;4163.188178305262;5707.4577915098;5719.256496655408;5727.341355744143;5735.139729040678;5738.77044918207;5866.530677545786;5928.466438020599;5934.19888315072;6080;6106.145139680449;5608.046632072557;5652.491275785199;5671.801486947937;5682.460166284196;5684.6020778545935;5145.665531740425;5156.355455568054;5159.922601160985;5162.096633089194;5200.011997720421;5875.6474611523445;5926.881462370815;6098.664573448415;6164.660943648053;6185.041318595625;5927.792527261525;5954.821355359346;5962.850928726816;6045.969770151297;6084.969575152096;6151.3541078186145;6155.415235552616;6159.230096237791;6177.81466556004;6185.536084793748;5724.169995350734;5920.437558431942;5936.1986131871645;5941.494972927349;5948.762049517971;5810.273715785527;5927.110933360031;5949;5962.25471816023;6060.333363329942;5837.883242335214;5885.14665373527;5889.499392551681;5895.233619629421;5899.321578018583;5848.912266315923;5871.882562348815;5873.676947767914;5881.470667639933;5890.970545147246;5615.859603509945;5622.662640241599;5685.800996965087;5702;5724.513416359656;5854;5854.619449735754;5856.209411729362;5863.794767183128;5878.647281163144;5606.074997625346;5638.126090455986;5712.0860662293835;5712.457316554921;5718.771249150153 20:28:03 INFO - PROCESS | 17234 | |1;ext.html;583.3903570768547;616.4390404731694;640.9871802563952;644.3459888213463;652.5432197461778;33098.17254568637;44052.339214911764;45148.77425612867;45184.548154518445;45254.77372613132;44999.55000449994;45578;45652;45692.54307456924;45747.54252457475;8222.547759873205;8420.452670576393;8995.595198216064;9125.543722813865;9140.725778226664;10722.785544289109;10947.069499092586;10977.39624320662;11241.819608941025;11261.099112071055;10986.560537578527;10996.890031099667;11056.834147487794;11064.889351106467;11070.778584428306;10894.782104357908;10926.399048052393;10943;10943.45282735868;10950.780984380268;10768.300060496122;10836.566537338496;10841.78316433667;10847.945760271226;10852.186086043499;42224.78887605573;42588;42588.36117458241;42642.78678606618;42716.50492232788;3622.185008373095;3748.4564738113095;3810.733248672594;3841.4621952926614;4176.895577610554;32203.355932881444;32688.346233075445;32781.01656950295;32790.50814237788;33071.173220669436;3933.468981687493;3938.2320447512748;3992.940105898414;4008.07814202735;4063.126427818004;331276;332172;334722;337237;337469;61996;62344.37655623476;62478.37521624726;62532.68733656393;62564.37435625677;64906.675466622364;64976;65077.34922650808;65125.674371627836;65135.674321629034;18901;19148.138333775012;19151.712724309145;19155.90422047881;19158;13028.674283142807;13709.245991470365;14045.929770351082;14324;14558.272086395638;18210.54473638143;18369.448916532525;18560.164792584095;18576.535586610444;18721;6332.715027823759;6357.427831495188;6625.17185351831;6634.369734875179;6646.700898459581;881.378628067211;983.4296108257194;989.6239429016928;1029.2949329709172;1090.51472094917;32866.83566582199;32952.505712414335;32982.67017329844;33023.174420639676;33449.16377090592;1104.690686607751;1125.234840308598;1214.227228246752;1218.750156217991;1248.082659245454;17339.739903901453;17407.3037078518;17543.316522694517;17553.21010554528;17632.382866599608;472960;522527;533985;535685;726200;60681;61151.38848611546;61174.38825611776;61223.38776612177;61319;1358.2461733737673;1395.7696979998186;1400.803887455757;1414.724128794875;1465.3479201755117;31780.364392711555;33238.833805830815;33496;33827.83086084652;33863.83068084644;51746;52124.47875521196;52178.47821521888;52252;52290.21564676609;315496;315544;317037;319012;319194;28885.566716498848;29663.110106696833;29759;29813.254668633457;29820;47140;47197.528024719315;47620.04759904852;47827.76086119547;47847.28229076497;39816.60183398245;39988.2002359957;40163.1967360657;40995.79502102471;41715.582844172386;40508.1898362037;40702.710254259975;41357.37963930603;41387.7930610345;42087.789561052;41070;41071.7946410266;41091.794541027106;41119;41174;34126;36429.45355819718;36993.81503092467;37407.251854963295;37449.6255037457;28078.719212808428;28087.438251234453;28098.438031239668;28335.29161770972;28383.29041773972 20:28:03 INFO - PROCESS | 17234 | |2;jquery.html;413.7455464889094;415.95632458591865;420.30229818501294;431.79273948504726;436.33676811246903;18913.148908299125;19022.92862164034;19508.21967121317;19676.01619919004;19803.306884259055;18414.81585184148;18902.05489725515;18980;19079.141438635295;19126.234950601993;5500.642458240211;5819.388964158766;5851.882962340772;5854.76580936762;5856.882862342751;5630.71846407678;5738.454846789569;5786.392428794979;5811.912821307684;5827.504662103726;5771.624844385123;5805.216295800076;5809.854753631172;5811.418858114197;5818.883622327551;5616.887662246773;5794.768209271624;5801.47786699197;5802.912956305638;5803.73883175256;5239.659422137549;5241.895162096775;5246.186841039645;5247.527722504993;5248.65883717561;22363.44091397712;22412.775872241233;22775.20286789971;23009.884950575306;23036.848157592052;2382.797462215714;2441.4994926040117;2852.657681078263;3018.6830382809926;3230.5800245967876;13117.737645247042;14052.016358854884;14355.928220358832;14485.130892146504;14539.3457294422;1911.44568075258;1947.464447276996;2029.8883561404264;2031.441353627764;2064.865783724068;77350.22649773542;78401.60799196025;79059;79532.60233698852;79694.60152699257;10696.41169735672;10742.409167495864;10777.51501182433;10930.234883558234;11069.5572177112;15988.120653364176;15993.120378379068;16004.279807408695;16006.279717412745;16006.839931600767;8283.58582070894;8423.789405264917;8480.915190848013;8661.263792577576;8700;8379.287760540301;8394.286485648667;8431.620577073923;8531.74404767858;8651.95674021626;6614.173228346457;6759.5606285591275;6767.35710107539;6799.286074962157;6824.18109826824;2038.6432374334431;2054.5582699719334;2055.5272287373987;2055.9177632894816;2073.3676228750073;762.6377470701373;889.8953973851794;1005.703317521333;1037.0770014686934;1051.75283808305;18908.243670253312;19565.413037608894;19667.606647866964;19808.50478738014;20045.49886252826;1032.1897310611134;1033.8242498775226;1044.3159730376615;1050.3907733514543;1117.234694234452;10886.292390994719;11273.323600583992;11374.431278436045;11392.94303528477;11410.429478526206;425116;429143;431405;431909;432813;48968.7551562247;55556.72221638866;77696.61151694205;77733.6113319441;78499.60750196212;1019.938803671782;1042.0621440703276;1042.3485321673954;1042.3954106618144;1056.0812093478569;16882.831171688616;17298.308067677153;17365.56586085358;17722.20250088775;17872.91063544674;38878.61121388863;38884.61115388923;39355.819325420285;39798.2040359197;40313.395299071126;52169.73915130552;52250.73874630602;53044.73477632587;57475;59891.70054149701;8211.79470513218;8510;8518.48889066658;8524.190201930807;8702.303815694602;10921.399323037309;12516.436760345625;12873.613791586267;13031.543895963596;13322.934945083527;11082.944585277022;11322.37726925027;11587.652370428901;11639.709007274885;11729.120315976164;11384;11506.597269095877;11517.366544840113;11564.248323858923;11736.119791015537;11301.434928253719;11379.54481820718;11653.53385864556;11680.70798230051;11816.054715622558;8359.498430094214;8563.015253245956;8652.351073669373;8767.693130740648;8879.689210877847;10923.235373523778;11414.714632133931;11582.247153934968;11630.127740419672;11646.592369267035 20:28:03 INFO - PROCESS | 17234 | |3;mootools.html;1473.0351619689104;1498.9250537473126;1666.6749983753166;1814.0838876367432;1836.6418548383062;8021.358291336694;8495.065542790288;8497.10780368061;8513.957430212848;8522.019967703716;7369.594672293035;7635.961820190892;8022.277994980451;8327.66689332426;8373.246407823295;2438.3782135555452;2469.469064151207;2470.555300045991;2472.418981539337;2474.7772700456953;2393.85636861788;2486.204414587333;2493.6259561065804;2499.5000999800022;2499.900003999847;2418.443757935676;2418.733939266679;2432.975670243293;2453.9631905521433;2456.6192240202795;2400.95198096038;2406.097713357491;2425.890834912433;2430.1373012580457;2436.671049408325;2369.336585755974;2380.976190238093;2399.6160614301803;2401.183597576832;2403.3510952043025;8581.485110893367;8591.183837535487;8663.39356245063;8666.783330416727;8673.826523469495;5330.840074797762;5489.176623506466;5491.533219676332;5495.340559132889;5501.202325662796;3284.753643476749;3302.091924720697;3333.4166520858753;3407.2333724911946;3430.5025771263026;1136.4829002803704;1163.668354518958;1168.9018212308927;1179.3867189061639;1921.8558608104447;11032.834507482394;11505.712357191138;11514.596989105341;11536.25014374063;11568.074554035657;4681.133990211753;4705.12955103307;4767.61859051275;4768.117898188846;4771.379720636295;9371.437713737198;9372.8594071089;9376.390534615228;9378.437293762396;9386.249100071978;5443.346798384219;5448.591355648263;5454.3454785426;5456.208849716848;5460.262864513319;4354.281543545279;4605.332226827091;5080.974595127001;5106.4382917879;5128;3864.053306939818;3944;3961.4255932890146;4013.6989725770686;4036.253293140778;1253.185429470833;1256.221142891395;1259.5591542959892;1271.2753730373784;1273.1469915156868;944.5843828715343;993.2997236947934;995.2088089968348;1002.9919930469831;1003.8644782954208;5418.91871621926;5529.087700529368;5574.526165275915;5693.715314234271;5724.084146536534;1006.808706345792;1018.5314755212537;1019.2966852871494;1075.3977772447297;1100.1199040767353;3587.515685382492;3590.7486475946434;3609.909752256162;3611.5124458198334;3719.1260053887313;10053.396796192252;10498.947505262577;10504.527296271686;10518.579256829642;10530.789384212272;10470.581176752845;10471.581136754598;10477.633282835064;10483.580656773796;10487.108595769292;7910.050793904653;7949.165337639464;8120.106788253287;8129.065157506962;8140.674373025131;5266.736663166903;5295.576353891756;5463.289772329572;5476.2607048048;5539.501444869981;9542.093501117382;9589.664361747584;9622.37454565451;9687.70936871895;9696.70909872705;9241.768955775891;9599.42403455795;9610.038996100613;9658.082482164184;9677.661281855102;6951.409130223786;7126.501144920013;7139.107611548557;7942.205779422012;8251.793705157179;7244;7313.451491138079;7884.881726773988;8130.715424960098;8164.714235001747;7444.478886477895;7450.739224127129;7631.084269887427;7647.311741943252;7767.650455729618;7178.389836863925;7208.639568021683;7239.095113110861;7332.890006650011;7353.632318384166;6677.76627818024;6711.731530738716;6777.491688123312;6803.115594972622;6805.863882722417;4961.7519124044375;5013.147764880052;5063.873403164803;5075.695458272516;5240.580753539632;5122.334096567422;5171.612129090258;5189.896202075862;5199.688018718889;5245.160774276097 20:28:03 INFO - PROCESS | 17234 | |4;prototype.html;350.9613942466329;356.3674477801901;358.83852266480073;359.46798737867937;363.6999475432767;5310.654807437514;5332.92000619991;5333.120115137825;5346.759395827187;5363.6245462817615;5313.57491400688;5352.866178345544;5359.437259087798;5361.276227709258;5364.673902180643;3723.869664561741;4035.9999999999927;4061.8984525386954;4143.1713657268665;4233.23801715691;4222.472190976128;4223.170475781219;4227.450431443908;4235.576442355755;4253.8723838284905;4208.537060923296;4209.6000879916355;4217.114405974749;4218.936715949263;4231.418834510946;4108.82898373962;4201.684873634459;4237.87286381409;4240.703150779446;4244.702870799046;3775.528058992626;3788.5643151037707;3789.1853251550774;3796.2217745362136;3797.6012518685416;5198.818041368571;5203.167493201107;5216.191490319006;5220.738963051832;5250.319897632759;4736.621070314367;4830;4831.516848315176;4862.465128835825;4866.51334866514;5492.764128071192;5518.806841760559;5540.196671482612;5549;5556.722163891789;4149.813258403379;4156.646685031776;4166.291910258356;4166.854160104412;4171.561985991488;5472.753726082336;5520.337559492847;5736.4550367715;5769.88460230793;5772.2496075510335;3931.783751893616;4245.834624341546;4246.299360605527;4252.978735106305;4272.10285839977;4292.5492823253735;4292.828286868553;4306.935395969063;4314.460692413449;4339.609435150788;4548.0216105993995;4836.3712717347225;4836.95163048365;4844.346013288161;4847.781849816767;5593.720313984284;5602.299712535933;5615.859603509945;5632.549396048306;5651.75024360994;1434.4333988074652;1435.7559214933488;1442.6321288071474;1447.3486930881145;1448.66680663448;936.157458287533;992.5632721602472;993.1409330928839;1000.9090091799973;1003.6487229469773;5224.216367544898;5239.869003274873;5249.658772179796;5284.101702710548;5290.365156181283;5526.834194974157;5604.8318550443555;5615.2700148981185;5616.69108199053;5645.322561292671;4957.851264462072;5182.274481572583;5225.16397376418;5231.973840130775;5254.395744489432;2942.9411411771644;2944.440556294297;2950.395168990352;2951.793374463767;2955.2907302247304;5688.63023903445;5689.886202275931;5693.459121383462;5705.258316418839;5713.286014195724;5380.381256155514;5569.579757161898;5602.411746766531;5635.887282254332;5646.661200327993;5620.9437905621235;5628.690422026746;5642.379338272786;5674.1488776683;5683.556070889557;5303.867403314948;5473.67157970523;5503.889922201453;5582.4138465462165;5603.8879222416135;5437.374701909331;5449.754761035842;5453.2004438534395;5467.043267428105;5501.889962200654;5638.182463542681;5680.602357835077;5744.511716504144;5761.740721667451;5875.854208429315;4108.36320370343;4173.14450537633;4181.616478607165;4183.916321673611;4197.874063778091;5608.579356548194;5727.312722473163;5749.425057494217;5768.94231057684;5796.652200867961;5502.779888804403;5568.638038527482;5588.944110558842;5589.357223919139;5600.411956744483;5573.804916827891;5590.217369568182;5595.685014021783;5600.35595906476;5630.239917611234;5234.738263086907;5511.669299842022;5516.834494965157;5558.972205138948;5564.970480461127;5663.207150998781;5666.603337766317;5670.291213598301;5700.771969121189;5709.885802284014;5566.580521966873;5570.6657600544095;5611.298587676541;5614.775408983758;5617 20:28:03 INFO - PROCESS | 17234 | |5;yui.html;821.8356328734254;832.9125441828608;845.5011543189516;855.5593869157381;869.4174902815113;15295.311710973005;15460.226988650578;16106.114163720991;16108.516744497654;16152.111633860148;14114.929425352859;14156.646083847909;14246.287685615729;14265.500707475241;14267.643308917257;860.9182127697875;875.995620021899;877.2017464107663;877.5349064995562;878;732.1251104929611;750.6772088002157;848.2111636178352;870.1733353314345;880.8326417980595;922.377395258198;922.8154369126169;923.4551614547415;923.6120829251697;924.4499522783966;921.4793641592546;921.9216366608846;922.4695799915042;922.6724512797961;922.7001224601997;681.3731367142241;681.9420349270318;682.668905580793;683.7265093962405;684.0525871667726;14773.630659233497;14955.925220373938;15002.174880381575;15003.24983750819;15305.846941530554;14811.629709257248;15216.239188040554;15577.299021544057;15681.607959801097;15790.447334343244;12047.93976030123;12083.27500349973;12218.266903985701;12231.75536489274;12268;3886.7279290449396;3887.086534664352;3895.2599006188734;3971.245463361952;4002;56513;56993;58747.118793218135;60498;62352.99999999955;11586.47860846264;11767.176297659082;11794.705132371588;11807.763844723057;11889.405529723479;19974.90012549928;19981;19984;20058.89970550138;20086.59826803456;8247.422680412314;8313.459625124347;8327.250547450758;8372.623231954576;8489.533075680896;4603.861884143481;4677.883052923636;4768.904621907612;4854.17479028566;4856.902861942742;3464.4630082337276;3497.5802903651215;3500.4749287607065;3552.2362692020824;3581.409067503833;598.7425407075;616.0881894795727;637.7225906730587;641.1024565608186;643.5398689936718;716.4161208614962;719.8740220461399;730.5981710059552;733.1641928201855;749.79380670315;9846.310758246997;9910.603575856885;10019.549120289605;10090.69727908164;10327.48362581883;640.3340525853154;648.18652590998;723.6526467295728;782.823864630465;798.7324246377528;4213.852515162016;4492.595666390041;4515.932261016087;4588.6099681526775;4591.816327346869;87946.56026719953;90368.09631903729;90960;93940;94368;78928;79312.60343698245;80482.5975870117;80949.59525202453;82894.75657865137;70692;73061.26938730651;74032.62983685046;75269;75737.24262757412;8666.869996950178;8820.64717411322;8882.378233523592;8949.149830766068;9015.14356136166;45658.54341456543;46092.30861537012;47223.76388118038;47611.52388476071;47738.52261477341;61274.38725612865;62212.68893655503;65345;66384;66491.33508664851;11620.825687614863;11985.101117416054;12097.69755756078;12457;12716.74566508646;12671.683207919876;12998.621736611749;13002.764737349937;13298.933505332412;13789.724205516035;12366.505339786308;12448.190867593577;12610.684732881751;13173.209607423585;13232.536861209812;12276.202046866925;12847.357632118543;12938.676533086747;12965.675858103623;12967.805482917953;12031.879681203425;12218.26690398579;12617.810732839198;12639.87360126387;13066.412011459317;9779.608815647294;10251.436171010666;10346.689599312032;10492.265541412027;10589.576416943237;10027.749306267402;11011.504482298156;11044.668659940215;11119.332840029625;11158.274712143684 20:28:03 INFO - PROCESS | 17234 | __end_tp_report 20:28:03 INFO - PROCESS | 17234 | __start_cc_report 20:28:03 INFO - PROCESS | 17234 | _x_x_mozilla_cycle_collect,1103 20:28:03 INFO - PROCESS | 17234 | __end_cc_report 20:28:03 INFO - PROCESS | 17234 | __startTimestamp1487910483293__endTimestamp 20:28:03 INFO - PROCESS | 17234 | 20:28:03 INFO - PROCESS | 17234 | ------- Summary: start ------- 20:28:03 INFO - PROCESS | 17234 | Number of tests: 6 20:28:03 INFO - PROCESS | 17234 | 20:28:03 INFO - PROCESS | 17234 | [#0] dojo.html Cycles:165 Average:5551.98 Median:5724.51 stddev:619.62 (10.8%) stddev-sans-first:593.20 20:28:03 INFO - PROCESS | 17234 | Values: 3191.3 3204.2 3209.3 3241.1 3252.5 5577.4 5649.1 5655.3 5657.5 5658.7 5606.7 5677.7 5682.3 5685.3 5714.4 5087.5 5112.7 5116.4 5155.9 5195.9 4975.8 4986.8 5203.1 5206.5 5219.3 4993.9 4999.8 5031.4 5079.6 5118.2 5099.2 5183.4 5187.9 5196.5 5214.7 4843.5 5070.6 5099.2 5135.4 5161.5 5432.5 5445.7 5472.9 5511.5 5555.5 5896.5 5929.4 6005.4 6005.5 6010.2 6040.8 6053.0 6056.7 6064.1 6065.7 5387.9 5435.6 5499.5 5546.7 5548.8 6053.7 6109.7 6118.5 6118.7 6146.0 5851.4 5860.1 5886.0 5891.1 5892.7 5777.5 5835.6 5892.6 5954.9 5961.0 5994.0 6004.9 6006.4 6009.8 6027.2 5926.9 5977.3 5987.9 5994.6 5996.3 4535.8 4574.0 4622.9 4669.6 4674.8 4105.5 4128.0 4141.2 4162.4 4163.2 5707.5 5719.3 5727.3 5735.1 5738.8 5866.5 5928.5 5934.2 6080.0 6106.1 5608.0 5652.5 5671.8 5682.5 5684.6 5145.7 5156.4 5159.9 5162.1 5200.0 5875.6 5926.9 6098.7 6164.7 6185.0 5927.8 5954.8 5962.9 6046.0 6085.0 6151.4 6155.4 6159.2 6177.8 6185.5 5724.2 5920.4 5936.2 5941.5 5948.8 5810.3 5927.1 5949.0 5962.3 6060.3 5837.9 5885.1 5889.5 5895.2 5899.3 5848.9 5871.9 5873.7 5881.5 5891.0 5615.9 5622.7 5685.8 5702.0 5724.5 5854.0 5854.6 5856.2 5863.8 5878.6 5606.1 5638.1 5712.1 5712.5 5718.8 20:28:03 INFO - PROCESS | 17234 | 20:28:03 INFO - PROCESS | 17234 | [#1] ext.html Cycles:180 Average:57922.84 Median:36711.63 stddev:111709.94 (304.3%) stddev-sans-first:111940.36 20:28:03 INFO - PROCESS | 17234 | Values: 583.4 616.4 641.0 644.3 652.5 33098.2 44052.3 45148.8 45184.5 45254.8 44999.6 45578.0 45652.0 45692.5 45747.5 8222.5 8420.5 8995.6 9125.5 9140.7 10722.8 10947.1 10977.4 11241.8 11261.1 10986.6 10996.9 11056.8 11064.9 11070.8 10894.8 10926.4 10943.0 10943.5 10950.8 10768.3 10836.6 10841.8 10847.9 10852.2 42224.8 42588.0 42588.4 42642.8 42716.5 3622.2 3748.5 3810.7 3841.5 4176.9 32203.4 32688.3 32781.0 32790.5 33071.2 3933.5 3938.2 3992.9 4008.1 4063.1 331276.0 332172.0 334722.0 337237.0 337469.0 61996.0 62344.4 62478.4 62532.7 62564.4 64906.7 64976.0 65077.3 65125.7 65135.7 18901.0 19148.1 19151.7 19155.9 19158.0 13028.7 13709.2 14045.9 14324.0 14558.3 18210.5 18369.4 18560.2 18576.5 18721.0 6332.7 6357.4 6625.2 6634.4 6646.7 881.4 983.4 989.6 1029.3 1090.5 32866.8 32952.5 32982.7 33023.2 33449.2 1104.7 1125.2 1214.2 1218.8 1248.1 17339.7 17407.3 17543.3 17553.2 17632.4 472960.0 522527.0 533985.0 535685.0 726200.0 60681.0 61151.4 61174.4 61223.4 61319.0 1358.2 1395.8 1400.8 1414.7 1465.3 31780.4 33238.8 33496.0 33827.8 33863.8 51746.0 52124.5 52178.5 52252.0 52290.2 315496.0 315544.0 317037.0 319012.0 319194.0 28885.6 29663.1 29759.0 29813.3 29820.0 47140.0 47197.5 47620.0 47827.8 47847.3 39816.6 39988.2 40163.2 40995.8 41715.6 40508.2 40702.7 41357.4 41387.8 42087.8 41070.0 41071.8 41091.8 41119.0 41174.0 34126.0 36429.5 36993.8 37407.3 37449.6 28078.7 28087.4 28098.4 28335.3 28383.3 20:28:03 INFO - PROCESS | 17234 | 20:28:03 INFO - PROCESS | 17234 | [#2] jquery.html Cycles:180 Average:26647.98 Median:22892.54 stddev:70670.40 (308.7%) stddev-sans-first:70841.19 20:28:03 INFO - PROCESS | 17234 | Values: 413.7 416.0 420.3 431.8 436.3 18913.1 19022.9 19508.2 19676.0 19803.3 18414.8 18902.1 18980.0 19079.1 19126.2 5500.6 5819.4 5851.9 5854.8 5856.9 5630.7 5738.5 5786.4 5811.9 5827.5 5771.6 5805.2 5809.9 5811.4 5818.9 5616.9 5794.8 5801.5 5802.9 5803.7 5239.7 5241.9 5246.2 5247.5 5248.7 22363.4 22412.8 22775.2 23009.9 23036.8 2382.8 2441.5 2852.7 3018.7 3230.6 13117.7 14052.0 14355.9 14485.1 14539.3 1911.4 1947.5 2029.9 2031.4 2064.9 77350.2 78401.6 79059.0 79532.6 79694.6 10696.4 10742.4 10777.5 10930.2 11069.6 15988.1 15993.1 16004.3 16006.3 16006.8 8283.6 8423.8 8480.9 8661.3 8700.0 8379.3 8394.3 8431.6 8531.7 8652.0 6614.2 6759.6 6767.4 6799.3 6824.2 2038.6 2054.6 2055.5 2055.9 2073.4 762.6 889.9 1005.7 1037.1 1051.8 18908.2 19565.4 19667.6 19808.5 20045.5 1032.2 1033.8 1044.3 1050.4 1117.2 10886.3 11273.3 11374.4 11392.9 11410.4 425116.0 429143.0 431405.0 431909.0 432813.0 48968.8 55556.7 77696.6 77733.6 78499.6 1019.9 1042.1 1042.3 1042.4 1056.1 16882.8 17298.3 17365.6 17722.2 17872.9 38878.6 38884.6 39355.8 39798.2 40313.4 52169.7 52250.7 53044.7 57475.0 59891.7 8211.8 8510.0 8518.5 8524.2 8702.3 10921.4 12516.4 12873.6 13031.5 13322.9 11082.9 11322.4 11587.7 11639.7 11729.1 11384.0 11506.6 11517.4 11564.2 11736.1 11301.4 11379.5 11653.5 11680.7 11816.1 8359.5 8563.0 8652.4 8767.7 8879.7 10923.2 11414.7 11582.2 11630.1 11646.6 20:28:03 INFO - PROCESS | 17234 | 20:28:03 INFO - PROCESS | 17234 | [#3] mootools.html Cycles:180 Average:5608.97 Median:5125.17 stddev:3041.90 (59.4%) stddev-sans-first:3034.55 20:28:03 INFO - PROCESS | 17234 | Values: 1473.0 1498.9 1666.7 1814.1 1836.6 8021.4 8495.1 8497.1 8514.0 8522.0 7369.6 7636.0 8022.3 8327.7 8373.2 2438.4 2469.5 2470.6 2472.4 2474.8 2393.9 2486.2 2493.6 2499.5 2499.9 2418.4 2418.7 2433.0 2454.0 2456.6 2401.0 2406.1 2425.9 2430.1 2436.7 2369.3 2381.0 2399.6 2401.2 2403.4 8581.5 8591.2 8663.4 8666.8 8673.8 5330.8 5489.2 5491.5 5495.3 5501.2 3284.8 3302.1 3333.4 3407.2 3430.5 1136.5 1163.7 1168.9 1179.4 1921.9 11032.8 11505.7 11514.6 11536.3 11568.1 4681.1 4705.1 4767.6 4768.1 4771.4 9371.4 9372.9 9376.4 9378.4 9386.2 5443.3 5448.6 5454.3 5456.2 5460.3 4354.3 4605.3 5081.0 5106.4 5128.0 3864.1 3944.0 3961.4 4013.7 4036.3 1253.2 1256.2 1259.6 1271.3 1273.1 944.6 993.3 995.2 1003.0 1003.9 5418.9 5529.1 5574.5 5693.7 5724.1 1006.8 1018.5 1019.3 1075.4 1100.1 3587.5 3590.7 3609.9 3611.5 3719.1 10053.4 10498.9 10504.5 10518.6 10530.8 10470.6 10471.6 10477.6 10483.6 10487.1 7910.1 7949.2 8120.1 8129.1 8140.7 5266.7 5295.6 5463.3 5476.3 5539.5 9542.1 9589.7 9622.4 9687.7 9696.7 9241.8 9599.4 9610.0 9658.1 9677.7 6951.4 7126.5 7139.1 7942.2 8251.8 7244.0 7313.5 7884.9 8130.7 8164.7 7444.5 7450.7 7631.1 7647.3 7767.7 7178.4 7208.6 7239.1 7332.9 7353.6 6677.8 6711.7 6777.5 6803.1 6805.9 4961.8 5013.1 5063.9 5075.7 5240.6 5122.3 5171.6 5189.9 5199.7 5245.2 20:28:03 INFO - PROCESS | 17234 | 20:28:03 INFO - PROCESS | 17234 | [#4] prototype.html Cycles:180 Average:4685.08 Median:5323.25 stddev:1339.91 (25.2%) stddev-sans-first:1303.58 20:28:03 INFO - PROCESS | 17234 | Values: 351.0 356.4 358.8 359.5 363.7 5310.7 5332.9 5333.1 5346.8 5363.6 5313.6 5352.9 5359.4 5361.3 5364.7 3723.9 4036.0 4061.9 4143.2 4233.2 4222.5 4223.2 4227.5 4235.6 4253.9 4208.5 4209.6 4217.1 4218.9 4231.4 4108.8 4201.7 4237.9 4240.7 4244.7 3775.5 3788.6 3789.2 3796.2 3797.6 5198.8 5203.2 5216.2 5220.7 5250.3 4736.6 4830.0 4831.5 4862.5 4866.5 5492.8 5518.8 5540.2 5549.0 5556.7 4149.8 4156.6 4166.3 4166.9 4171.6 5472.8 5520.3 5736.5 5769.9 5772.2 3931.8 4245.8 4246.3 4253.0 4272.1 4292.5 4292.8 4306.9 4314.5 4339.6 4548.0 4836.4 4837.0 4844.3 4847.8 5593.7 5602.3 5615.9 5632.5 5651.8 1434.4 1435.8 1442.6 1447.3 1448.7 936.2 992.6 993.1 1000.9 1003.6 5224.2 5239.9 5249.7 5284.1 5290.4 5526.8 5604.8 5615.3 5616.7 5645.3 4957.9 5182.3 5225.2 5232.0 5254.4 2942.9 2944.4 2950.4 2951.8 2955.3 5688.6 5689.9 5693.5 5705.3 5713.3 5380.4 5569.6 5602.4 5635.9 5646.7 5620.9 5628.7 5642.4 5674.1 5683.6 5303.9 5473.7 5503.9 5582.4 5603.9 5437.4 5449.8 5453.2 5467.0 5501.9 5638.2 5680.6 5744.5 5761.7 5875.9 4108.4 4173.1 4181.6 4183.9 4197.9 5608.6 5727.3 5749.4 5768.9 5796.7 5502.8 5568.6 5588.9 5589.4 5600.4 5573.8 5590.2 5595.7 5600.4 5630.2 5234.7 5511.7 5516.8 5559.0 5565.0 5663.2 5666.6 5670.3 5700.8 5709.9 5566.6 5570.7 5611.3 5614.8 5617.0 20:28:03 INFO - PROCESS | 17234 | 20:28:03 INFO - PROCESS | 17234 | [#5] yui.html Cycles:180 Average:18224.40 Median:25950.82 stddev:24300.26 (93.6%) stddev-sans-first:24333.29 20:28:03 INFO - PROCESS | 17234 | Values: 821.8 832.9 845.5 855.6 869.4 15295.3 15460.2 16106.1 16108.5 16152.1 14114.9 14156.6 14246.3 14265.5 14267.6 860.9 876.0 877.2 877.5 878.0 732.1 750.7 848.2 870.2 880.8 922.4 922.8 923.5 923.6 924.4 921.5 921.9 922.5 922.7 922.7 681.4 681.9 682.7 683.7 684.1 14773.6 14955.9 15002.2 15003.2 15305.8 14811.6 15216.2 15577.3 15681.6 15790.4 12047.9 12083.3 12218.3 12231.8 12268.0 3886.7 3887.1 3895.3 3971.2 4002.0 56513.0 56993.0 58747.1 60498.0 62353.0 11586.5 11767.2 11794.7 11807.8 11889.4 19974.9 19981.0 19984.0 20058.9 20086.6 8247.4 8313.5 8327.3 8372.6 8489.5 4603.9 4677.9 4768.9 4854.2 4856.9 3464.5 3497.6 3500.5 3552.2 3581.4 598.7 616.1 637.7 641.1 643.5 716.4 719.9 730.6 733.2 749.8 9846.3 9910.6 10019.5 10090.7 10327.5 640.3 648.2 723.7 782.8 798.7 4213.9 4492.6 4515.9 4588.6 4591.8 87946.6 90368.1 90960.0 93940.0 94368.0 78928.0 79312.6 80482.6 80949.6 82894.8 70692.0 73061.3 74032.6 75269.0 75737.2 8666.9 8820.6 8882.4 8949.1 9015.1 45658.5 46092.3 47223.8 47611.5 47738.5 61274.4 62212.7 65345.0 66384.0 66491.3 11620.8 11985.1 12097.7 12457.0 12716.7 12671.7 12998.6 13002.8 13298.9 13789.7 12366.5 12448.2 12610.7 13173.2 13232.5 12276.2 12847.4 12938.7 12965.7 12967.8 12031.9 12218.3 12617.8 12639.9 13066.4 9779.6 10251.4 10346.7 10492.3 10589.6 10027.7 11011.5 11044.7 11119.3 11158.3 20:28:03 INFO - PROCESS | 17234 | -------- Summary: end -------- 20:28:03 INFO - PROCESS | 17234 | 20:28:04 INFO - TEST-INFO | 17234: exit 0 20:28:04 INFO - TEST-OK | dromaeo_css | took 1114931ms 20:28:04 INFO - TEST-START | kraken 20:28:04 INFO - operating with platform_type : linux_ 20:28:04 INFO - Initialising browser for kraken test... 20:28:04 INFO - TEST-INFO | started process 17539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz1gICl/profile http://localhost:38717/getInfo.html) 20:28:07 INFO - PROCESS | 17539 | __metrics Screen width/height:1600/1200 20:28:07 INFO - PROCESS | 17539 | colorDepth:24 20:28:07 INFO - PROCESS | 17539 | Browser inner width/height: 1024/697 20:28:07 INFO - PROCESS | 17539 | __metrics 20:28:08 INFO - PROCESS | 17539 | 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" 20:28:08 INFO - PROCESS | 17539 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:28:08 INFO - PROCESS | 17539 | console.error: PushService: 20:28:08 INFO - PROCESS | 17539 | stateChangeProcessEnqueue: Error transitioning state 20:28:08 INFO - PROCESS | 17539 | UnknownError 20:28:09 INFO - TEST-INFO | 17539: exit 0 20:28:09 INFO - Browser initialized. 20:28:09 INFO - Running cycle 1/1 for kraken test... 20:28:09 INFO - TEST-INFO | started process 17630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz1gICl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:28:21 INFO - PROCESS | 17630 | RSS: Main: 141303808 20:28:21 INFO - PROCESS | 17630 | 20:28:23 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38717/tests/kraken/driver.html?testName=audio-beat-detection) 20:28:24 INFO - PROCESS | 17630 | RSS: Main: 183181312 20:28:24 INFO - PROCESS | 17630 | 20:28:27 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38717/tests/kraken/driver.html?testName=audio-dft) 20:28:27 INFO - PROCESS | 17630 | RSS: Main: 173256704 20:28:27 INFO - PROCESS | 17630 | 20:28:30 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38717/tests/kraken/driver.html?testName=audio-fft) 20:28:31 INFO - PROCESS | 17630 | RSS: Main: 264855552 20:28:31 INFO - PROCESS | 17630 | 20:28:33 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38717/tests/kraken/driver.html?testName=audio-oscillator) 20:28:33 INFO - PROCESS | 17630 | RSS: Main: 171732992 20:28:33 INFO - PROCESS | 17630 | 20:28:35 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38717/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:28:36 INFO - PROCESS | 17630 | RSS: Main: 173490176 20:28:36 INFO - PROCESS | 17630 | 20:28:39 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38717/tests/kraken/driver.html?testName=imaging-darkroom) 20:28:39 INFO - PROCESS | 17630 | RSS: Main: 212058112 20:28:39 INFO - PROCESS | 17630 | 20:28:43 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38717/tests/kraken/driver.html?testName=imaging-desaturate) 20:28:43 INFO - PROCESS | 17630 | RSS: Main: 210825216 20:28:43 INFO - PROCESS | 17630 | 20:28:46 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38717/tests/kraken/driver.html?testName=json-parse-financial) 20:28:47 INFO - PROCESS | 17630 | RSS: Main: 209969152 20:28:47 INFO - PROCESS | 17630 | 20:28:48 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38717/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:28:49 INFO - PROCESS | 17630 | RSS: Main: 172298240 20:28:49 INFO - PROCESS | 17630 | 20:28:50 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38717/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:28:51 INFO - PROCESS | 17630 | RSS: Main: 179380224 20:28:51 INFO - PROCESS | 17630 | 20:28:53 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38717/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:28:54 INFO - PROCESS | 17630 | RSS: Main: 188243968 20:28:54 INFO - PROCESS | 17630 | 20:28:56 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:28:57 INFO - PROCESS | 17630 | RSS: Main: 196497408 20:28:57 INFO - PROCESS | 17630 | 20:28:59 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:29:00 INFO - PROCESS | 17630 | RSS: Main: 193273856 20:29:00 INFO - PROCESS | 17630 | 20:29:02 INFO - PROCESS | 17630 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38717/tests/kraken/driver.html?testName=ai-astar) 20:29:02 INFO - PROCESS | 17630 | RSS: Main: 244404224 20:29:02 INFO - PROCESS | 17630 | 20:29:02 INFO - PROCESS | 17630 | __start_tp_report 20:29:02 INFO - PROCESS | 17630 | _x_x_mozilla_page_load 20:29:02 INFO - PROCESS | 17630 | _x_x_mozilla_page_load_details 20:29:02 INFO - PROCESS | 17630 | |i|pagename|runs| 20:29:02 INFO - PROCESS | 17630 | |0;ai-astar;101;111;109;109;112;109;110;109;110;109 20:29:02 INFO - PROCESS | 17630 | |1;audio-beat-detection;148;118;118;160;126;120;122;117;147;118 20:29:02 INFO - PROCESS | 17630 | |2;audio-dft;161;160;161;160;160;161;160;159;160;161 20:29:02 INFO - PROCESS | 17630 | |3;audio-fft;73;75;74;106;75;74;75;75;97;75 20:29:02 INFO - PROCESS | 17630 | |4;audio-oscillator;82;82;112;82;82;82;102;82;81;114 20:29:02 INFO - PROCESS | 17630 | |5;imaging-gaussian-blur;117;117;116;117;118;116;116;117;117;116 20:29:02 INFO - PROCESS | 17630 | |6;imaging-darkroom;147;146;147;146;145;146;146;146;147;146 20:29:02 INFO - PROCESS | 17630 | |7;imaging-desaturate;84;85;84;84;85;85;85;84;84;84 20:29:02 INFO - PROCESS | 17630 | |8;json-parse-financial;50;54;53;52;52;52;54;51;51;51 20:29:02 INFO - PROCESS | 17630 | |9;json-stringify-tinderbox;59;59;59;60;60;59;61;59;59;59 20:29:02 INFO - PROCESS | 17630 | |10;stanford-crypto-aes;83;74;82;75;75;74;75;88;75;75 20:29:02 INFO - PROCESS | 17630 | |11;stanford-crypto-ccm;132;135;139;125;120;121;122;119;159;126 20:29:02 INFO - PROCESS | 17630 | |12;stanford-crypto-pbkdf2;159;160;160;159;156;161;158;155;159;158 20:29:02 INFO - PROCESS | 17630 | |13;stanford-crypto-sha256-iterative;63;63;63;62;64;62;62;63;62;62 20:29:02 INFO - PROCESS | 17630 | __end_tp_report 20:29:02 INFO - PROCESS | 17630 | __start_cc_report 20:29:02 INFO - PROCESS | 17630 | _x_x_mozilla_cycle_collect,1607 20:29:02 INFO - PROCESS | 17630 | __end_cc_report 20:29:02 INFO - PROCESS | 17630 | __startTimestamp1487910542446__endTimestamp 20:29:02 INFO - PROCESS | 17630 | 20:29:02 INFO - PROCESS | 17630 | ------- Summary: start ------- 20:29:02 INFO - PROCESS | 17630 | Number of tests: 14 20:29:02 INFO - PROCESS | 17630 | 20:29:02 INFO - PROCESS | 17630 | [#0] ai-astar Cycles:10 Average:108.90 Median:109.50 stddev:2.96 (2.7%) stddev-sans-first:1.09 20:29:02 INFO - PROCESS | 17630 | Values: 101.0 111.0 109.0 109.0 112.0 109.0 110.0 109.0 110.0 109.0 20:29:02 INFO - PROCESS | 17630 | 20:29:02 INFO - PROCESS | 17630 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:124.00 stddev:15.95 (12.9%) stddev-sans-first:15.44 20:29:02 INFO - PROCESS | 17630 | Values: 148.0 118.0 118.0 160.0 126.0 120.0 122.0 117.0 147.0 118.0 20:29:02 INFO - PROCESS | 17630 | 20:29:02 INFO - PROCESS | 17630 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 20:29:02 INFO - PROCESS | 17630 | Values: 161.0 160.0 161.0 160.0 160.0 161.0 160.0 159.0 160.0 161.0 20:29:02 INFO - PROCESS | 17630 | 20:29:02 INFO - PROCESS | 17630 | [#3] audio-fft Cycles:10 Average:79.90 Median:75.00 stddev:11.60 (15.5%) stddev-sans-first:12.03 20:29:02 INFO - PROCESS | 17630 | Values: 73.0 75.0 74.0 106.0 75.0 74.0 75.0 75.0 97.0 75.0 20:29:02 INFO - PROCESS | 17630 | 20:29:02 INFO - PROCESS | 17630 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:82.00 stddev:13.62 (16.6%) stddev-sans-first:14.12 20:29:02 INFO - PROCESS | 17630 | Values: 82.0 82.0 112.0 82.0 82.0 82.0 102.0 82.0 81.0 114.0 20:29:02 INFO - PROCESS | 17630 | 20:29:02 INFO - PROCESS | 17630 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 20:29:02 INFO - PROCESS | 17630 | Values: 117.0 117.0 116.0 117.0 118.0 116.0 116.0 117.0 117.0 116.0 20:29:02 INFO - PROCESS | 17630 | 20:29:02 INFO - PROCESS | 17630 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 20:29:02 INFO - PROCESS | 17630 | Values: 147.0 146.0 147.0 146.0 145.0 146.0 146.0 146.0 147.0 146.0 20:29:02 INFO - PROCESS | 17630 | 20:29:02 INFO - PROCESS | 17630 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 20:29:02 INFO - PROCESS | 17630 | Values: 84.0 85.0 84.0 84.0 85.0 85.0 85.0 84.0 84.0 84.0 20:29:02 INFO - PROCESS | 17630 | 20:29:02 INFO - PROCESS | 17630 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.33 (2.6%) stddev-sans-first:1.20 20:29:02 INFO - PROCESS | 17630 | Values: 50.0 54.0 53.0 52.0 52.0 52.0 54.0 51.0 51.0 51.0 20:29:02 INFO - PROCESS | 17630 | 20:29:02 INFO - PROCESS | 17630 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 20:29:02 INFO - PROCESS | 17630 | Values: 59.0 59.0 59.0 60.0 60.0 59.0 61.0 59.0 59.0 59.0 20:29:02 INFO - PROCESS | 17630 | 20:29:02 INFO - PROCESS | 17630 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:75.00 stddev:4.90 (6.5%) stddev-sans-first:4.80 20:29:02 INFO - PROCESS | 17630 | Values: 83.0 74.0 82.0 75.0 75.0 74.0 75.0 88.0 75.0 75.0 20:29:02 INFO - PROCESS | 17630 | 20:29:02 INFO - PROCESS | 17630 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:129.00 stddev:12.28 (9.5%) stddev-sans-first:13.00 20:29:02 INFO - PROCESS | 17630 | Values: 132.0 135.0 139.0 125.0 120.0 121.0 122.0 119.0 159.0 126.0 20:29:02 INFO - PROCESS | 17630 | 20:29:02 INFO - PROCESS | 17630 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.50 Median:159.00 stddev:1.84 (1.2%) stddev-sans-first:1.94 20:29:02 INFO - PROCESS | 17630 | Values: 159.0 160.0 160.0 159.0 156.0 161.0 158.0 155.0 159.0 158.0 20:29:02 INFO - PROCESS | 17630 | 20:29:02 INFO - PROCESS | 17630 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 20:29:02 INFO - PROCESS | 17630 | Values: 63.0 63.0 63.0 62.0 64.0 62.0 62.0 63.0 62.0 62.0 20:29:02 INFO - PROCESS | 17630 | -------- Summary: end -------- 20:29:02 INFO - PROCESS | 17630 | 20:29:03 INFO - TEST-INFO | 17630: exit 0 20:29:03 INFO - TEST-OK | kraken | took 59469ms 20:29:03 INFO - SUITE-END | took 1174s 20:29:03 INFO - Completed test suite (00:19:34) 20:29:03 INFO - javascript benchmark 20:29:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3191.313867518483, 3204.230984563704, 3209.3260415312784, 3241.1086951088464, 3252.528383384409, 5577.414371490996, 5649.096144616857, 5655.26481557397, 5657.547396208303, 5658.717064146792, 5606.663600183992, 5677.716114194284, 5682.289713785777, 5685.260916080914, 5714.371419143901, 5087.465816089303, 5112.718800465973, 5116.411612664554, 5155.922661160085, 5195.922061169085, 4975.751212439382, 4986.775595098229, 5203.063448579254, 5206.45332240115, 5219.295395121648, 4993.875153121165, 4999.775010124553, 5031.4465408805, 5079.568236699866, 5118.232265160219, 5099.184130539114, 5183.429822719517, 5187.896242075138, 5196.474568164519, 5214.6871187728475, 4843.467218605986, 5070.645054846163, 5099.184130539133, 5135.3837539495125, 5161.483851614846, 5432.456754324576, 5445.673259604437, 5472.890542189174, 5511.53151982082, 5555.527780138693, 5896.469317761379, 5929.436703513159, 6005.369436209179, 6005.4895333896675, 6010.158577799111, 6040.788572399989, 6053.0, 6056.72744726484, 6064.060070689006, 6065.727042283108, 5387.919181212285, 5435.565154787608, 5499.50504454593, 5546.694931778791, 5548.833534993957, 6053.727582258809, 6109.725062372204, 6118.479929205978, 6118.724657390429, 6146.016637338004, 5851.385604511465, 5860.120981852756, 5886.0, 5891.116332550152, 5892.705364731832, 5777.480026797609, 5835.649861008353, 5892.558058145656, 5954.940450595439, 5961.0, 5994.0409534474275, 6004.909926351108, 6006.429389208019, 6009.849753756191, 6027.156198132265, 5926.851828704317, 5977.252843394575, 5987.880242395215, 5994.550408719363, 5996.340402555716, 4535.7732113394195, 4573.977130114395, 4622.930656040162, 4669.626429885601, 4674.789634466457, 4105.486814148231, 4128.02991297045, 4141.192467468814, 4162.396452514368, 4163.188178305262, 5707.4577915098, 5719.256496655408, 5727.341355744143, 5735.139729040678, 5738.77044918207, 5866.530677545786, 5928.466438020599, 5934.19888315072, 6080.0, 6106.145139680449, 5608.046632072557, 5652.491275785199, 5671.801486947937, 5682.460166284196, 5684.6020778545935, 5145.665531740425, 5156.355455568054, 5159.922601160985, 5162.096633089194, 5200.011997720421, 5875.6474611523445, 5926.881462370815, 6098.664573448415, 6164.660943648053, 6185.041318595625, 5927.792527261525, 5954.821355359346, 5962.850928726816, 6045.969770151297, 6084.969575152096, 6151.3541078186145, 6155.415235552616, 6159.230096237791, 6177.81466556004, 6185.536084793748, 5724.169995350734, 5920.437558431942, 5936.1986131871645, 5941.494972927349, 5948.762049517971, 5810.273715785527, 5927.110933360031, 5949.0, 5962.25471816023, 6060.333363329942, 5837.883242335214, 5885.14665373527, 5889.499392551681, 5895.233619629421, 5899.321578018583, 5848.912266315923, 5871.882562348815, 5873.676947767914, 5881.470667639933, 5890.970545147246, 5615.859603509945, 5622.662640241599, 5685.800996965087, 5702.0, 5724.513416359656, 5854.0, 5854.619449735754, 5856.209411729362, 5863.794767183128, 5878.647281163144, 5606.074997625346, 5638.126090455986, 5712.0860662293835, 5712.457316554921, 5718.771249150153], "value": 5510.684878050282, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.3903570768547, 616.4390404731694, 640.9871802563952, 644.3459888213463, 652.5432197461778, 33098.17254568637, 44052.339214911764, 45148.77425612867, 45184.548154518445, 45254.77372613132, 44999.55000449994, 45578.0, 45652.0, 45692.54307456924, 45747.54252457475, 8222.547759873205, 8420.452670576393, 8995.595198216064, 9125.543722813865, 9140.725778226664, 10722.785544289109, 10947.069499092586, 10977.39624320662, 11241.819608941025, 11261.099112071055, 10986.560537578527, 10996.890031099667, 11056.834147487794, 11064.889351106467, 11070.778584428306, 10894.782104357908, 10926.399048052393, 10943.0, 10943.45282735868, 10950.780984380268, 10768.300060496122, 10836.566537338496, 10841.78316433667, 10847.945760271226, 10852.186086043499, 42224.78887605573, 42588.0, 42588.36117458241, 42642.78678606618, 42716.50492232788, 3622.185008373095, 3748.4564738113095, 3810.733248672594, 3841.4621952926614, 4176.895577610554, 32203.355932881444, 32688.346233075445, 32781.01656950295, 32790.50814237788, 33071.173220669436, 3933.468981687493, 3938.2320447512748, 3992.940105898414, 4008.07814202735, 4063.126427818004, 331276.0, 332172.0, 334722.0, 337237.0, 337469.0, 61996.0, 62344.37655623476, 62478.37521624726, 62532.68733656393, 62564.37435625677, 64906.675466622364, 64976.0, 65077.34922650808, 65125.674371627836, 65135.674321629034, 18901.0, 19148.138333775012, 19151.712724309145, 19155.90422047881, 19158.0, 13028.674283142807, 13709.245991470365, 14045.929770351082, 14324.0, 14558.272086395638, 18210.54473638143, 18369.448916532525, 18560.164792584095, 18576.535586610444, 18721.0, 6332.715027823759, 6357.427831495188, 6625.17185351831, 6634.369734875179, 6646.700898459581, 881.378628067211, 983.4296108257194, 989.6239429016928, 1029.2949329709172, 1090.51472094917, 32866.83566582199, 32952.505712414335, 32982.67017329844, 33023.174420639676, 33449.16377090592, 1104.690686607751, 1125.234840308598, 1214.227228246752, 1218.750156217991, 1248.082659245454, 17339.739903901453, 17407.3037078518, 17543.316522694517, 17553.21010554528, 17632.382866599608, 472960.0, 522527.0, 533985.0, 535685.0, 726200.0, 60681.0, 61151.38848611546, 61174.38825611776, 61223.38776612177, 61319.0, 1358.2461733737673, 1395.7696979998186, 1400.803887455757, 1414.724128794875, 1465.3479201755117, 31780.364392711555, 33238.833805830815, 33496.0, 33827.83086084652, 33863.83068084644, 51746.0, 52124.47875521196, 52178.47821521888, 52252.0, 52290.21564676609, 315496.0, 315544.0, 317037.0, 319012.0, 319194.0, 28885.566716498848, 29663.110106696833, 29759.0, 29813.254668633457, 29820.0, 47140.0, 47197.528024719315, 47620.04759904852, 47827.76086119547, 47847.28229076497, 39816.60183398245, 39988.2002359957, 40163.1967360657, 40995.79502102471, 41715.582844172386, 40508.1898362037, 40702.710254259975, 41357.37963930603, 41387.7930610345, 42087.789561052, 41070.0, 41071.7946410266, 41091.794541027106, 41119.0, 41174.0, 34126.0, 36429.45355819718, 36993.81503092467, 37407.251854963295, 37449.6255037457, 28078.719212808428, 28087.438251234453, 28098.438031239668, 28335.29161770972, 28383.29041773972], "value": 20743.03051917358, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.7455464889094, 415.95632458591865, 420.30229818501294, 431.79273948504726, 436.33676811246903, 18913.148908299125, 19022.92862164034, 19508.21967121317, 19676.01619919004, 19803.306884259055, 18414.81585184148, 18902.05489725515, 18980.0, 19079.141438635295, 19126.234950601993, 5500.642458240211, 5819.388964158766, 5851.882962340772, 5854.76580936762, 5856.882862342751, 5630.71846407678, 5738.454846789569, 5786.392428794979, 5811.912821307684, 5827.504662103726, 5771.624844385123, 5805.216295800076, 5809.854753631172, 5811.418858114197, 5818.883622327551, 5616.887662246773, 5794.768209271624, 5801.47786699197, 5802.912956305638, 5803.73883175256, 5239.659422137549, 5241.895162096775, 5246.186841039645, 5247.527722504993, 5248.65883717561, 22363.44091397712, 22412.775872241233, 22775.20286789971, 23009.884950575306, 23036.848157592052, 2382.797462215714, 2441.4994926040117, 2852.657681078263, 3018.6830382809926, 3230.5800245967876, 13117.737645247042, 14052.016358854884, 14355.928220358832, 14485.130892146504, 14539.3457294422, 1911.44568075258, 1947.464447276996, 2029.8883561404264, 2031.441353627764, 2064.865783724068, 77350.22649773542, 78401.60799196025, 79059.0, 79532.60233698852, 79694.60152699257, 10696.41169735672, 10742.409167495864, 10777.51501182433, 10930.234883558234, 11069.5572177112, 15988.120653364176, 15993.120378379068, 16004.279807408695, 16006.279717412745, 16006.839931600767, 8283.58582070894, 8423.789405264917, 8480.915190848013, 8661.263792577576, 8700.0, 8379.287760540301, 8394.286485648667, 8431.620577073923, 8531.74404767858, 8651.95674021626, 6614.173228346457, 6759.5606285591275, 6767.35710107539, 6799.286074962157, 6824.18109826824, 2038.6432374334431, 2054.5582699719334, 2055.5272287373987, 2055.9177632894816, 2073.3676228750073, 762.6377470701373, 889.8953973851794, 1005.703317521333, 1037.0770014686934, 1051.75283808305, 18908.243670253312, 19565.413037608894, 19667.606647866964, 19808.50478738014, 20045.49886252826, 1032.1897310611134, 1033.8242498775226, 1044.3159730376615, 1050.3907733514543, 1117.234694234452, 10886.292390994719, 11273.323600583992, 11374.431278436045, 11392.94303528477, 11410.429478526206, 425116.0, 429143.0, 431405.0, 431909.0, 432813.0, 48968.7551562247, 55556.72221638866, 77696.61151694205, 77733.6113319441, 78499.60750196212, 1019.938803671782, 1042.0621440703276, 1042.3485321673954, 1042.3954106618144, 1056.0812093478569, 16882.831171688616, 17298.308067677153, 17365.56586085358, 17722.20250088775, 17872.91063544674, 38878.61121388863, 38884.61115388923, 39355.819325420285, 39798.2040359197, 40313.395299071126, 52169.73915130552, 52250.73874630602, 53044.73477632587, 57475.0, 59891.70054149701, 8211.79470513218, 8510.0, 8518.48889066658, 8524.190201930807, 8702.303815694602, 10921.399323037309, 12516.436760345625, 12873.613791586267, 13031.543895963596, 13322.934945083527, 11082.944585277022, 11322.37726925027, 11587.652370428901, 11639.709007274885, 11729.120315976164, 11384.0, 11506.597269095877, 11517.366544840113, 11564.248323858923, 11736.119791015537, 11301.434928253719, 11379.54481820718, 11653.53385864556, 11680.70798230051, 11816.054715622558, 8359.498430094214, 8563.015253245956, 8652.351073669373, 8767.693130740648, 8879.689210877847, 10923.235373523778, 11414.714632133931, 11582.247153934968, 11630.127740419672, 11646.592369267035], "value": 9355.3602039387, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1473.0351619689104, 1498.9250537473126, 1666.6749983753166, 1814.0838876367432, 1836.6418548383062, 8021.358291336694, 8495.065542790288, 8497.10780368061, 8513.957430212848, 8522.019967703716, 7369.594672293035, 7635.961820190892, 8022.277994980451, 8327.66689332426, 8373.246407823295, 2438.3782135555452, 2469.469064151207, 2470.555300045991, 2472.418981539337, 2474.7772700456953, 2393.85636861788, 2486.204414587333, 2493.6259561065804, 2499.5000999800022, 2499.900003999847, 2418.443757935676, 2418.733939266679, 2432.975670243293, 2453.9631905521433, 2456.6192240202795, 2400.95198096038, 2406.097713357491, 2425.890834912433, 2430.1373012580457, 2436.671049408325, 2369.336585755974, 2380.976190238093, 2399.6160614301803, 2401.183597576832, 2403.3510952043025, 8581.485110893367, 8591.183837535487, 8663.39356245063, 8666.783330416727, 8673.826523469495, 5330.840074797762, 5489.176623506466, 5491.533219676332, 5495.340559132889, 5501.202325662796, 3284.753643476749, 3302.091924720697, 3333.4166520858753, 3407.2333724911946, 3430.5025771263026, 1136.4829002803704, 1163.668354518958, 1168.9018212308927, 1179.3867189061639, 1921.8558608104447, 11032.834507482394, 11505.712357191138, 11514.596989105341, 11536.25014374063, 11568.074554035657, 4681.133990211753, 4705.12955103307, 4767.61859051275, 4768.117898188846, 4771.379720636295, 9371.437713737198, 9372.8594071089, 9376.390534615228, 9378.437293762396, 9386.249100071978, 5443.346798384219, 5448.591355648263, 5454.3454785426, 5456.208849716848, 5460.262864513319, 4354.281543545279, 4605.332226827091, 5080.974595127001, 5106.4382917879, 5128.0, 3864.053306939818, 3944.0, 3961.4255932890146, 4013.6989725770686, 4036.253293140778, 1253.185429470833, 1256.221142891395, 1259.5591542959892, 1271.2753730373784, 1273.1469915156868, 944.5843828715343, 993.2997236947934, 995.2088089968348, 1002.9919930469831, 1003.8644782954208, 5418.91871621926, 5529.087700529368, 5574.526165275915, 5693.715314234271, 5724.084146536534, 1006.808706345792, 1018.5314755212537, 1019.2966852871494, 1075.3977772447297, 1100.1199040767353, 3587.515685382492, 3590.7486475946434, 3609.909752256162, 3611.5124458198334, 3719.1260053887313, 10053.396796192252, 10498.947505262577, 10504.527296271686, 10518.579256829642, 10530.789384212272, 10470.581176752845, 10471.581136754598, 10477.633282835064, 10483.580656773796, 10487.108595769292, 7910.050793904653, 7949.165337639464, 8120.106788253287, 8129.065157506962, 8140.674373025131, 5266.736663166903, 5295.576353891756, 5463.289772329572, 5476.2607048048, 5539.501444869981, 9542.093501117382, 9589.664361747584, 9622.37454565451, 9687.70936871895, 9696.70909872705, 9241.768955775891, 9599.42403455795, 9610.038996100613, 9658.082482164184, 9677.661281855102, 6951.409130223786, 7126.501144920013, 7139.107611548557, 7942.205779422012, 8251.793705157179, 7244.0, 7313.451491138079, 7884.881726773988, 8130.715424960098, 8164.714235001747, 7444.478886477895, 7450.739224127129, 7631.084269887427, 7647.311741943252, 7767.650455729618, 7178.389836863925, 7208.639568021683, 7239.095113110861, 7332.890006650011, 7353.632318384166, 6677.76627818024, 6711.731530738716, 6777.491688123312, 6803.115594972622, 6805.863882722417, 4961.7519124044375, 5013.147764880052, 5063.873403164803, 5075.695458272516, 5240.580753539632, 5122.334096567422, 5171.612129090258, 5189.896202075862, 5199.688018718889, 5245.160774276097], "value": 4594.396106408824, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.9613942466329, 356.3674477801901, 358.83852266480073, 359.46798737867937, 363.6999475432767, 5310.654807437514, 5332.92000619991, 5333.120115137825, 5346.759395827187, 5363.6245462817615, 5313.57491400688, 5352.866178345544, 5359.437259087798, 5361.276227709258, 5364.673902180643, 3723.869664561741, 4035.9999999999927, 4061.8984525386954, 4143.1713657268665, 4233.23801715691, 4222.472190976128, 4223.170475781219, 4227.450431443908, 4235.576442355755, 4253.8723838284905, 4208.537060923296, 4209.6000879916355, 4217.114405974749, 4218.936715949263, 4231.418834510946, 4108.82898373962, 4201.684873634459, 4237.87286381409, 4240.703150779446, 4244.702870799046, 3775.528058992626, 3788.5643151037707, 3789.1853251550774, 3796.2217745362136, 3797.6012518685416, 5198.818041368571, 5203.167493201107, 5216.191490319006, 5220.738963051832, 5250.319897632759, 4736.621070314367, 4830.0, 4831.516848315176, 4862.465128835825, 4866.51334866514, 5492.764128071192, 5518.806841760559, 5540.196671482612, 5549.0, 5556.722163891789, 4149.813258403379, 4156.646685031776, 4166.291910258356, 4166.854160104412, 4171.561985991488, 5472.753726082336, 5520.337559492847, 5736.4550367715, 5769.88460230793, 5772.2496075510335, 3931.783751893616, 4245.834624341546, 4246.299360605527, 4252.978735106305, 4272.10285839977, 4292.5492823253735, 4292.828286868553, 4306.935395969063, 4314.460692413449, 4339.609435150788, 4548.0216105993995, 4836.3712717347225, 4836.95163048365, 4844.346013288161, 4847.781849816767, 5593.720313984284, 5602.299712535933, 5615.859603509945, 5632.549396048306, 5651.75024360994, 1434.4333988074652, 1435.7559214933488, 1442.6321288071474, 1447.3486930881145, 1448.66680663448, 936.157458287533, 992.5632721602472, 993.1409330928839, 1000.9090091799973, 1003.6487229469773, 5224.216367544898, 5239.869003274873, 5249.658772179796, 5284.101702710548, 5290.365156181283, 5526.834194974157, 5604.8318550443555, 5615.2700148981185, 5616.69108199053, 5645.322561292671, 4957.851264462072, 5182.274481572583, 5225.16397376418, 5231.973840130775, 5254.395744489432, 2942.9411411771644, 2944.440556294297, 2950.395168990352, 2951.793374463767, 2955.2907302247304, 5688.63023903445, 5689.886202275931, 5693.459121383462, 5705.258316418839, 5713.286014195724, 5380.381256155514, 5569.579757161898, 5602.411746766531, 5635.887282254332, 5646.661200327993, 5620.9437905621235, 5628.690422026746, 5642.379338272786, 5674.1488776683, 5683.556070889557, 5303.867403314948, 5473.67157970523, 5503.889922201453, 5582.4138465462165, 5603.8879222416135, 5437.374701909331, 5449.754761035842, 5453.2004438534395, 5467.043267428105, 5501.889962200654, 5638.182463542681, 5680.602357835077, 5744.511716504144, 5761.740721667451, 5875.854208429315, 4108.36320370343, 4173.14450537633, 4181.616478607165, 4183.916321673611, 4197.874063778091, 5608.579356548194, 5727.312722473163, 5749.425057494217, 5768.94231057684, 5796.652200867961, 5502.779888804403, 5568.638038527482, 5588.944110558842, 5589.357223919139, 5600.411956744483, 5573.804916827891, 5590.217369568182, 5595.685014021783, 5600.35595906476, 5630.239917611234, 5234.738263086907, 5511.669299842022, 5516.834494965157, 5558.972205138948, 5564.970480461127, 5663.207150998781, 5666.603337766317, 5670.291213598301, 5700.771969121189, 5709.885802284014, 5566.580521966873, 5570.6657600544095, 5611.298587676541, 5614.775408983758, 5617.0], "value": 4265.793360741104, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.8356328734254, 832.9125441828608, 845.5011543189516, 855.5593869157381, 869.4174902815113, 15295.311710973005, 15460.226988650578, 16106.114163720991, 16108.516744497654, 16152.111633860148, 14114.929425352859, 14156.646083847909, 14246.287685615729, 14265.500707475241, 14267.643308917257, 860.9182127697875, 875.995620021899, 877.2017464107663, 877.5349064995562, 878.0, 732.1251104929611, 750.6772088002157, 848.2111636178352, 870.1733353314345, 880.8326417980595, 922.377395258198, 922.8154369126169, 923.4551614547415, 923.6120829251697, 924.4499522783966, 921.4793641592546, 921.9216366608846, 922.4695799915042, 922.6724512797961, 922.7001224601997, 681.3731367142241, 681.9420349270318, 682.668905580793, 683.7265093962405, 684.0525871667726, 14773.630659233497, 14955.925220373938, 15002.174880381575, 15003.24983750819, 15305.846941530554, 14811.629709257248, 15216.239188040554, 15577.299021544057, 15681.607959801097, 15790.447334343244, 12047.93976030123, 12083.27500349973, 12218.266903985701, 12231.75536489274, 12268.0, 3886.7279290449396, 3887.086534664352, 3895.2599006188734, 3971.245463361952, 4002.0, 56513.0, 56993.0, 58747.118793218135, 60498.0, 62352.99999999955, 11586.47860846264, 11767.176297659082, 11794.705132371588, 11807.763844723057, 11889.405529723479, 19974.90012549928, 19981.0, 19984.0, 20058.89970550138, 20086.59826803456, 8247.422680412314, 8313.459625124347, 8327.250547450758, 8372.623231954576, 8489.533075680896, 4603.861884143481, 4677.883052923636, 4768.904621907612, 4854.17479028566, 4856.902861942742, 3464.4630082337276, 3497.5802903651215, 3500.4749287607065, 3552.2362692020824, 3581.409067503833, 598.7425407075, 616.0881894795727, 637.7225906730587, 641.1024565608186, 643.5398689936718, 716.4161208614962, 719.8740220461399, 730.5981710059552, 733.1641928201855, 749.79380670315, 9846.310758246997, 9910.603575856885, 10019.549120289605, 10090.69727908164, 10327.48362581883, 640.3340525853154, 648.18652590998, 723.6526467295728, 782.823864630465, 798.7324246377528, 4213.852515162016, 4492.595666390041, 4515.932261016087, 4588.6099681526775, 4591.816327346869, 87946.56026719953, 90368.09631903729, 90960.0, 93940.0, 94368.0, 78928.0, 79312.60343698245, 80482.5975870117, 80949.59525202453, 82894.75657865137, 70692.0, 73061.26938730651, 74032.62983685046, 75269.0, 75737.24262757412, 8666.869996950178, 8820.64717411322, 8882.378233523592, 8949.149830766068, 9015.14356136166, 45658.54341456543, 46092.30861537012, 47223.76388118038, 47611.52388476071, 47738.52261477341, 61274.38725612865, 62212.68893655503, 65345.0, 66384.0, 66491.33508664851, 11620.825687614863, 11985.101117416054, 12097.69755756078, 12457.0, 12716.74566508646, 12671.683207919876, 12998.621736611749, 13002.764737349937, 13298.933505332412, 13789.724205516035, 12366.505339786308, 12448.190867593577, 12610.684732881751, 13173.209607423585, 13232.536861209812, 12276.202046866925, 12847.357632118543, 12938.676533086747, 12965.675858103623, 12967.805482917953, 12031.879681203425, 12218.26690398579, 12617.810732839198, 12639.87360126387, 13066.412011459317, 9779.608815647294, 10251.436171010666, 10346.689599312032, 10492.265541412027, 10589.576416943237, 10027.749306267402, 11011.504482298156, 11044.668659940215, 11119.332840029625, 11158.274712143684], "value": 7323.245143258211, "unit": "score"}], "name": "dromaeo_css", "value": 7317.329876839705, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 109.0, 109.0, 112.0, 109.0, 110.0, 109.0, 110.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 118.0, 160.0, 126.0, 120.0, 122.0, 117.0, 147.0, 118.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 160.0, 161.0, 160.0, 159.0, 160.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 106.0, 75.0, 74.0, 75.0, 75.0, 97.0, 75.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 112.0, 82.0, 82.0, 82.0, 102.0, 82.0, 81.0, 114.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 54.0, 53.0, 52.0, 52.0, 52.0, 54.0, 51.0, 51.0, 51.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 61.0, 59.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 74.0, 82.0, 75.0, 75.0, 74.0, 75.0, 88.0, 75.0, 75.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 135.0, 139.0, 125.0, 120.0, 121.0, 122.0, 119.0, 159.0, 126.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 160.0, 159.0, 156.0, 161.0, 158.0, 155.0, 159.0, 158.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 64.0, 62.0, 62.0, 63.0, 62.0, 62.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1455.7999999999997, "alertThreshold": 2.0}]} 20:29:03 INFO - Return code: 0 20:29:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:29:03 INFO - # TBPL SUCCESS # 20:29:03 INFO - Running post-action listener: _resource_record_post_action 20:29:03 INFO - [mozharness: 2017-02-24 04:29:03.759008Z] Finished run-tests step (success) 20:29:03 INFO - Running post-run listener: _resource_record_post_run 20:29:03 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311455744; Read time: 12; Write time: 164364 20:29:03 INFO - TinderboxPrint: CPU usage
13.0% 20:29:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:29:03 INFO - TinderboxPrint: I/O write bytes / time
311,455,744 / 164,364 20:29:03 INFO - TinderboxPrint: CPU idle
8,252.9 (87.0%) 20:29:03 INFO - TinderboxPrint: CPU user
1,189.3 (12.5%) 20:29:03 INFO - TinderboxPrint: Swap in / out
0 / 0 20:29:03 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 97333248; Read time: 0; Write time: 68016 20:29:03 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 209731584; Read time: 12; Write time: 96068 20:29:04 INFO - Running post-run listener: _upload_blobber_files 20:29:04 INFO - Blob upload gear active. 20:29:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:29:04 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 20:29:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:29:04 INFO - (blobuploader) - INFO - Open directory for files ... 20:29:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:29:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:29:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:05 INFO - (blobuploader) - INFO - Done attempting. 20:29:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:29:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:29:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:08 INFO - (blobuploader) - INFO - Done attempting. 20:29:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:29:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:29:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:09 INFO - (blobuploader) - INFO - Done attempting. 20:29:09 INFO - (blobuploader) - INFO - Iteration through files over. 20:29:09 INFO - Return code: 0 20:29:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:29:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:29:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cd2767e310620b96106d3bd3dc2934e6be421cb769c4cb564444d84a5e5dbe21496eb1c0eb37bd1228197b245a4988cb47b5b7c5d542d9312bcc5a51b58d52f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0262b9b514518189c69077fc48dbb63b3c31adc20f2bfa4f8a47aed5efa2f55f5253ee40e53858e9ca49437d3a3eabb1fc74fd0c608432bf69b5d8c19600818e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eecc04b33af950d2247cba9b85f23caa37a037b9c3bb483b619f8cd38ab85adcaeaed927ef4bb0d490a08849d248cbb1cc538f0319f8c635929d172d4979e25b"} 20:29:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:29:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:29:09 INFO - Contents: 20:29:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cd2767e310620b96106d3bd3dc2934e6be421cb769c4cb564444d84a5e5dbe21496eb1c0eb37bd1228197b245a4988cb47b5b7c5d542d9312bcc5a51b58d52f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0262b9b514518189c69077fc48dbb63b3c31adc20f2bfa4f8a47aed5efa2f55f5253ee40e53858e9ca49437d3a3eabb1fc74fd0c608432bf69b5d8c19600818e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eecc04b33af950d2247cba9b85f23caa37a037b9c3bb483b619f8cd38ab85adcaeaed927ef4bb0d490a08849d248cbb1cc538f0319f8c635929d172d4979e25b"} 20:29:09 INFO - Running post-run listener: copy_logs_to_upload_dir 20:29:09 INFO - Copying logs to upload dir... 20:29:09 INFO - mkdir: /builds/slave/test/build/upload/logs 20:29:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.910505 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-23 20:29:09.567756) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 20:29:09.571509) ========= 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=ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cd2767e310620b96106d3bd3dc2934e6be421cb769c4cb564444d84a5e5dbe21496eb1c0eb37bd1228197b245a4988cb47b5b7c5d542d9312bcc5a51b58d52f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0262b9b514518189c69077fc48dbb63b3c31adc20f2bfa4f8a47aed5efa2f55f5253ee40e53858e9ca49437d3a3eabb1fc74fd0c608432bf69b5d8c19600818e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eecc04b33af950d2247cba9b85f23caa37a037b9c3bb483b619f8cd38ab85adcaeaed927ef4bb0d490a08849d248cbb1cc538f0319f8c635929d172d4979e25b"} build_url:https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/UU5XnCEETX-JDD1zjsUdog/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cd2767e310620b96106d3bd3dc2934e6be421cb769c4cb564444d84a5e5dbe21496eb1c0eb37bd1228197b245a4988cb47b5b7c5d542d9312bcc5a51b58d52f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0262b9b514518189c69077fc48dbb63b3c31adc20f2bfa4f8a47aed5efa2f55f5253ee40e53858e9ca49437d3a3eabb1fc74fd0c608432bf69b5d8c19600818e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eecc04b33af950d2247cba9b85f23caa37a037b9c3bb483b619f8cd38ab85adcaeaed927ef4bb0d490a08849d248cbb1cc538f0319f8c635929d172d4979e25b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 20:29:09.600360) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:29:09.600718) ========= 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=ed14279e38b05397cf4aa391000001a4-1487908697.548742-34942443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:29:09.686561) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 20:29:09.686881) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 20:29:09.687207) ========= ========= Total master_lag: 0.18 =========