builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1480722533.1 results: success (0) buildid: 20161202141144 builduid: 5379c59769e84e12858a96cd0b6f4310 revision: bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 15:48:53.099620) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 15:48:53.100231) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 15:48:53.100591) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 15:48:53.115795) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:48:53.116129) ========= 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=41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-02 15:48:53-- 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% 222M=0s 2016-12-02 15:48:53 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150678 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:48:53.285001) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:48:53.285644) ========= 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=41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013925 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:48:53.340756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 15:48:53.341769) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 --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=41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-02 15:48:53,514 truncating revision to first 12 chars 2016-12-02 15:48:53,514 Setting DEBUG logging. 2016-12-02 15:48:53,514 attempt 1/10 2016-12-02 15:48:53,514 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bb91b72c0d3b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-02 15:48:53,814 unpacking tar archive at: mozilla-aurora-bb91b72c0d3b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.033419 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 15:48:54.390003) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 15:48:54.390367) ========= script_repo_revision: bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 15:48:54.390812) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 15:48:54.391172) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 15:48:54.408767) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-12-02 15:48:54.409155) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:48:54 INFO - MultiFileLogger online at 20161202 15:48:54 in /builds/slave/test 15:48:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:48:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:48:54 INFO - {'append_to_log': False, 15:48:54 INFO - 'base_work_dir': '/builds/slave/test', 15:48:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:48:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:48:54 INFO - 'branch': 'Mozilla-Aurora', 15:48:54 INFO - 'buildbot_json_path': 'buildprops.json', 15:48:54 INFO - 'config_files': ('talos/linux_config.py',), 15:48:54 INFO - 'default_actions': ('clobber', 15:48:54 INFO - 'read-buildbot-config', 15:48:54 INFO - 'download-and-extract', 15:48:54 INFO - 'populate-webroot', 15:48:54 INFO - 'create-virtualenv', 15:48:54 INFO - 'install', 15:48:54 INFO - 'run-tests'), 15:48:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:48:54 INFO - 'download_minidump_stackwalk': True, 15:48:54 INFO - 'download_symbols': 'ondemand', 15:48:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:48:54 INFO - 'tooltool.py': '/tools/tooltool.py', 15:48:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:48:54 INFO - '/tools/misc-python/virtualenv.py')}, 15:48:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:48:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:48:54 INFO - 'installer_path': 'installer.exe', 15:48:54 INFO - 'log_level': 'info', 15:48:54 INFO - 'log_name': 'talos', 15:48:54 INFO - 'log_to_console': True, 15:48:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:48:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:48:54 INFO - 'opt_config_files': (), 15:48:54 INFO - 'pip_index': False, 15:48:54 INFO - 'sps_profile': False, 15:48:54 INFO - 'sps_profile_interval': 0, 15:48:54 INFO - 'suite': 'dromaeojs-e10s', 15:48:54 INFO - 'system_bits': '32', 15:48:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:48:54 INFO - 'title': 'talos-linux64-ix-024', 15:48:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:48:54 INFO - 'use_talos_json': True, 15:48:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:48:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:48:54 INFO - 'work_dir': 'build'} 15:48:54 INFO - [mozharness: 2016-12-02 23:48:54.681749Z] Running clobber step. 15:48:54 INFO - Running pre-action listener: _resource_record_pre_action 15:48:54 INFO - Running main action method: clobber 15:48:54 INFO - rmtree: /builds/slave/test/build 15:48:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:48:55 INFO - Running post-action listener: _resource_record_post_action 15:48:55 INFO - [mozharness: 2016-12-02 23:48:55.140338Z] Finished clobber step (success) 15:48:55 INFO - [mozharness: 2016-12-02 23:48:55.140438Z] Running read-buildbot-config step. 15:48:55 INFO - Running pre-action listener: _resource_record_pre_action 15:48:55 INFO - Running main action method: read_buildbot_config 15:48:55 INFO - Using buildbot properties: 15:48:55 INFO - { 15:48:55 INFO - "project": "", 15:48:55 INFO - "product": "firefox", 15:48:55 INFO - "script_repo_revision": "production", 15:48:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:48:55 INFO - "repository": "", 15:48:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:48:55 INFO - "buildid": "20161202141144", 15:48:55 INFO - "pgo_build": "True", 15:48:55 INFO - "basedir": "/builds/slave/test", 15:48:55 INFO - "buildnumber": 692, 15:48:55 INFO - "slavename": "talos-linux64-ix-024", 15:48:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:48:55 INFO - "platform": "ubuntu64_hw", 15:48:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:48:55 INFO - "branch": "mozilla-aurora", 15:48:55 INFO - "repo_path": "releases/mozilla-aurora", 15:48:55 INFO - "revision": "bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1", 15:48:55 INFO - "stage_platform": "linux64-pgo", 15:48:55 INFO - "builduid": "5379c59769e84e12858a96cd0b6f4310", 15:48:55 INFO - "slavebuilddir": "test" 15:48:55 INFO - } 15:48:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 15:48:55 INFO - Running post-action listener: _resource_record_post_action 15:48:55 INFO - [mozharness: 2016-12-02 23:48:55.142900Z] Finished read-buildbot-config step (success) 15:48:55 INFO - [mozharness: 2016-12-02 23:48:55.142988Z] Running download-and-extract step. 15:48:55 INFO - Running pre-action listener: _resource_record_pre_action 15:48:55 INFO - Running main action method: download_and_extract 15:48:55 INFO - mkdir: /builds/slave/test/build/tests 15:48: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')]} 15:48:55 INFO - trying https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:48:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:48:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:48:55 INFO - Downloaded 1361 bytes. 15:48:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:48:55 INFO - Using the following test package requirements: 15:48:55 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 15:48:55 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:48:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:48:55 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:48:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:48:55 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:48:55 INFO - u'jsshell-linux-x86_64.zip'], 15:48:55 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:48:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:48:55 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 15:48:55 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:48:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:48:55 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:48:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:48:55 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:48:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:48:55 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:48:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:48:55 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:48:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 15:48:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:48:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:48:56 INFO - Http code: 200 15:48:56 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 15:48:56 INFO - x-amz-cf-id: rzq5t_cfBx8wF28oxNyjO1cWhDmOsM-UKypbXLmUbRUjesvgQhzarg== 15:48:56 INFO - x-amz-version-id: y9GuPwKeNgzW9zz9DeoAsCnALJzpgary 15:48:57 INFO - Expected file size: 21955360 15:48:57 INFO - Obtained file size: 21955360 15:49:01 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:49:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 15:49:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:49:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:49:02 INFO - Http code: 200 15:49:02 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 15:49:02 INFO - x-amz-cf-id: YBjmW66ZvBS-wK5r732FWggA4mb26yrArWlIih3hk3vob4RAZ9ARRg== 15:49:02 INFO - x-amz-version-id: y9GuPwKeNgzW9zz9DeoAsCnALJzpgary 15:49:02 INFO - Expected file size: 21955360 15:49:02 INFO - Obtained file size: 21955360 15:49:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 15:49:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:49:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 15:49:07 INFO - Http code: 200 15:49:07 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 15:49:07 INFO - x-amz-cf-id: auK0DJj6J7HsE_fFzNFofOONRxsjjRmthPo2W_fgip7XUNJqxrSq3w== 15:49:07 INFO - x-amz-version-id: hHJ1SfvtQqXUfFWxHYxzioUH8f5thues 15:49:08 INFO - Expected file size: 14409038 15:49:08 INFO - Obtained file size: 14409038 15:49:09 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')]} 15:49:09 INFO - trying https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:49:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:49:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:49:11 INFO - Downloaded 63987849 bytes. 15:49:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:49:11 INFO - mkdir: /builds/slave/test/properties 15:49:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:49:11 INFO - Writing to file /builds/slave/test/properties/build_url 15:49:11 INFO - Contents: 15:49:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:49:12 INFO - Running post-action listener: _resource_record_post_action 15:49:12 INFO - Running post-action listener: set_extra_try_arguments 15:49:12 INFO - [mozharness: 2016-12-02 23:49:12.623883Z] Finished download-and-extract step (success) 15:49:12 INFO - [mozharness: 2016-12-02 23:49:12.624109Z] Running populate-webroot step. 15:49:12 INFO - Running pre-action listener: _resource_record_pre_action 15:49:12 INFO - Running main action method: populate_webroot 15:49:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:49:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:49:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:49:12 INFO - '--tppagecycles', 15:49:12 INFO - '7'], 15:49:12 INFO - 'tests': ['tsvgm']}}, 15:49:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:49:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:49:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:49:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:49:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:49:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:49:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:12 INFO - 'talos_options': ['--disable-e10s'], 15:49:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:12 INFO - 'talos_options': ['--disable-e10s'], 15:49:12 INFO - 'tests': ['damp', 'tps']}, 15:49:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:12 INFO - 'tests': ['damp', 'tps']}, 15:49:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:49:12 INFO - 'tests': ['dromaeo_dom']}, 15:49:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:49:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:49:12 INFO - 'tests': ['basic_compositor_video']}, 15:49:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:49:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:49:12 INFO - 'tests': ['a11yr', 15:49:12 INFO - 'ts_paint', 15:49:12 INFO - 'tpaint', 15:49:12 INFO - 'sessionrestore', 15:49:12 INFO - 'sessionrestore_no_auto_restore', 15:49:12 INFO - 'tabpaint']}, 15:49:12 INFO - 'other-e10s': {'tests': ['a11yr', 15:49:12 INFO - 'ts_paint', 15:49:12 INFO - 'tpaint', 15:49:12 INFO - 'sessionrestore', 15:49:12 INFO - 'sessionrestore_no_auto_restore', 15:49:12 INFO - 'tabpaint']}, 15:49:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:49:12 INFO - 'ts_paint', 15:49:12 INFO - 'tpaint', 15:49:12 INFO - 'sessionrestore', 15:49:12 INFO - 'sessionrestore_no_auto_restore', 15:49:12 INFO - 'tabpaint']}, 15:49:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:49:12 INFO - 'ts_paint', 15:49:12 INFO - 'tpaint', 15:49:12 INFO - 'sessionrestore', 15:49:12 INFO - 'sessionrestore_no_auto_restore', 15:49:12 INFO - 'tabpaint']}, 15:49:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:49:12 INFO - 'tests': ['a11yr', 15:49:12 INFO - 'ts_paint', 15:49:12 INFO - 'tpaint', 15:49:12 INFO - 'sessionrestore', 15:49:12 INFO - 'sessionrestore_no_auto_restore', 15:49:12 INFO - 'tabpaint']}, 15:49:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:49:12 INFO - 'tests': ['a11yr', 15:49:12 INFO - 'ts_paint', 15:49:12 INFO - 'tpaint', 15:49:12 INFO - 'sessionrestore', 15:49:12 INFO - 'sessionrestore_no_auto_restore', 15:49:12 INFO - 'tabpaint']}, 15:49:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:49:12 INFO - 'tests': ['tsvgx', 15:49:12 INFO - 'tsvgr_opacity', 15:49:12 INFO - 'tart', 15:49:12 INFO - 'tscrollx', 15:49:12 INFO - 'cart']}, 15:49:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:49:12 INFO - 'tsvgr_opacity', 15:49:12 INFO - 'tart', 15:49:12 INFO - 'tscrollx', 15:49:12 INFO - 'cart']}, 15:49:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:12 INFO - 'talos_options': ['--disable-e10s'], 15:49:12 INFO - 'tests': ['tp5o']}, 15:49:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:12 INFO - 'tests': ['tp5o']}, 15:49:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:12 INFO - 'talos_options': ['--disable-e10s', 15:49:12 INFO - '--xperf_path', 15:49:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:12 INFO - 'tests': ['tp5n']}, 15:49:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:12 INFO - 'talos_options': ['--xperf_path', 15:49:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:12 INFO - 'tests': ['tp5n']}}, 15:49:12 INFO - 'talos.zip': {'path': '', 15:49:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:49:12 INFO - Running post-action listener: _resource_record_post_action 15:49:12 INFO - [mozharness: 2016-12-02 23:49:12.641036Z] Finished populate-webroot step (success) 15:49:12 INFO - [mozharness: 2016-12-02 23:49:12.641124Z] Running create-virtualenv step. 15:49:12 INFO - Running pre-action listener: _resource_record_pre_action 15:49:12 INFO - Running main action method: create_virtualenv 15:49:12 INFO - Creating virtualenv /builds/slave/test/build/venv 15:49:12 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 15:49:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:49:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:49:12 INFO - Using real prefix '/usr' 15:49:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:49:13 INFO - Installing distribute.............................................................................................................................................................................................done. 15:49:15 INFO - Installing pip.................done. 15:49:15 INFO - Return code: 0 15:49:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:49:15 INFO - Reading from file tmpfile_stdout 15:49:15 INFO - Output received: 15:49:15 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) 15:49:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42d7de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7f60>, '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 0x1cf8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf91d0>, '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': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', '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 15:49:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:49:15 INFO - Using env: {'DISPLAY': ':0', 15:49:15 INFO - 'HOME': '/home/cltbld', 15:49:15 INFO - 'LANG': 'en_US.UTF-8', 15:49:15 INFO - 'LANGUAGE': 'en_US:en', 15:49:15 INFO - 'LOGNAME': 'cltbld', 15:49:15 INFO - 'MAIL': '/var/mail/cltbld', 15:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:15 INFO - 'MOZ_NO_REMOTE': '1', 15:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:15 INFO - 'NO_EM_RESTART': '1', 15:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:15 INFO - 'PWD': '/builds/slave/test', 15:49:15 INFO - 'SHELL': '/bin/bash', 15:49:15 INFO - 'SHLVL': '1', 15:49:15 INFO - 'TERM': 'linux', 15:49:15 INFO - 'TMOUT': '86400', 15:49:15 INFO - 'USER': 'cltbld', 15:49:15 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', 15:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:15 INFO - '_': '/tools/buildbot/bin/python'} 15:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:15 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 15:49:15 INFO - Cleaning up... 15:49:15 INFO - Return code: 0 15:49:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f42d7de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7f60>, '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 0x1cf8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf91d0>, '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': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', '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 15:49:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:49:15 INFO - Using env: {'DISPLAY': ':0', 15:49:15 INFO - 'HOME': '/home/cltbld', 15:49:15 INFO - 'LANG': 'en_US.UTF-8', 15:49:15 INFO - 'LANGUAGE': 'en_US:en', 15:49:15 INFO - 'LOGNAME': 'cltbld', 15:49:15 INFO - 'MAIL': '/var/mail/cltbld', 15:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:15 INFO - 'MOZ_NO_REMOTE': '1', 15:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:15 INFO - 'NO_EM_RESTART': '1', 15:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:15 INFO - 'PWD': '/builds/slave/test', 15:49:15 INFO - 'SHELL': '/bin/bash', 15:49:15 INFO - 'SHLVL': '1', 15:49:15 INFO - 'TERM': 'linux', 15:49:15 INFO - 'TMOUT': '86400', 15:49:15 INFO - 'USER': 'cltbld', 15:49:15 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', 15:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:15 INFO - '_': '/tools/buildbot/bin/python'} 15:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:15 INFO - Downloading/unpacking psutil>=3.1.1 15:49:15 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 15:49:15 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 15:49:15 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 15:49:15 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 15:49:15 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 15:49:15 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 15:49:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:49:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:17 INFO - Installing collected packages: psutil 15:49:17 INFO - Running setup.py install for psutil 15:49:18 INFO - building 'psutil._psutil_linux' extension 15:49:18 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 15:49:18 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 15:49:18 INFO - building 'psutil._psutil_posix' extension 15:49:18 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 15:49:18 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 15:49:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:18 INFO - Successfully installed psutil 15:49:18 INFO - Cleaning up... 15:49:18 INFO - Return code: 0 15:49:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:49:18 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')]} 15:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:18 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')]} 15:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:18 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 0x7f42d7de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7f60>, '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 0x1cf8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf91d0>, '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': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', '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 15:49:18 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 15:49:18 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 15:49:18 INFO - Using env: {'DISPLAY': ':0', 15:49:18 INFO - 'HOME': '/home/cltbld', 15:49:18 INFO - 'LANG': 'en_US.UTF-8', 15:49:18 INFO - 'LANGUAGE': 'en_US:en', 15:49:18 INFO - 'LOGNAME': 'cltbld', 15:49:18 INFO - 'MAIL': '/var/mail/cltbld', 15:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:18 INFO - 'MOZ_NO_REMOTE': '1', 15:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:18 INFO - 'NO_EM_RESTART': '1', 15:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:18 INFO - 'PWD': '/builds/slave/test', 15:49:18 INFO - 'SHELL': '/bin/bash', 15:49:18 INFO - 'SHLVL': '1', 15:49:18 INFO - 'TERM': 'linux', 15:49:18 INFO - 'TMOUT': '86400', 15:49:18 INFO - 'USER': 'cltbld', 15:49:18 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', 15:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:18 INFO - '_': '/tools/buildbot/bin/python'} 15:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:49:18 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 15:49:18 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 15:49:18 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 15:49:18 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 15:49:18 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 15:49:18 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 15:49:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:49:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:49:20 INFO - Installing collected packages: mozsystemmonitor 15:49:20 INFO - Running setup.py install for mozsystemmonitor 15:49:20 INFO - Successfully installed mozsystemmonitor 15:49:20 INFO - Cleaning up... 15:49:20 INFO - Return code: 0 15:49:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:49:20 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')]} 15:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:20 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')]} 15:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:20 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 0x7f42d7de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7f60>, '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 0x1cf8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf91d0>, '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': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', '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 15:49:20 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 15:49:20 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 15:49:20 INFO - Using env: {'DISPLAY': ':0', 15:49:20 INFO - 'HOME': '/home/cltbld', 15:49:20 INFO - 'LANG': 'en_US.UTF-8', 15:49:20 INFO - 'LANGUAGE': 'en_US:en', 15:49:20 INFO - 'LOGNAME': 'cltbld', 15:49:20 INFO - 'MAIL': '/var/mail/cltbld', 15:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:20 INFO - 'MOZ_NO_REMOTE': '1', 15:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:20 INFO - 'NO_EM_RESTART': '1', 15:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:20 INFO - 'PWD': '/builds/slave/test', 15:49:20 INFO - 'SHELL': '/bin/bash', 15:49:20 INFO - 'SHLVL': '1', 15:49:20 INFO - 'TERM': 'linux', 15:49:20 INFO - 'TMOUT': '86400', 15:49:20 INFO - 'USER': 'cltbld', 15:49:20 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', 15:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:20 INFO - '_': '/tools/buildbot/bin/python'} 15:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:21 INFO - Downloading/unpacking jsonschema==2.5.1 15:49:21 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 15:49:21 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 15:49:21 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 15:49:21 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 15:49:21 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 15:49:21 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 15:49:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:49:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:49:23 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 15:49:23 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 15:49:23 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 15:49:23 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 15:49:23 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 15:49:23 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 15:49:23 INFO - Downloading functools32-3.2.3-2.tar.gz 15:49:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:49:23 INFO - warning: no files found matching '*.txt' 15:49:23 INFO - no previously-included directories found matching 'build' 15:49:23 INFO - no previously-included directories found matching 'dist' 15:49:23 INFO - no previously-included directories found matching '.git*' 15:49:23 INFO - Installing collected packages: jsonschema, functools32 15:49:23 INFO - Running setup.py install for functools32 15:49:23 INFO - warning: no files found matching '*.txt' 15:49:23 INFO - no previously-included directories found matching 'build' 15:49:23 INFO - no previously-included directories found matching 'dist' 15:49:23 INFO - no previously-included directories found matching '.git*' 15:49:23 INFO - Successfully installed jsonschema functools32 15:49:23 INFO - Cleaning up... 15:49:23 INFO - Return code: 0 15:49:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:49:23 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')]} 15:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:23 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')]} 15:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:23 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 0x7f42d7de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7f60>, '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 0x1cf8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf91d0>, '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': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', '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 15:49:23 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 15:49:23 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 15:49:23 INFO - Using env: {'DISPLAY': ':0', 15:49:23 INFO - 'HOME': '/home/cltbld', 15:49:23 INFO - 'LANG': 'en_US.UTF-8', 15:49:23 INFO - 'LANGUAGE': 'en_US:en', 15:49:23 INFO - 'LOGNAME': 'cltbld', 15:49:23 INFO - 'MAIL': '/var/mail/cltbld', 15:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:23 INFO - 'MOZ_NO_REMOTE': '1', 15:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:23 INFO - 'NO_EM_RESTART': '1', 15:49:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:23 INFO - 'PWD': '/builds/slave/test', 15:49:23 INFO - 'SHELL': '/bin/bash', 15:49:23 INFO - 'SHLVL': '1', 15:49:23 INFO - 'TERM': 'linux', 15:49:23 INFO - 'TMOUT': '86400', 15:49:23 INFO - 'USER': 'cltbld', 15:49:23 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', 15:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:23 INFO - '_': '/tools/buildbot/bin/python'} 15:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:49:23 INFO - Cleaning up... 15:49:23 INFO - Return code: 0 15:49:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:49:23 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')]} 15:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:23 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')]} 15:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:23 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 0x7f42d7de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7f60>, '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 0x1cf8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf91d0>, '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': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', '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 15:49:23 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 15:49:23 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 15:49:23 INFO - Using env: {'DISPLAY': ':0', 15:49:23 INFO - 'HOME': '/home/cltbld', 15:49:23 INFO - 'LANG': 'en_US.UTF-8', 15:49:23 INFO - 'LANGUAGE': 'en_US:en', 15:49:23 INFO - 'LOGNAME': 'cltbld', 15:49:23 INFO - 'MAIL': '/var/mail/cltbld', 15:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:23 INFO - 'MOZ_NO_REMOTE': '1', 15:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:23 INFO - 'NO_EM_RESTART': '1', 15:49:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:23 INFO - 'PWD': '/builds/slave/test', 15:49:23 INFO - 'SHELL': '/bin/bash', 15:49:23 INFO - 'SHLVL': '1', 15:49:23 INFO - 'TERM': 'linux', 15:49:23 INFO - 'TMOUT': '86400', 15:49:23 INFO - 'USER': 'cltbld', 15:49:23 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', 15:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:23 INFO - '_': '/tools/buildbot/bin/python'} 15:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:24 INFO - Downloading/unpacking blobuploader==1.2.4 15:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:25 INFO - Downloading blobuploader-1.2.4.tar.gz 15:49:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:49:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:49:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:26 INFO - Downloading docopt-0.6.1.tar.gz 15:49:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:49:26 INFO - Installing collected packages: blobuploader, requests, docopt 15:49:26 INFO - Running setup.py install for blobuploader 15:49:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:49:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:49:26 INFO - Running setup.py install for requests 15:49:27 INFO - Running setup.py install for docopt 15:49:27 INFO - Successfully installed blobuploader requests docopt 15:49:27 INFO - Cleaning up... 15:49:27 INFO - Return code: 0 15:49:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:27 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 0x7f42d7de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7f60>, '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 0x1cf8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf91d0>, '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': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', '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 15:49:27 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 15:49:27 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 15:49:27 INFO - Using env: {'DISPLAY': ':0', 15:49:27 INFO - 'HOME': '/home/cltbld', 15:49:27 INFO - 'LANG': 'en_US.UTF-8', 15:49:27 INFO - 'LANGUAGE': 'en_US:en', 15:49:27 INFO - 'LOGNAME': 'cltbld', 15:49:27 INFO - 'MAIL': '/var/mail/cltbld', 15:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:27 INFO - 'MOZ_NO_REMOTE': '1', 15:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:27 INFO - 'NO_EM_RESTART': '1', 15:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:27 INFO - 'PWD': '/builds/slave/test', 15:49:27 INFO - 'SHELL': '/bin/bash', 15:49:27 INFO - 'SHLVL': '1', 15:49:27 INFO - 'TERM': 'linux', 15:49:27 INFO - 'TMOUT': '86400', 15:49:27 INFO - 'USER': 'cltbld', 15:49:27 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', 15:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:27 INFO - '_': '/tools/buildbot/bin/python'} 15:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:27 INFO - Running setup.py (path:/tmp/pip-TiRijc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:27 INFO - Running setup.py (path:/tmp/pip-ut2AZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:27 INFO - Running setup.py (path:/tmp/pip-bP2XlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:27 INFO - Running setup.py (path:/tmp/pip-V4mtXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:27 INFO - Running setup.py (path:/tmp/pip-n78LCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:27 INFO - Running setup.py (path:/tmp/pip-gQGRb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:28 INFO - Running setup.py (path:/tmp/pip-UqyKi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:28 INFO - Running setup.py (path:/tmp/pip-oeRNvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:28 INFO - Running setup.py (path:/tmp/pip-CQIS2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:28 INFO - Running setup.py (path:/tmp/pip-aI6ZXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:28 INFO - Running setup.py (path:/tmp/pip-tx94C1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:28 INFO - Running setup.py (path:/tmp/pip-xwgdXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:28 INFO - Running setup.py (path:/tmp/pip-bxYK2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:28 INFO - Running setup.py (path:/tmp/pip-Wz9Gf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:28 INFO - Running setup.py (path:/tmp/pip-Vz9HjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:28 INFO - Running setup.py (path:/tmp/pip-mIAiy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:28 INFO - Running setup.py (path:/tmp/pip-RKJ4GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:49:28 INFO - Running setup.py install for manifestparser 15:49:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:49:28 INFO - Running setup.py install for mozcrash 15:49:29 INFO - Running setup.py install for mozdebug 15:49:29 INFO - Running setup.py install for mozdevice 15:49:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:49:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:49:29 INFO - Running setup.py install for mozfile 15:49:29 INFO - Running setup.py install for mozhttpd 15:49:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:49:29 INFO - Running setup.py install for mozinfo 15:49:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:49:29 INFO - Running setup.py install for mozInstall 15:49:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:49:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:49:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:49:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:49:29 INFO - Running setup.py install for mozleak 15:49:29 INFO - Running setup.py install for mozlog 15:49:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:49:29 INFO - Running setup.py install for moznetwork 15:49:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:49:30 INFO - Running setup.py install for mozprocess 15:49:30 INFO - Running setup.py install for mozprofile 15:49:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:49:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:49:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:49:30 INFO - Running setup.py install for mozrunner 15:49:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:49:30 INFO - Running setup.py install for mozscreenshot 15:49:30 INFO - Running setup.py install for moztest 15:49:30 INFO - Running setup.py install for mozversion 15:49:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:49:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:49:30 INFO - Cleaning up... 15:49:30 INFO - Return code: 0 15:49:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:30 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')]} 15:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:30 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')]} 15:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:30 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 0x7f42d7de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7f60>, '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 0x1cf8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf91d0>, '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': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', '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 15:49:30 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 15:49:30 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 15:49:30 INFO - Using env: {'DISPLAY': ':0', 15:49:30 INFO - 'HOME': '/home/cltbld', 15:49:30 INFO - 'LANG': 'en_US.UTF-8', 15:49:30 INFO - 'LANGUAGE': 'en_US:en', 15:49:30 INFO - 'LOGNAME': 'cltbld', 15:49:30 INFO - 'MAIL': '/var/mail/cltbld', 15:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:30 INFO - 'MOZ_NO_REMOTE': '1', 15:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:30 INFO - 'NO_EM_RESTART': '1', 15:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:30 INFO - 'PWD': '/builds/slave/test', 15:49:30 INFO - 'SHELL': '/bin/bash', 15:49:30 INFO - 'SHLVL': '1', 15:49:30 INFO - 'TERM': 'linux', 15:49:30 INFO - 'TMOUT': '86400', 15:49:30 INFO - 'USER': 'cltbld', 15:49:30 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', 15:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:30 INFO - '_': '/tools/buildbot/bin/python'} 15:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:30 INFO - Running setup.py (path:/tmp/pip-Ux7cMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:30 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)) 15:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:30 INFO - Running setup.py (path:/tmp/pip-0wpNi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:31 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)) 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:31 INFO - Running setup.py (path:/tmp/pip-d6vnLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:31 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)) 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:31 INFO - Running setup.py (path:/tmp/pip-7xxBO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:31 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)) 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:31 INFO - Running setup.py (path:/tmp/pip-OlLCaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:31 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)) 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:31 INFO - Running setup.py (path:/tmp/pip-7MLEXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:31 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)) 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:31 INFO - Running setup.py (path:/tmp/pip-sLnDcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:31 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)) 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:31 INFO - Running setup.py (path:/tmp/pip-inKvEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:31 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)) 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:31 INFO - Running setup.py (path:/tmp/pip-PN6rb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:31 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)) 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:31 INFO - Running setup.py (path:/tmp/pip-GCIw0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:31 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)) 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:31 INFO - Running setup.py (path:/tmp/pip-JFwHgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:31 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)) 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:31 INFO - Running setup.py (path:/tmp/pip-PdlCL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:31 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)) 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:31 INFO - Running setup.py (path:/tmp/pip-SL1zsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:31 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)) 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:31 INFO - Running setup.py (path:/tmp/pip-y9pWmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:31 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)) 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:31 INFO - Running setup.py (path:/tmp/pip-BGagWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:31 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)) 15:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:31 INFO - Running setup.py (path:/tmp/pip-Q5gcv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:32 INFO - Running setup.py (path:/tmp/pip-XxAfer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:32 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)) 15:49:32 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)) 15:49:32 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)) 15:49:32 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)) 15:49:32 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)) 15:49:32 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)) 15:49:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:49:32 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 15:49:32 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 15:49:32 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 15:49:32 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 15:49:32 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 15:49:32 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 15:49:34 INFO - Downloading blessings-1.6.tar.gz 15:49:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:49:34 INFO - Installing collected packages: blessings 15:49:34 INFO - Running setup.py install for blessings 15:49:34 INFO - Successfully installed blessings 15:49:34 INFO - Cleaning up... 15:49:34 INFO - Return code: 0 15:49:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:49:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:34 INFO - Reading from file tmpfile_stdout 15:49:34 INFO - Current package versions: 15:49:34 INFO - argparse == 1.2.1 15:49:34 INFO - blessings == 1.6 15:49:34 INFO - blobuploader == 1.2.4 15:49:34 INFO - docopt == 0.6.1 15:49:34 INFO - functools32 == 3.2.3-2 15:49:34 INFO - jsonschema == 2.5.1 15:49:34 INFO - manifestparser == 1.1 15:49:34 INFO - mozInstall == 1.12 15:49:34 INFO - mozcrash == 1.0 15:49:34 INFO - mozdebug == 0.1 15:49:34 INFO - mozdevice == 0.48 15:49:34 INFO - mozfile == 1.2 15:49:34 INFO - mozhttpd == 0.7 15:49:34 INFO - mozinfo == 0.9 15:49:34 INFO - mozleak == 0.1 15:49:34 INFO - mozlog == 3.4 15:49:34 INFO - moznetwork == 0.27 15:49:34 INFO - mozprocess == 0.23 15:49:34 INFO - mozprofile == 0.28 15:49:34 INFO - mozrunner == 6.13 15:49:34 INFO - mozscreenshot == 0.1 15:49:34 INFO - mozsystemmonitor == 0.3 15:49:34 INFO - moztest == 0.7 15:49:34 INFO - mozversion == 1.4 15:49:34 INFO - psutil == 3.1.1 15:49:34 INFO - requests == 1.2.3 15:49:34 INFO - wsgiref == 0.1.2 15:49:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49: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')]} 15:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49: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')]} 15:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:34 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 0x7f42d7de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7f60>, '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 0x1cf8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf91d0>, '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': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', '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 15:49:34 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 15:49:34 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 15:49:34 INFO - Using env: {'DISPLAY': ':0', 15:49:34 INFO - 'HOME': '/home/cltbld', 15:49:34 INFO - 'LANG': 'en_US.UTF-8', 15:49:34 INFO - 'LANGUAGE': 'en_US:en', 15:49:34 INFO - 'LOGNAME': 'cltbld', 15:49:34 INFO - 'MAIL': '/var/mail/cltbld', 15:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:34 INFO - 'MOZ_NO_REMOTE': '1', 15:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:34 INFO - 'NO_EM_RESTART': '1', 15:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:34 INFO - 'PWD': '/builds/slave/test', 15:49:34 INFO - 'SHELL': '/bin/bash', 15:49:34 INFO - 'SHLVL': '1', 15:49:34 INFO - 'TERM': 'linux', 15:49:34 INFO - 'TMOUT': '86400', 15:49:34 INFO - 'USER': 'cltbld', 15:49:34 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', 15:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:34 INFO - '_': '/tools/buildbot/bin/python'} 15:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:34 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)) 15:49:34 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)) 15:49:34 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)) 15:49:34 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)) 15:49:34 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)) 15:49:34 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)) 15:49:34 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)) 15:49:34 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)) 15:49:34 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)) 15:49:34 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)) 15:49:34 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)) 15:49:34 INFO - Cleaning up... 15:49:35 INFO - Return code: 0 15:49:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42d7de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7f60>, '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 0x1cf8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf91d0>, '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': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', '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 15:49:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:49:35 INFO - Using env: {'DISPLAY': ':0', 15:49:35 INFO - 'HOME': '/home/cltbld', 15:49:35 INFO - 'LANG': 'en_US.UTF-8', 15:49:35 INFO - 'LANGUAGE': 'en_US:en', 15:49:35 INFO - 'LOGNAME': 'cltbld', 15:49:35 INFO - 'MAIL': '/var/mail/cltbld', 15:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:35 INFO - 'MOZ_NO_REMOTE': '1', 15:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:35 INFO - 'NO_EM_RESTART': '1', 15:49:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:35 INFO - 'PWD': '/builds/slave/test', 15:49:35 INFO - 'SHELL': '/bin/bash', 15:49:35 INFO - 'SHLVL': '1', 15:49:35 INFO - 'TERM': 'linux', 15:49:35 INFO - 'TMOUT': '86400', 15:49:35 INFO - 'USER': 'cltbld', 15:49:35 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', 15:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:35 INFO - '_': '/tools/buildbot/bin/python'} 15:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:49:35 INFO - Cleaning up... 15:49:35 INFO - Return code: 0 15:49:35 INFO - Running post-action listener: _resource_record_post_action 15:49:35 INFO - Running post-action listener: _start_resource_monitoring 15:49:35 INFO - Starting resource monitoring. 15:49:35 INFO - [mozharness: 2016-12-02 23:49:35.259763Z] Finished create-virtualenv step (success) 15:49:35 INFO - [mozharness: 2016-12-02 23:49:35.260229Z] Running install step. 15:49:35 INFO - Running pre-action listener: _resource_record_pre_action 15:49:35 INFO - Running main action method: install 15:49:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:35 INFO - Reading from file tmpfile_stdout 15:49:35 INFO - Detecting whether we're running mozinstall >=1.0... 15:49:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:49:35 INFO - Reading from file tmpfile_stdout 15:49:35 INFO - Output received: 15:49:35 INFO - Usage: mozinstall [options] installer 15:49:35 INFO - Options: 15:49:35 INFO - -h, --help show this help message and exit 15:49:35 INFO - -d DEST, --destination=DEST 15:49:35 INFO - Directory to install application into. [default: 15:49:35 INFO - "/builds/slave/test"] 15:49:35 INFO - --app=APP Application being installed. [default: firefox] 15:49:35 INFO - mkdir: /builds/slave/test/build/application 15:49:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:49:51 INFO - Reading from file tmpfile_stdout 15:49:51 INFO - Output received: 15:49:51 INFO - /builds/slave/test/build/application/firefox/firefox 15:49:51 INFO - Running post-action listener: _resource_record_post_action 15:49:51 INFO - [mozharness: 2016-12-02 23:49:51.465777Z] Finished install step (success) 15:49:51 INFO - [mozharness: 2016-12-02 23:49:51.466087Z] Running run-tests step. 15:49:51 INFO - Running pre-action listener: _resource_record_pre_action 15:49:51 INFO - Running main action method: run_tests 15:49:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:49:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:49:51 INFO - Python 2.7.3 15:49:51 INFO - Return code: 0 15:49:51 INFO - grabbing minidump binary from tooltool 15:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:51 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 0x1cf7f60>, '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 0x1cf8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf91d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:49:51 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 15:49:51 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 15:49:51 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 15:49:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:49:51 INFO - Return code: 0 15:49:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:49:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:49:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:49:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:49:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:49:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:49:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:49:51 INFO - Using env: {'DISPLAY': ':0', 15:49:51 INFO - 'HOME': '/home/cltbld', 15:49:51 INFO - 'LANG': 'en_US.UTF-8', 15:49:51 INFO - 'LANGUAGE': 'en_US:en', 15:49:51 INFO - 'LOGNAME': 'cltbld', 15:49:51 INFO - 'MAIL': '/var/mail/cltbld', 15:49:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:49:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:51 INFO - 'MOZ_NO_REMOTE': '1', 15:49:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:51 INFO - 'NO_EM_RESTART': '1', 15:49:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:51 INFO - 'PWD': '/builds/slave/test', 15:49:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:49:51 INFO - 'SHELL': '/bin/bash', 15:49:51 INFO - 'SHLVL': '1', 15:49:51 INFO - 'TERM': 'linux', 15:49:51 INFO - 'TMOUT': '86400', 15:49:51 INFO - 'USER': 'cltbld', 15:49:51 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599', 15:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:51 INFO - '_': '/tools/buildbot/bin/python'} 15:49:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:49:51 INFO - mozversion application_buildid: 20161202141144 15:49:51 INFO - mozversion application_changeset: bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 15:49:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:49:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:49:51 INFO - mozversion application_name: Firefox 15:49:51 INFO - mozversion application_remotingname: firefox-dev 15:49:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:49:51 INFO - mozversion application_vendor: Mozilla 15:49:51 INFO - mozversion application_version: 52.0a2 15:49:51 INFO - mozversion platform_buildid: 20161202141144 15:49:51 INFO - mozversion platform_changeset: bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 15:49:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:49:51 INFO - mozversion platform_version: 52.0a2 15:49:51 INFO - using testdate: 1480722591 15:49:51 INFO - actual date: 1480722591 15:49:51 INFO - starting webserver on 'localhost:36223' 15:49:51 INFO - SUITE-START | Running 2 tests 15:49:51 INFO - TEST-START | dromaeo_css 15:49:51 INFO - operating with platform_type : linux_ 15:49:51 INFO - Initialising browser for dromaeo_css test... 15:49:51 INFO - TEST-INFO | started process 11122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6BWkbD/profile http://localhost:36223/getInfo.html) 15:49:56 INFO - PROCESS | 11122 | __metrics Screen width/height:1600/1200 15:49:56 INFO - PROCESS | 11122 | colorDepth:24 15:49:56 INFO - PROCESS | 11122 | Browser inner width/height: 1024/697 15:49:56 INFO - PROCESS | 11122 | __metrics 15:49:57 ERROR - PROCESS | 11122 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 15:49:57 INFO - TEST-INFO | 11122: exit 0 15:49:57 INFO - Browser initialized. 15:49:57 INFO - Running cycle 1/1 for dromaeo_css test... 15:49:57 INFO - TEST-INFO | started process 11257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6BWkbD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:09 INFO - PROCESS | 11257 | RSS: Main: 151576576 15:50:09 INFO - PROCESS | 11257 | 15:50:59 INFO - PROCESS | 11257 | 1480722659379 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:53:09 INFO - PROCESS | 11257 | Cycle 1(1): loaded http://localhost:36223/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36223/tests/dromaeo/cssquery-ext.html) 15:53:11 INFO - PROCESS | 11257 | RSS: Main: 156045312 15:53:11 INFO - PROCESS | 11257 | 15:56:13 INFO - PROCESS | 11257 | Cycle 1(1): loaded http://localhost:36223/tests/dromaeo/cssquery-ext.html (next: http://localhost:36223/tests/dromaeo/cssquery-jquery.html) 15:56:13 INFO - PROCESS | 11257 | RSS: Main: 153047040 15:56:13 INFO - PROCESS | 11257 | 15:59:15 INFO - PROCESS | 11257 | Cycle 1(1): loaded http://localhost:36223/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36223/tests/dromaeo/cssquery-mootools.html) 15:59:16 INFO - PROCESS | 11257 | RSS: Main: 153165824 15:59:16 INFO - PROCESS | 11257 | 16:02:17 INFO - PROCESS | 11257 | Cycle 1(1): loaded http://localhost:36223/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36223/tests/dromaeo/cssquery-prototype.html) 16:02:18 INFO - PROCESS | 11257 | RSS: Main: 151609344 16:02:18 INFO - PROCESS | 11257 | 16:05:21 INFO - PROCESS | 11257 | Cycle 1(1): loaded http://localhost:36223/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36223/tests/dromaeo/cssquery-yui.html) 16:05:21 INFO - PROCESS | 11257 | RSS: Main: 154304512 16:05:21 INFO - PROCESS | 11257 | 16:08:24 INFO - PROCESS | 11257 | Cycle 1(1): loaded http://localhost:36223/tests/dromaeo/cssquery-yui.html (next: http://localhost:36223/tests/dromaeo/cssquery-dojo.html) 16:08:24 INFO - PROCESS | 11257 | RSS: Main: 154804224 16:08:24 INFO - PROCESS | 11257 | 16:08:24 INFO - PROCESS | 11257 | __start_tp_report 16:08:24 INFO - PROCESS | 11257 | _x_x_mozilla_page_load 16:08:24 INFO - PROCESS | 11257 | _x_x_mozilla_page_load_details 16:08:24 INFO - PROCESS | 11257 | |i|pagename|runs| 16:08:24 INFO - PROCESS | 11257 | |0;dojo.html;3219.243477782721;3256.397566450207;3264.4776835706284;3273.9508907366408;3278.327942771732;5525.226468294442;5546.1680747887785;5587.497125258726;5596.86007849804;5597.356304025033;5552.11166213406;5602.187682785993;5606.859828504289;5624;5663.3204015518195;5080.263361812535;5113.539781419671;5155.664881782691;5176.559992400632;5201.713905735183;5121.155009423441;5160.819371322004;5161.4322424533275;5177.249298851664;5186.688798672092;5056.4437911829855;5060.089183946888;5141.383034035921;5160;5185.818496352628;5059.974700126476;5077.669951453162;5100.897982040338;5152.510511501401;5190.71451070191;5026.673266237683;5128.948565544055;5130.4356520782685;5135.537801597837;5140.1518749406305;5401.081816091274;5558.583106267006;5577.637453565505;5638.85902852432;5647.43525647436;5810.273715785527;5849.7660093596205;5889.970550147222;5911.438413350725;5995.490383317423;5946.048632218824;5949.25634295713;5957.6127551709;6030.487408570277;6056.182415373956;5628.352739434977;5637.689927054052;5642.520385767174;5643.971780141073;5650.039493286151;6046.788362407295;6058.4244496772735;6101.755929762849;6153.353897840751;6154.846128846725;5838.211841401441;5896.380880007538;5903.055511118287;5924.437178468039;5940.079287710412;5969.671668058211;6012.579119461596;6013.579049466495;6015.248093988252;6023.247094113236;5751.568632352591;5829.621074630136;5852.122181672698;5854.8536286592325;5861;5898.970505147447;5917.260342457193;5920.644761314335;5940.46535811779;5944.702764861826;4643.4660014098135;4672.74299913508;4688.507706690816;4696.577308042292;4724.126036683225;4072.165206132736;4084.571120032354;4094.877153685394;4106.568810274878;4173.874783756492;5709.7716091356715;5712.285964254468;5773.1051686988585;5800.477956983807;5827.708614569255;5915.08316210988;6008;6019.608725432833;6034.426729460694;6043.818685439356;5652.3217213934595;5664.915026274609;5718.771249150071;5726.856828579319;5766.596338256281;5235.319408476874;5273.288106105703;5276.604254680914;5296;5308.92036619451;6283.3088360280335;6305.085762564494;6312.621242725451;6320;6339.049142628551;5862.355140934579;5906.881862362643;6040.546958978182;6044.697765111639;6058.818235452944;6138.357744607813;6164.229471316085;6196.535259855439;6242.188515493139;6248.281447633581;5864.589478736448;5869.970650146722;5871.001929671881;5876.265466816648;5894.557908156991;5780.710964451677;5918.881622367615;5993.61041532299;6005.219321488178;6014.8195554133445;5681.034224181816;5744.5978781486565;5762.250907382181;5769.913451298318;5840.94159058421;5786.884262314646;5797.101449275369;5810.070388737781;5820.388859169726;5822.272215973004;5753.539716822728;5778.682172480554;5789.507891829242;5792.160136780228;5809.680467574155;5688.260526131577;5728.513076388387;5832;5847.590668653153;5857.970710146422;5717.514011308919;5728.914066289092;5753.683547404933;5772.2207501986695;5784.942150578609 16:08:24 INFO - PROCESS | 11257 | |1;ext.html;563.2340017576096;620.8416853702306;638.205434234378;646.8867948109081;652.4160876015962;43633.78183109084;44527.77736111319;44697.553024469744;47901.52098479014;48023;47597;48041.75979120108;48178.51821481784;48189.51810481894;48257;8668.696595619154;8747.825043499126;8778.736637900873;8786.341024423162;8799.692010779623;8767.947846258458;8791.736247912573;8815.074417186199;8831.205191532761;8852.822943541125;8866.157715017063;8881.24509416697;8935.329850261223;8939;8973.596188171516;8716;8754.168354006359;8776.16626420489;8813.955930220372;8822.250108740733;8749.256313213384;8763.430377025537;8815.471071735716;8828.690995815115;8836.983746869128;43799.78100109511;44110.55889441097;44160.11679766419;44240.3363949541;44369.778151109036;3316.303576248991;3442.5008373785663;3470.0977745786026;3486.511888335635;3486.7210623150086;32537.17264490505;32771;33163;33284.16789580256;34063.659363406296;4427.889302767424;4439.711418757771;4517.638588912912;4531.048479819242;4570.360149579062;365986;369250;370141;370617;371484.9999999973;62785;63115.36884631187;63158.36841631525;63211;63433.36566634275;65891.34108658852;66264.33735662678;66416.66791666107;66586.66706666436;66752;18449.815501845078;18655.533611659546;18688.159032843556;18690.71963920542;18911.81088189128;13905.16569005863;13978.580642580739;13983.930080349737;13990.86009139916;13992.650183745487;17662.17175978232;18817.435476935712;18817.717734233996;18885.15016824246;19001;6223.595466294767;6237.787539417203;6280.497560195174;6429.485641148697;6480.837979050467;917.788908551037;1015.1219195395929;1025.3027941000043;1031.783325501638;1046.1735229168871;32775.34449311048;33051.3389732204;33269;33411.04349605853;33540.832295838365;1111.9610813621646;1130.37829193943;1147.3689470791032;1179.2488155089684;1194.2655267010725;16882.66234675324;17282.740758888627;17340.393086241922;17386.565335866704;17431.954082755074;534047;534048;535376;536492;536742;63125;63225;63347.6832615834;63619;63885;1290.4902563487558;1344.932753362328;1345.4819894340749;1356.138851829076;1378.6139880833382;30994;32408.675913240564;32678.183045424055;32827.50758738669;33836.154096147795;56012.159817603584;56663.43336566581;56943.430565693816;56962.715186423804;56983.43016569947;477744;481899;483554;484726;485846;31095.533566996062;31131.533027005065;31541.842290788398;31670.841645791625;31705.682943171196;49616.255756164406;50155.24767128569;51033.74483127561;51070.74464627653;52084.73957630188;42320.1535969285;42480.1503969925;42583.36124958066;43421;44559.55440445554;40889.59110408858;40983.385249220686;41732.58267417287;42378.36432453454;43332.78333608312;42345.364819527116;42834;43799.34300985552;43843;45964.54035459603;35353.64646353606;37727.245455091295;38141.618583813804;38434.6156538431;38995.22009559736;29454;29579;29695;29942.700572993992;30112.644930978597 16:08:24 INFO - PROCESS | 11257 | |2;jquery.html;419.5552714123028;430.3544682975537;433.48632850810077;436.9300911854103;444.4599811229356;18178.636427271445;18700;19750.506237344038;19869.900650496744;19907.502312442197;19208.327708530203;19354.419367419;19656.213751449926;19778.60442791147;19782;5650.208970744089;5938.346781853993;5940.04959206527;5946.345901950782;5946.910796338037;5689.687067211302;5806.970965145189;5835.241418615574;5927.2590926134235;5938.287405511344;5842.503387212092;5849.532037436995;5849.8830023399505;5850.297964244297;5861.6189947653265;5664.0371136906615;5811.215485909433;5829.9708501457435;5831;5864.824055278348;5319.494648008472;5320.680759154463;5322.04203243416;5322.760475778599;5333.839984800462;22372.888135559217;22935.655965160535;23310;23342.883285583634;23370.76629233703;2450.509898020385;2459.1761759810483;2608.4522250327454;2924.1519959211805;3078.6921307869256;10281.228907831868;10390.896091039069;10719.678409647722;10829.512671929704;10965.177611679077;1714.9571260718458;1806.9457916262402;1807.150639199574;1859.6559636467161;1871.5414723392719;86440;87151;87812;87991;88575.55712221397;11470.197086203885;11703;11730.472128754227;11825.172237943261;11834.230774999769;16915.40796072156;16918.91540542314;16944.322227110777;16976.151192440328;17023.40418085361;8731.65073397057;8801.91198088011;8905.73282801517;8947.284217262604;9031.548422578844;8365.665373385118;8554.828903421896;8582.270507006975;8690;8693.826123477495;5081.0854046272025;5103.974480127576;5111.05445492585;5133.589312854962;5181.761399125547;1951.9316823911095;2055.85609007371;2094.2670065477264;2113.661814109735;2175.1516908405733;948.3551185194134;966.8694726212012;999.1207737191226;1022.3303736052898;1071.49104175516;19430.70853937192;19511.707324389863;19550.608987820164;19666.115024823917;19835.611507194357;983;987.9407235565889;1001.7946321004176;1008.253892119826;1068.989310106889;10353.223508236912;10951.780964380669;10959.12327013837;10967.945160274307;10990.120790336754;476110;480003;489988;518287;519764;91297;91485.54257228671;94195;94668.0533194673;96272.51863740636;1021.7496713305288;1028.3161697471248;1091.0780390569955;1106.9667909962714;1107.2802678259036;17062.48812535626;17414.854493124156;17421.95468271908;17490.300387984338;17571.560710981816;42399.788001059795;44047.11905761931;44996.32505512486;46373.53626463827;46530;59572;60073.699631501564;60667.69666151641;61449.69275153775;61609;8591.527465989431;8771.692990745294;8907.643694252416;8980.101989800967;9280;12900.612981610566;13057.21656700601;13361.465541378237;13372.598822035354;13539.11995720275;11201.215914886207;11421.600243991421;11489.597864074718;11592.362420066976;11598.94200528992;11058.502367393326;11198.664040078811;11217.158713096387;11562.595309164139;11670.416479175838;11414.543418263176;11424;11668.88331116678;11702.70743231426;12116.697082573006;7794.610269486389;8446.746597602081;8462.788430289045;8679.60941757635;9052.864207037032;9204.585793639168;11392.462017627515;11446.885531144582;11526.711832204262;11621.593244236412 16:08:24 INFO - PROCESS | 11257 | |3;mootools.html;1513.5988962924828;1543.5678010157155;1701.8978861268324;1790.0960015192318;1795.2908601102556;8032.196780321965;8270.255676989069;8504.149585041501;8979.820403591932;9007.504587247708;8362.581870906446;8680.652773889053;8763.474191548496;8765.342599305062;8773.649054037847;2395.461021270209;2419.1049311754678;2453.828232023759;2464.2853572463964;2468.2101727447225;2433.892578876616;2482.1808803095028;2498.8625625590585;2503.0738626708144;2510.585753350695;2408.458096928186;2417.0452671194867;2424.9272521824373;2433.124075332879;2438.0247900839627;2296.311106667993;2350.224425939436;2353.235198560466;2375.2517956843712;2376.192094687806;2370.7629237076326;2392.031227352925;2392.9760702392928;2418.504206637635;2421.806255499556;8865.556722163867;8912.777180570472;8928.10718928102;8967.641294348217;8970.641174353019;5397.379301380352;5499.285092937933;5510.476504732044;5535.640183388067;5553.583481238883;3335.5997280326515;3393.355262500117;3403.5745531808525;3405.8467368968454;3492.755507114503;1077.983830242547;1098.0831006109909;1103.382106020623;1145.2956431794387;1167.97080072998;12111.152219344649;12260.0191984641;12290.877091229062;12333;12450.875491245062;4504.121696269196;4693.366395536627;4812.917093653899;4821.951780482221;4848.200046992207;10192.13366863825;10234.33476824004;10357.274990750575;10364.948175259226;10365.896341036492;5481.671099734029;5483.4516548344845;5483.533899618577;5483.917741233885;5498.532624726863;4535.160995215896;4560.566746159176;4861.732604706775;4901.166801643729;5019.397672279277;4016.5983401660183;4043.2722110020477;4115.176964607091;4127.236461254677;4132.896677583084;1306.203216038216;1363.277462944641;1363.4682473835212;1365.9658508537168;1373.4231622718482;938.9154976052188;959.1176117971482;972.5283237629744;982.4350998176077;1005.8843233028149;5859.794907178229;5871.031279838779;5916.7337469813965;5929.614575052694;6055.576109672281;504.76023888652594;507.16064912569755;508.37216038192804;508.8498892826625;518.5255491225562;3965.088029753173;3977.9801100994887;3982.183652351261;3993.9201215975518;4011.4183443400543;10465.529051192563;10877.564897404174;10923.617673381552;10983.340999540053;10984.945075274733;10816.56733730642;10816.72958176036;10849.620263290746;10861.40262285582;10867.619633312795;8116.75649730509;8222.917770822334;8238.670453181925;8317.41778075529;8352.415330926899;5707;5769.567282453749;5801.709914504342;5844.298684157929;5868.119782032559;9094.909050909406;9807.509624518603;9848.359856609297;9891.455969921722;10013.799724005334;9656.179224765692;9685.32202745801;9703.223742100756;9735.756606084904;9764.85352719724;7078.858422831618;7124.85750284981;7612.733554325572;7766.106897706836;7895.1315355309725;8470;8594.699185528476;8597.441166324168;8624.09447008055;8631.136886311318;7449.44129190302;7455.552666840007;7531.58576278288;7544.924550754422;7694.07671079474;7588.734394296173;7635.503692259986;7685.807854803675;7714.421418393756;7815.8436831261915;7067.57594544329;7073.469489788184;7186.10173728284;7191.460640451883;7198.676059577227;5027.974860125676;5034.697918124924;5070.670406423571;5073.543381095719;5189.948100518946;5104.642675012862;5174.870628234325;5177.068127737043;5184.222366645034;5376.542993845567 16:08:24 INFO - PROCESS | 11257 | |4;prototype.html;328.40066877947737;341.7258147031503;347.4198089191052;359.60802725029714;359.6475454055026;5473.616846820724;5560.6941618211085;5638.859028524289;5693.829185124448;5702.885942281152;5426;5523.475269849368;5546.613346663335;5556.583256255787;5557.38868724441;4438.312061630452;4440.245158323085;4456.621187199092;4463.375127482155;4478.373027776114;4155.252054630166;4320.308750599905;4340.370646256291;4425.269830477967;4460;4291.699581029329;4310.245707001278;4329.437173167499;4332;4338.284183109783;4307.8492252771;4314.813426307759;4322.200392927319;4324.329728892011;4326.199653064177;3731.533558305212;3759.4360845873066;3819.618038196186;3840.750351227189;3851.5185601799776;5353.491418315254;5363.329583802025;5363.597730170253;5376.758045887945;5412.648177868426;4900.289458028566;4919.950800491985;4923.08922849274;4937.358143441365;4969.726665033421;5485.61600687952;5786.47921687046;5814.273215848019;5826.912596311059;5861.443162899561;4213.726107802983;4256.851010214627;4266.296061149907;4268.573142685737;4279.97860010698;6034.24571928509;6048.516118710492;6052.394760523956;6062.424069713415;6078.96960515199;4258.659307255412;4297.419848320499;4341.761203133858;4341.8480353188115;4356.934645980313;4371.060222052274;4390.670699697535;4410.735355878657;4412.161689279027;4435.911281774346;4927.339236812153;4979.207485305287;4995.175795993693;5002.174641184237;5022.949770502249;5641.12562552805;5710.972604725346;5827.912581311284;5832.329282132524;5867.826434713074;1463.9707205855823;1479.186447453896;1481.6444053427315;1488.8138982627172;1498.4380857178558;1016.2124353625851;1031.6073301043682;1039.9116075133547;1040.564021650133;1055.7911191685478;5532.7786888524815;5554.333479982347;5556.0831513127905;5563.972180139073;5572.857564199329;5773.24947756789;5776.584736739525;5811.343767026462;5821.27234095738;5825.563082768809;5420;5423.186522021729;5467.617266791366;5499.700179892113;5540.168974653834;3082.737967272807;3086.382723455318;3088.4132014917545;3096.3188098618266;3106.48742957414;6031.24609423822;6062.333143354227;6067.484263837623;6068.666223357758;6108.908366374508;6122.326544080148;6152.415520525543;6190.907136392958;6212.875742485125;6213.347598502182;6353.8729225416155;6363.172787537591;6371.490280777527;6375.3624637536805;6386.2336519618875;5915.385998920849;6030.6080104793045;6057.4851137653795;6071.787487437919;6088.178095956989;5967.6419414835245;6005.489533389711;6008.87982240344;6008.969955150196;6018.247719035121;6121;6279.403456671609;6288.842778930563;6410.166678331787;6437.291897891322;4336.739795612273;4345.652347812231;4364.956350436582;4366.781660917005;4393.956060439355;5895.498882595028;6027.879442411215;6082.695865206633;6125.774845030923;6135.785247516315;5793.420657934173;5869.325027621878;5890.9116363253725;5893.823185304448;5938.584299099021;5888.381719919518;5910.468057874812;5913.58604897653;5922.615030023035;5995.730192141277;5730;5820.854478638068;5853.882922341614;5867.005218225824;5882.382349853204;5913.319968203712;5915.438033386821;5923.763049477972;5943.762249509971;5947.6431414115295;5670.8374783170175;5760.913586296293;5793.884122317614;5808.722081142142;5841.415858414124 16:08:24 INFO - PROCESS | 11257 | |5;yui.html;647.3655817299046;676.6041865508677;734.2657342657342;736.5470235804978;783.6630248992931;14119.152850828945;14872.256387180652;14889.702205955888;14978.176200308992;15644.452444164457;14495.565133045999;14636.048656837298;14689.485867994596;14711.632209194775;14712.190829504372;832.9541875196892;833.0669649992018;833.7207035643066;834.3033566971586;841;843.6709683223547;859.1751918158575;859.5530324231396;865.8008658008662;874.9518776467291;910.7085732565581;913.9314551408638;916.6745805239144;917.0279503726039;918;909.495230147268;911.0434044253508;912.0788004115824;913.3606475467167;913.9817203655923;666.0209492046683;668.7091115364832;668.9598624082571;668.9698963546653;669.3641041011059;15115.546533604009;15327.846721532753;15390.384384624602;15453.995490293095;15537.844621553753;13161.73676526464;13639.454421823115;13727;13923;14114.153150810984;10804.1896857736;10892.455377231106;10929.781404371868;10956;11118.277311974696;3800.1639639279315;3802.4676545283683;3803.9809800951093;3846.0769415340396;3865.632764887331;64313.999999999534;65291.347086529;65665;66543.3345666542;66591;10795.244332896778;11290.604828831116;11349.489272982735;11629.418529073513;11705.941470292764;19909.402717918485;20064.297749578694;20109.698354524695;20203.48473864466;20385.694214586794;7897.131315555284;7906.841863162705;7967.601619919097;7988.800279993046;8191.426600138052;4455.68810183284;4501.504834468205;4504.684672072989;4549.590536851633;4578.931316030262;3292.967070329266;3415.7096646785303;3442.4664177052596;3442.913927151841;3448.0690213642174;613.7054213977316;621.8321053315669;627.8147946355745;632.250782822357;649.6426965169138;614.3242433323397;615.9168512250878;665.820228538292;675.8141511084393;698.3296035805683;9156.450612963243;9994;10012.14775266578;10240.743981400525;10487.737806554744;661.5071771530145;742.736328603338;752.7403045949138;772.3820943245381;816.0859836982618;4632.62938964882;4900.754962251873;4951.777170027357;4968.205087186033;5030.471800460972;77392;81185;82598.58700706458;84896;85034;71346;72640.27359726335;74240.17827830024;76431.61784191155;76857.23142768501;66180.33819661742;66667.99129717708;67558;67777.3222267771;68438.65780671065;9291.396059256127;9349.25205983506;9427.952860235655;9537;9539;44068.55931440773;44510.554894450644;45047.56269175435;45621.08757824892;46382.53617463782;61626;62089.68955155195;62152;63373.36626633859;65626.67186664227;11883.881161188277;11953.342566158944;12527;12707.428165732379;12823.807642885178;13591;14077.507287244896;14236.430542778588;14342.139471631319;15326.923365383102;13835.308234588028;13900.582982510541;13957.441702331793;14321.713565728418;14954.327055282321;14195.432182712575;14436.133831970115;14457.855421446071;14607.780883286547;14663.926680366956;12859.16415432994;12884.677883052998;13115.540956066492;13291.20252784836;13356.599302020955;10614.575416983544;10889.401082940198;11228.326300422;11495.195336326376;11682.357470339213;10915.890841091805;11846.348450835287;11943.402829858645;12100.697482563006;12118.272903625459 16:08:24 INFO - PROCESS | 11257 | __end_tp_report 16:08:24 INFO - PROCESS | 11257 | __start_cc_report 16:08:24 INFO - PROCESS | 11257 | _x_x_mozilla_cycle_collect,316 16:08:24 INFO - PROCESS | 11257 | __end_cc_report 16:08:24 INFO - PROCESS | 11257 | __startTimestamp1480723704327__endTimestamp 16:08:24 INFO - PROCESS | 11257 | 16:08:24 INFO - PROCESS | 11257 | ------- Summary: start ------- 16:08:24 INFO - PROCESS | 11257 | Number of tests: 6 16:08:24 INFO - PROCESS | 11257 | 16:08:24 INFO - PROCESS | 11257 | [#0] dojo.html Cycles:165 Average:5566.46 Median:5769.91 stddev:611.29 (10.6%) stddev-sans-first:584.78 16:08:24 INFO - PROCESS | 11257 | Values: 3219.2 3256.4 3264.5 3274.0 3278.3 5525.2 5546.2 5587.5 5596.9 5597.4 5552.1 5602.2 5606.9 5624.0 5663.3 5080.3 5113.5 5155.7 5176.6 5201.7 5121.2 5160.8 5161.4 5177.2 5186.7 5056.4 5060.1 5141.4 5160.0 5185.8 5060.0 5077.7 5100.9 5152.5 5190.7 5026.7 5128.9 5130.4 5135.5 5140.2 5401.1 5558.6 5577.6 5638.9 5647.4 5810.3 5849.8 5890.0 5911.4 5995.5 5946.0 5949.3 5957.6 6030.5 6056.2 5628.4 5637.7 5642.5 5644.0 5650.0 6046.8 6058.4 6101.8 6153.4 6154.8 5838.2 5896.4 5903.1 5924.4 5940.1 5969.7 6012.6 6013.6 6015.2 6023.2 5751.6 5829.6 5852.1 5854.9 5861.0 5899.0 5917.3 5920.6 5940.5 5944.7 4643.5 4672.7 4688.5 4696.6 4724.1 4072.2 4084.6 4094.9 4106.6 4173.9 5709.8 5712.3 5773.1 5800.5 5827.7 5915.1 6008.0 6019.6 6034.4 6043.8 5652.3 5664.9 5718.8 5726.9 5766.6 5235.3 5273.3 5276.6 5296.0 5308.9 6283.3 6305.1 6312.6 6320.0 6339.0 5862.4 5906.9 6040.5 6044.7 6058.8 6138.4 6164.2 6196.5 6242.2 6248.3 5864.6 5870.0 5871.0 5876.3 5894.6 5780.7 5918.9 5993.6 6005.2 6014.8 5681.0 5744.6 5762.3 5769.9 5840.9 5786.9 5797.1 5810.1 5820.4 5822.3 5753.5 5778.7 5789.5 5792.2 5809.7 5688.3 5728.5 5832.0 5847.6 5858.0 5717.5 5728.9 5753.7 5772.2 5784.9 16:08:24 INFO - PROCESS | 11257 | 16:08:24 INFO - PROCESS | 11257 | [#1] ext.html Cycles:180 Average:63431.81 Median:44200.23 stddev:123907.92 (280.3%) stddev-sans-first:124165.61 16:08:24 INFO - PROCESS | 11257 | Values: 563.2 620.8 638.2 646.9 652.4 43633.8 44527.8 44697.6 47901.5 48023.0 47597.0 48041.8 48178.5 48189.5 48257.0 8668.7 8747.8 8778.7 8786.3 8799.7 8767.9 8791.7 8815.1 8831.2 8852.8 8866.2 8881.2 8935.3 8939.0 8973.6 8716.0 8754.2 8776.2 8814.0 8822.3 8749.3 8763.4 8815.5 8828.7 8837.0 43799.8 44110.6 44160.1 44240.3 44369.8 3316.3 3442.5 3470.1 3486.5 3486.7 32537.2 32771.0 33163.0 33284.2 34063.7 4427.9 4439.7 4517.6 4531.0 4570.4 365986.0 369250.0 370141.0 370617.0 371485.0 62785.0 63115.4 63158.4 63211.0 63433.4 65891.3 66264.3 66416.7 66586.7 66752.0 18449.8 18655.5 18688.2 18690.7 18911.8 13905.2 13978.6 13983.9 13990.9 13992.7 17662.2 18817.4 18817.7 18885.2 19001.0 6223.6 6237.8 6280.5 6429.5 6480.8 917.8 1015.1 1025.3 1031.8 1046.2 32775.3 33051.3 33269.0 33411.0 33540.8 1112.0 1130.4 1147.4 1179.2 1194.3 16882.7 17282.7 17340.4 17386.6 17432.0 534047.0 534048.0 535376.0 536492.0 536742.0 63125.0 63225.0 63347.7 63619.0 63885.0 1290.5 1344.9 1345.5 1356.1 1378.6 30994.0 32408.7 32678.2 32827.5 33836.2 56012.2 56663.4 56943.4 56962.7 56983.4 477744.0 481899.0 483554.0 484726.0 485846.0 31095.5 31131.5 31541.8 31670.8 31705.7 49616.3 50155.2 51033.7 51070.7 52084.7 42320.2 42480.2 42583.4 43421.0 44559.6 40889.6 40983.4 41732.6 42378.4 43332.8 42345.4 42834.0 43799.3 43843.0 45964.5 35353.6 37727.2 38141.6 38434.6 38995.2 29454.0 29579.0 29695.0 29942.7 30112.6 16:08:24 INFO - PROCESS | 11257 | 16:08:24 INFO - PROCESS | 11257 | [#2] jquery.html Cycles:180 Average:29725.95 Median:2533.81 stddev:82107.12 (3240.5%) stddev-sans-first:82307.96 16:08:24 INFO - PROCESS | 11257 | Values: 419.6 430.4 433.5 436.9 444.5 18178.6 18700.0 19750.5 19869.9 19907.5 19208.3 19354.4 19656.2 19778.6 19782.0 5650.2 5938.3 5940.0 5946.3 5946.9 5689.7 5807.0 5835.2 5927.3 5938.3 5842.5 5849.5 5849.9 5850.3 5861.6 5664.0 5811.2 5830.0 5831.0 5864.8 5319.5 5320.7 5322.0 5322.8 5333.8 22372.9 22935.7 23310.0 23342.9 23370.8 2450.5 2459.2 2608.5 2924.2 3078.7 10281.2 10390.9 10719.7 10829.5 10965.2 1715.0 1806.9 1807.2 1859.7 1871.5 86440.0 87151.0 87812.0 87991.0 88575.6 11470.2 11703.0 11730.5 11825.2 11834.2 16915.4 16918.9 16944.3 16976.2 17023.4 8731.7 8801.9 8905.7 8947.3 9031.5 8365.7 8554.8 8582.3 8690.0 8693.8 5081.1 5104.0 5111.1 5133.6 5181.8 1951.9 2055.9 2094.3 2113.7 2175.2 948.4 966.9 999.1 1022.3 1071.5 19430.7 19511.7 19550.6 19666.1 19835.6 983.0 987.9 1001.8 1008.3 1069.0 10353.2 10951.8 10959.1 10967.9 10990.1 476110.0 480003.0 489988.0 518287.0 519764.0 91297.0 91485.5 94195.0 94668.1 96272.5 1021.7 1028.3 1091.1 1107.0 1107.3 17062.5 17414.9 17422.0 17490.3 17571.6 42399.8 44047.1 44996.3 46373.5 46530.0 59572.0 60073.7 60667.7 61449.7 61609.0 8591.5 8771.7 8907.6 8980.1 9280.0 12900.6 13057.2 13361.5 13372.6 13539.1 11201.2 11421.6 11489.6 11592.4 11598.9 11058.5 11198.7 11217.2 11562.6 11670.4 11414.5 11424.0 11668.9 11702.7 12116.7 7794.6 8446.7 8462.8 8679.6 9052.9 9204.6 11392.5 11446.9 11526.7 11621.6 16:08:24 INFO - PROCESS | 11257 | 16:08:24 INFO - PROCESS | 11257 | [#3] mootools.html Cycles:180 Average:5785.58 Median:2788.92 stddev:3247.78 (116.5%) stddev-sans-first:3241.03 16:08:24 INFO - PROCESS | 11257 | Values: 1513.6 1543.6 1701.9 1790.1 1795.3 8032.2 8270.3 8504.1 8979.8 9007.5 8362.6 8680.7 8763.5 8765.3 8773.6 2395.5 2419.1 2453.8 2464.3 2468.2 2433.9 2482.2 2498.9 2503.1 2510.6 2408.5 2417.0 2424.9 2433.1 2438.0 2296.3 2350.2 2353.2 2375.3 2376.2 2370.8 2392.0 2393.0 2418.5 2421.8 8865.6 8912.8 8928.1 8967.6 8970.6 5397.4 5499.3 5510.5 5535.6 5553.6 3335.6 3393.4 3403.6 3405.8 3492.8 1078.0 1098.1 1103.4 1145.3 1168.0 12111.2 12260.0 12290.9 12333.0 12450.9 4504.1 4693.4 4812.9 4822.0 4848.2 10192.1 10234.3 10357.3 10364.9 10365.9 5481.7 5483.5 5483.5 5483.9 5498.5 4535.2 4560.6 4861.7 4901.2 5019.4 4016.6 4043.3 4115.2 4127.2 4132.9 1306.2 1363.3 1363.5 1366.0 1373.4 938.9 959.1 972.5 982.4 1005.9 5859.8 5871.0 5916.7 5929.6 6055.6 504.8 507.2 508.4 508.8 518.5 3965.1 3978.0 3982.2 3993.9 4011.4 10465.5 10877.6 10923.6 10983.3 10984.9 10816.6 10816.7 10849.6 10861.4 10867.6 8116.8 8222.9 8238.7 8317.4 8352.4 5707.0 5769.6 5801.7 5844.3 5868.1 9094.9 9807.5 9848.4 9891.5 10013.8 9656.2 9685.3 9703.2 9735.8 9764.9 7078.9 7124.9 7612.7 7766.1 7895.1 8470.0 8594.7 8597.4 8624.1 8631.1 7449.4 7455.6 7531.6 7544.9 7694.1 7588.7 7635.5 7685.8 7714.4 7815.8 7067.6 7073.5 7186.1 7191.5 7198.7 5028.0 5034.7 5070.7 5073.5 5189.9 5104.6 5174.9 5177.1 5184.2 5376.5 16:08:24 INFO - PROCESS | 11257 | 16:08:24 INFO - PROCESS | 11257 | [#4] prototype.html Cycles:180 Average:4936.82 Median:5550.47 stddev:1452.42 (26.2%) stddev-sans-first:1414.71 16:08:24 INFO - PROCESS | 11257 | Values: 328.4 341.7 347.4 359.6 359.6 5473.6 5560.7 5638.9 5693.8 5702.9 5426.0 5523.5 5546.6 5556.6 5557.4 4438.3 4440.2 4456.6 4463.4 4478.4 4155.3 4320.3 4340.4 4425.3 4460.0 4291.7 4310.2 4329.4 4332.0 4338.3 4307.8 4314.8 4322.2 4324.3 4326.2 3731.5 3759.4 3819.6 3840.8 3851.5 5353.5 5363.3 5363.6 5376.8 5412.6 4900.3 4920.0 4923.1 4937.4 4969.7 5485.6 5786.5 5814.3 5826.9 5861.4 4213.7 4256.9 4266.3 4268.6 4280.0 6034.2 6048.5 6052.4 6062.4 6079.0 4258.7 4297.4 4341.8 4341.8 4356.9 4371.1 4390.7 4410.7 4412.2 4435.9 4927.3 4979.2 4995.2 5002.2 5022.9 5641.1 5711.0 5827.9 5832.3 5867.8 1464.0 1479.2 1481.6 1488.8 1498.4 1016.2 1031.6 1039.9 1040.6 1055.8 5532.8 5554.3 5556.1 5564.0 5572.9 5773.2 5776.6 5811.3 5821.3 5825.6 5420.0 5423.2 5467.6 5499.7 5540.2 3082.7 3086.4 3088.4 3096.3 3106.5 6031.2 6062.3 6067.5 6068.7 6108.9 6122.3 6152.4 6190.9 6212.9 6213.3 6353.9 6363.2 6371.5 6375.4 6386.2 5915.4 6030.6 6057.5 6071.8 6088.2 5967.6 6005.5 6008.9 6009.0 6018.2 6121.0 6279.4 6288.8 6410.2 6437.3 4336.7 4345.7 4365.0 4366.8 4394.0 5895.5 6027.9 6082.7 6125.8 6135.8 5793.4 5869.3 5890.9 5893.8 5938.6 5888.4 5910.5 5913.6 5922.6 5995.7 5730.0 5820.9 5853.9 5867.0 5882.4 5913.3 5915.4 5923.8 5943.8 5947.6 5670.8 5760.9 5793.9 5808.7 5841.4 16:08:24 INFO - PROCESS | 11257 | 16:08:24 INFO - PROCESS | 11257 | [#5] yui.html Cycles:180 Average:17808.27 Median:25100.01 stddev:22903.24 (91.2%) stddev-sans-first:22931.23 16:08:24 INFO - PROCESS | 11257 | Values: 647.4 676.6 734.3 736.5 783.7 14119.2 14872.3 14889.7 14978.2 15644.5 14495.6 14636.0 14689.5 14711.6 14712.2 833.0 833.1 833.7 834.3 841.0 843.7 859.2 859.6 865.8 875.0 910.7 913.9 916.7 917.0 918.0 909.5 911.0 912.1 913.4 914.0 666.0 668.7 669.0 669.0 669.4 15115.5 15327.8 15390.4 15454.0 15537.8 13161.7 13639.5 13727.0 13923.0 14114.2 10804.2 10892.5 10929.8 10956.0 11118.3 3800.2 3802.5 3804.0 3846.1 3865.6 64314.0 65291.3 65665.0 66543.3 66591.0 10795.2 11290.6 11349.5 11629.4 11705.9 19909.4 20064.3 20109.7 20203.5 20385.7 7897.1 7906.8 7967.6 7988.8 8191.4 4455.7 4501.5 4504.7 4549.6 4578.9 3293.0 3415.7 3442.5 3442.9 3448.1 613.7 621.8 627.8 632.3 649.6 614.3 615.9 665.8 675.8 698.3 9156.5 9994.0 10012.1 10240.7 10487.7 661.5 742.7 752.7 772.4 816.1 4632.6 4900.8 4951.8 4968.2 5030.5 77392.0 81185.0 82598.6 84896.0 85034.0 71346.0 72640.3 74240.2 76431.6 76857.2 66180.3 66668.0 67558.0 67777.3 68438.7 9291.4 9349.3 9428.0 9537.0 9539.0 44068.6 44510.6 45047.6 45621.1 46382.5 61626.0 62089.7 62152.0 63373.4 65626.7 11883.9 11953.3 12527.0 12707.4 12823.8 13591.0 14077.5 14236.4 14342.1 15326.9 13835.3 13900.6 13957.4 14321.7 14954.3 14195.4 14436.1 14457.9 14607.8 14663.9 12859.2 12884.7 13115.5 13291.2 13356.6 10614.6 10889.4 11228.3 11495.2 11682.4 10915.9 11846.3 11943.4 12100.7 12118.3 16:08:24 INFO - PROCESS | 11257 | -------- Summary: end -------- 16:08:24 INFO - PROCESS | 11257 | 16:08:25 INFO - TEST-INFO | 11257: exit 0 16:08:25 INFO - TEST-OK | dromaeo_css | took 1113391ms 16:08:25 INFO - TEST-START | kraken 16:08:25 INFO - operating with platform_type : linux_ 16:08:25 INFO - Initialising browser for kraken test... 16:08:25 INFO - TEST-INFO | started process 11630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUPghOJ/profile http://localhost:36223/getInfo.html) 16:08:29 INFO - PROCESS | 11630 | __metrics Screen width/height:1600/1200 16:08:29 INFO - PROCESS | 11630 | colorDepth:24 16:08:29 INFO - PROCESS | 11630 | Browser inner width/height: 1024/697 16:08:29 INFO - PROCESS | 11630 | __metrics 16:08:30 ERROR - PROCESS | 11630 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 16:08:31 INFO - TEST-INFO | 11630: exit 0 16:08:31 INFO - Browser initialized. 16:08:31 INFO - Running cycle 1/1 for kraken test... 16:08:31 INFO - TEST-INFO | started process 11760 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUPghOJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:43 INFO - PROCESS | 11760 | RSS: Main: 151937024 16:08:43 INFO - PROCESS | 11760 | 16:08:45 INFO - PROCESS | 11760 | Cycle 1(1): loaded http://localhost:36223/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36223/tests/kraken/driver.html?testName=audio-beat-detection) 16:08:46 INFO - PROCESS | 11760 | RSS: Main: 157155328 16:08:46 INFO - PROCESS | 11760 | 16:08:49 INFO - PROCESS | 11760 | Cycle 1(1): loaded http://localhost:36223/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36223/tests/kraken/driver.html?testName=audio-dft) 16:08:49 INFO - PROCESS | 11760 | RSS: Main: 155070464 16:08:49 INFO - PROCESS | 11760 | 16:08:52 INFO - PROCESS | 11760 | Cycle 1(1): loaded http://localhost:36223/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36223/tests/kraken/driver.html?testName=audio-fft) 16:08:53 INFO - PROCESS | 11760 | RSS: Main: 155402240 16:08:53 INFO - PROCESS | 11760 | 16:08:55 INFO - PROCESS | 11760 | Cycle 1(1): loaded http://localhost:36223/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36223/tests/kraken/driver.html?testName=audio-oscillator) 16:08:55 INFO - PROCESS | 11760 | RSS: Main: 155111424 16:08:55 INFO - PROCESS | 11760 | 16:08:58 INFO - PROCESS | 11760 | Cycle 1(1): loaded http://localhost:36223/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36223/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:08:58 INFO - PROCESS | 11760 | RSS: Main: 154988544 16:08:58 INFO - PROCESS | 11760 | 16:09:01 INFO - PROCESS | 11760 | Cycle 1(1): loaded http://localhost:36223/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36223/tests/kraken/driver.html?testName=imaging-darkroom) 16:09:02 INFO - PROCESS | 11760 | RSS: Main: 157904896 16:09:02 INFO - PROCESS | 11760 | 16:09:05 INFO - PROCESS | 11760 | Cycle 1(1): loaded http://localhost:36223/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36223/tests/kraken/driver.html?testName=imaging-desaturate) 16:09:06 INFO - PROCESS | 11760 | RSS: Main: 158265344 16:09:06 INFO - PROCESS | 11760 | 16:09:08 INFO - PROCESS | 11760 | Cycle 1(1): loaded http://localhost:36223/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36223/tests/kraken/driver.html?testName=json-parse-financial) 16:09:09 INFO - PROCESS | 11760 | RSS: Main: 157470720 16:09:09 INFO - PROCESS | 11760 | 16:09:11 INFO - PROCESS | 11760 | Cycle 1(1): loaded http://localhost:36223/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36223/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:09:11 INFO - PROCESS | 11760 | RSS: Main: 156798976 16:09:11 INFO - PROCESS | 11760 | 16:09:13 INFO - PROCESS | 11760 | Cycle 1(1): loaded http://localhost:36223/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36223/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:09:14 INFO - PROCESS | 11760 | RSS: Main: 156688384 16:09:14 INFO - PROCESS | 11760 | 16:09:16 INFO - PROCESS | 11760 | Cycle 1(1): loaded http://localhost:36223/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36223/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:09:16 INFO - PROCESS | 11760 | RSS: Main: 157151232 16:09:16 INFO - PROCESS | 11760 | 16:09:19 INFO - PROCESS | 11760 | Cycle 1(1): loaded http://localhost:36223/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:09:20 INFO - PROCESS | 11760 | RSS: Main: 157241344 16:09:20 INFO - PROCESS | 11760 | 16:09:22 INFO - PROCESS | 11760 | Cycle 1(1): loaded http://localhost:36223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:09:23 INFO - PROCESS | 11760 | RSS: Main: 157757440 16:09:23 INFO - PROCESS | 11760 | 16:09:25 INFO - PROCESS | 11760 | Cycle 1(1): loaded http://localhost:36223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36223/tests/kraken/driver.html?testName=ai-astar) 16:09:25 INFO - PROCESS | 11760 | RSS: Main: 159162368 16:09:25 INFO - PROCESS | 11760 | 16:09:25 INFO - PROCESS | 11760 | __start_tp_report 16:09:25 INFO - PROCESS | 11760 | _x_x_mozilla_page_load 16:09:25 INFO - PROCESS | 11760 | _x_x_mozilla_page_load_details 16:09:25 INFO - PROCESS | 11760 | |i|pagename|runs| 16:09:25 INFO - PROCESS | 11760 | |0;ai-astar;102;113;113;112;112;113;112;115;112;112 16:09:25 INFO - PROCESS | 11760 | |1;audio-beat-detection;146;124;126;159;123;122;123;122;151;130 16:09:25 INFO - PROCESS | 11760 | |2;audio-dft;161;163;164;163;161;161;162;162;164;161 16:09:25 INFO - PROCESS | 11760 | |3;audio-fft;76;75;78;103;75;76;76;78;105;77 16:09:25 INFO - PROCESS | 11760 | |4;audio-oscillator;83;82;119;84;83;83;103;82;82;113 16:09:25 INFO - PROCESS | 11760 | |5;imaging-gaussian-blur;117;118;117;119;117;117;118;118;117;118 16:09:25 INFO - PROCESS | 11760 | |6;imaging-darkroom;148;147;149;148;150;147;147;148;149;149 16:09:25 INFO - PROCESS | 11760 | |7;imaging-desaturate;85;86;85;85;87;86;85;85;85;87 16:09:25 INFO - PROCESS | 11760 | |8;json-parse-financial;55;54;53;53;52;52;55;52;55;59 16:09:25 INFO - PROCESS | 11760 | |9;json-stringify-tinderbox;58;59;59;59;63;59;59;58;60;59 16:09:25 INFO - PROCESS | 11760 | |10;stanford-crypto-aes;76;75;76;82;76;75;75;81;75;75 16:09:25 INFO - PROCESS | 11760 | |11;stanford-crypto-ccm;128;140;141;140;134;140;127;137;177;127 16:09:25 INFO - PROCESS | 11760 | |12;stanford-crypto-pbkdf2;168;163;160;164;161;158;172;161;161;160 16:09:25 INFO - PROCESS | 11760 | |13;stanford-crypto-sha256-iterative;66;67;66;65;64;64;67;64;63;70 16:09:25 INFO - PROCESS | 11760 | __end_tp_report 16:09:25 INFO - PROCESS | 11760 | __start_cc_report 16:09:25 INFO - PROCESS | 11760 | _x_x_mozilla_cycle_collect,817 16:09:25 INFO - PROCESS | 11760 | __end_cc_report 16:09:25 INFO - PROCESS | 11760 | __startTimestamp1480723765493__endTimestamp 16:09:25 INFO - PROCESS | 11760 | 16:09:25 INFO - PROCESS | 11760 | ------- Summary: start ------- 16:09:25 INFO - PROCESS | 11760 | Number of tests: 14 16:09:25 INFO - PROCESS | 11760 | 16:09:25 INFO - PROCESS | 11760 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:3.50 (3.1%) stddev-sans-first:1.00 16:09:25 INFO - PROCESS | 11760 | Values: 102.0 113.0 113.0 112.0 112.0 113.0 112.0 115.0 112.0 112.0 16:09:25 INFO - PROCESS | 11760 | 16:09:25 INFO - PROCESS | 11760 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:128.00 stddev:13.94 (10.9%) stddev-sans-first:13.91 16:09:25 INFO - PROCESS | 11760 | Values: 146.0 124.0 126.0 159.0 123.0 122.0 123.0 122.0 151.0 130.0 16:09:25 INFO - PROCESS | 11760 | 16:09:25 INFO - PROCESS | 11760 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.23 (0.8%) stddev-sans-first:1.22 16:09:25 INFO - PROCESS | 11760 | Values: 161.0 163.0 164.0 163.0 161.0 161.0 162.0 162.0 164.0 161.0 16:09:25 INFO - PROCESS | 11760 | 16:09:25 INFO - PROCESS | 11760 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:11.70 (15.4%) stddev-sans-first:12.22 16:09:25 INFO - PROCESS | 11760 | Values: 76.0 75.0 78.0 103.0 75.0 76.0 76.0 78.0 105.0 77.0 16:09:25 INFO - PROCESS | 11760 | 16:09:25 INFO - PROCESS | 11760 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:82.50 stddev:14.51 (17.6%) stddev-sans-first:15.07 16:09:25 INFO - PROCESS | 11760 | Values: 83.0 82.0 119.0 84.0 83.0 83.0 103.0 82.0 82.0 113.0 16:09:25 INFO - PROCESS | 11760 | 16:09:25 INFO - PROCESS | 11760 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 16:09:25 INFO - PROCESS | 11760 | Values: 117.0 118.0 117.0 119.0 117.0 117.0 118.0 118.0 117.0 118.0 16:09:25 INFO - PROCESS | 11760 | 16:09:25 INFO - PROCESS | 11760 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:1.03 (0.7%) stddev-sans-first:1.09 16:09:25 INFO - PROCESS | 11760 | Values: 148.0 147.0 149.0 148.0 150.0 147.0 147.0 148.0 149.0 149.0 16:09:25 INFO - PROCESS | 11760 | 16:09:25 INFO - PROCESS | 11760 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:85.50 stddev:0.84 (1.0%) stddev-sans-first:0.87 16:09:25 INFO - PROCESS | 11760 | Values: 85.0 86.0 85.0 85.0 87.0 86.0 85.0 85.0 85.0 87.0 16:09:25 INFO - PROCESS | 11760 | 16:09:25 INFO - PROCESS | 11760 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.50 stddev:2.16 (4.0%) stddev-sans-first:2.26 16:09:25 INFO - PROCESS | 11760 | Values: 55.0 54.0 53.0 53.0 52.0 52.0 55.0 52.0 55.0 59.0 16:09:25 INFO - PROCESS | 11760 | 16:09:25 INFO - PROCESS | 11760 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:1.42 (2.4%) stddev-sans-first:1.42 16:09:25 INFO - PROCESS | 11760 | Values: 58.0 59.0 59.0 59.0 63.0 59.0 59.0 58.0 60.0 59.0 16:09:25 INFO - PROCESS | 11760 | 16:09:25 INFO - PROCESS | 11760 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.00 stddev:2.63 (3.5%) stddev-sans-first:2.78 16:09:25 INFO - PROCESS | 11760 | Values: 76.0 75.0 76.0 82.0 76.0 75.0 75.0 81.0 75.0 75.0 16:09:25 INFO - PROCESS | 11760 | 16:09:25 INFO - PROCESS | 11760 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:140.00 stddev:14.49 (10.3%) stddev-sans-first:14.80 16:09:25 INFO - PROCESS | 11760 | Values: 128.0 140.0 141.0 140.0 134.0 140.0 127.0 137.0 177.0 127.0 16:09:25 INFO - PROCESS | 11760 | 16:09:25 INFO - PROCESS | 11760 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:162.00 stddev:4.24 (2.6%) stddev-sans-first:4.06 16:09:25 INFO - PROCESS | 11760 | Values: 168.0 163.0 160.0 164.0 161.0 158.0 172.0 161.0 161.0 160.0 16:09:25 INFO - PROCESS | 11760 | 16:09:25 INFO - PROCESS | 11760 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:2.07 (3.1%) stddev-sans-first:2.19 16:09:25 INFO - PROCESS | 11760 | Values: 66.0 67.0 66.0 65.0 64.0 64.0 67.0 64.0 63.0 70.0 16:09:25 INFO - PROCESS | 11760 | -------- Summary: end -------- 16:09:25 INFO - PROCESS | 11760 | 16:09:26 INFO - TEST-INFO | 11760: exit 0 16:09:26 INFO - TEST-OK | kraken | took 61435ms 16:09:26 INFO - SUITE-END | took 1174s 16:09:26 INFO - Completed test suite (00:19:34) 16:09:26 INFO - javascript benchmark 16:09:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7395.812974166871, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3219.243477782721, 3256.397566450207, 3264.4776835706284, 3273.9508907366408, 3278.327942771732, 5525.226468294442, 5546.1680747887785, 5587.497125258726, 5596.86007849804, 5597.356304025033, 5552.11166213406, 5602.187682785993, 5606.859828504289, 5624.0, 5663.3204015518195, 5080.263361812535, 5113.539781419671, 5155.664881782691, 5176.559992400632, 5201.713905735183, 5121.155009423441, 5160.819371322004, 5161.4322424533275, 5177.249298851664, 5186.688798672092, 5056.4437911829855, 5060.089183946888, 5141.383034035921, 5160.0, 5185.818496352628, 5059.974700126476, 5077.669951453162, 5100.897982040338, 5152.510511501401, 5190.71451070191, 5026.673266237683, 5128.948565544055, 5130.4356520782685, 5135.537801597837, 5140.1518749406305, 5401.081816091274, 5558.583106267006, 5577.637453565505, 5638.85902852432, 5647.43525647436, 5810.273715785527, 5849.7660093596205, 5889.970550147222, 5911.438413350725, 5995.490383317423, 5946.048632218824, 5949.25634295713, 5957.6127551709, 6030.487408570277, 6056.182415373956, 5628.352739434977, 5637.689927054052, 5642.520385767174, 5643.971780141073, 5650.039493286151, 6046.788362407295, 6058.4244496772735, 6101.755929762849, 6153.353897840751, 6154.846128846725, 5838.211841401441, 5896.380880007538, 5903.055511118287, 5924.437178468039, 5940.079287710412, 5969.671668058211, 6012.579119461596, 6013.579049466495, 6015.248093988252, 6023.247094113236, 5751.568632352591, 5829.621074630136, 5852.122181672698, 5854.8536286592325, 5861.0, 5898.970505147447, 5917.260342457193, 5920.644761314335, 5940.46535811779, 5944.702764861826, 4643.4660014098135, 4672.74299913508, 4688.507706690816, 4696.577308042292, 4724.126036683225, 4072.165206132736, 4084.571120032354, 4094.877153685394, 4106.568810274878, 4173.874783756492, 5709.7716091356715, 5712.285964254468, 5773.1051686988585, 5800.477956983807, 5827.708614569255, 5915.08316210988, 6008.0, 6019.608725432833, 6034.426729460694, 6043.818685439356, 5652.3217213934595, 5664.915026274609, 5718.771249150071, 5726.856828579319, 5766.596338256281, 5235.319408476874, 5273.288106105703, 5276.604254680914, 5296.0, 5308.92036619451, 6283.3088360280335, 6305.085762564494, 6312.621242725451, 6320.0, 6339.049142628551, 5862.355140934579, 5906.881862362643, 6040.546958978182, 6044.697765111639, 6058.818235452944, 6138.357744607813, 6164.229471316085, 6196.535259855439, 6242.188515493139, 6248.281447633581, 5864.589478736448, 5869.970650146722, 5871.001929671881, 5876.265466816648, 5894.557908156991, 5780.710964451677, 5918.881622367615, 5993.61041532299, 6005.219321488178, 6014.8195554133445, 5681.034224181816, 5744.5978781486565, 5762.250907382181, 5769.913451298318, 5840.94159058421, 5786.884262314646, 5797.101449275369, 5810.070388737781, 5820.388859169726, 5822.272215973004, 5753.539716822728, 5778.682172480554, 5789.507891829242, 5792.160136780228, 5809.680467574155, 5688.260526131577, 5728.513076388387, 5832.0, 5847.590668653153, 5857.970710146422, 5717.514011308919, 5728.914066289092, 5753.683547404933, 5772.2207501986695, 5784.942150578609], "value": 5526.300774229871, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.2340017576096, 620.8416853702306, 638.205434234378, 646.8867948109081, 652.4160876015962, 43633.78183109084, 44527.77736111319, 44697.553024469744, 47901.52098479014, 48023.0, 47597.0, 48041.75979120108, 48178.51821481784, 48189.51810481894, 48257.0, 8668.696595619154, 8747.825043499126, 8778.736637900873, 8786.341024423162, 8799.692010779623, 8767.947846258458, 8791.736247912573, 8815.074417186199, 8831.205191532761, 8852.822943541125, 8866.157715017063, 8881.24509416697, 8935.329850261223, 8939.0, 8973.596188171516, 8716.0, 8754.168354006359, 8776.16626420489, 8813.955930220372, 8822.250108740733, 8749.256313213384, 8763.430377025537, 8815.471071735716, 8828.690995815115, 8836.983746869128, 43799.78100109511, 44110.55889441097, 44160.11679766419, 44240.3363949541, 44369.778151109036, 3316.303576248991, 3442.5008373785663, 3470.0977745786026, 3486.511888335635, 3486.7210623150086, 32537.17264490505, 32771.0, 33163.0, 33284.16789580256, 34063.659363406296, 4427.889302767424, 4439.711418757771, 4517.638588912912, 4531.048479819242, 4570.360149579062, 365986.0, 369250.0, 370141.0, 370617.0, 371484.9999999973, 62785.0, 63115.36884631187, 63158.36841631525, 63211.0, 63433.36566634275, 65891.34108658852, 66264.33735662678, 66416.66791666107, 66586.66706666436, 66752.0, 18449.815501845078, 18655.533611659546, 18688.159032843556, 18690.71963920542, 18911.81088189128, 13905.16569005863, 13978.580642580739, 13983.930080349737, 13990.86009139916, 13992.650183745487, 17662.17175978232, 18817.435476935712, 18817.717734233996, 18885.15016824246, 19001.0, 6223.595466294767, 6237.787539417203, 6280.497560195174, 6429.485641148697, 6480.837979050467, 917.788908551037, 1015.1219195395929, 1025.3027941000043, 1031.783325501638, 1046.1735229168871, 32775.34449311048, 33051.3389732204, 33269.0, 33411.04349605853, 33540.832295838365, 1111.9610813621646, 1130.37829193943, 1147.3689470791032, 1179.2488155089684, 1194.2655267010725, 16882.66234675324, 17282.740758888627, 17340.393086241922, 17386.565335866704, 17431.954082755074, 534047.0, 534048.0, 535376.0, 536492.0, 536742.0, 63125.0, 63225.0, 63347.6832615834, 63619.0, 63885.0, 1290.4902563487558, 1344.932753362328, 1345.4819894340749, 1356.138851829076, 1378.6139880833382, 30994.0, 32408.675913240564, 32678.183045424055, 32827.50758738669, 33836.154096147795, 56012.159817603584, 56663.43336566581, 56943.430565693816, 56962.715186423804, 56983.43016569947, 477744.0, 481899.0, 483554.0, 484726.0, 485846.0, 31095.533566996062, 31131.533027005065, 31541.842290788398, 31670.841645791625, 31705.682943171196, 49616.255756164406, 50155.24767128569, 51033.74483127561, 51070.74464627653, 52084.73957630188, 42320.1535969285, 42480.1503969925, 42583.36124958066, 43421.0, 44559.55440445554, 40889.59110408858, 40983.385249220686, 41732.58267417287, 42378.36432453454, 43332.78333608312, 42345.364819527116, 42834.0, 43799.34300985552, 43843.0, 45964.54035459603, 35353.64646353606, 37727.245455091295, 38141.618583813804, 38434.6156538431, 38995.22009559736, 29454.0, 29579.0, 29695.0, 29942.700572993992, 30112.644930978597], "value": 20841.015993820063, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.5552714123028, 430.3544682975537, 433.48632850810077, 436.9300911854103, 444.4599811229356, 18178.636427271445, 18700.0, 19750.506237344038, 19869.900650496744, 19907.502312442197, 19208.327708530203, 19354.419367419, 19656.213751449926, 19778.60442791147, 19782.0, 5650.208970744089, 5938.346781853993, 5940.04959206527, 5946.345901950782, 5946.910796338037, 5689.687067211302, 5806.970965145189, 5835.241418615574, 5927.2590926134235, 5938.287405511344, 5842.503387212092, 5849.532037436995, 5849.8830023399505, 5850.297964244297, 5861.6189947653265, 5664.0371136906615, 5811.215485909433, 5829.9708501457435, 5831.0, 5864.824055278348, 5319.494648008472, 5320.680759154463, 5322.04203243416, 5322.760475778599, 5333.839984800462, 22372.888135559217, 22935.655965160535, 23310.0, 23342.883285583634, 23370.76629233703, 2450.509898020385, 2459.1761759810483, 2608.4522250327454, 2924.1519959211805, 3078.6921307869256, 10281.228907831868, 10390.896091039069, 10719.678409647722, 10829.512671929704, 10965.177611679077, 1714.9571260718458, 1806.9457916262402, 1807.150639199574, 1859.6559636467161, 1871.5414723392719, 86440.0, 87151.0, 87812.0, 87991.0, 88575.55712221397, 11470.197086203885, 11703.0, 11730.472128754227, 11825.172237943261, 11834.230774999769, 16915.40796072156, 16918.91540542314, 16944.322227110777, 16976.151192440328, 17023.40418085361, 8731.65073397057, 8801.91198088011, 8905.73282801517, 8947.284217262604, 9031.548422578844, 8365.665373385118, 8554.828903421896, 8582.270507006975, 8690.0, 8693.826123477495, 5081.0854046272025, 5103.974480127576, 5111.05445492585, 5133.589312854962, 5181.761399125547, 1951.9316823911095, 2055.85609007371, 2094.2670065477264, 2113.661814109735, 2175.1516908405733, 948.3551185194134, 966.8694726212012, 999.1207737191226, 1022.3303736052898, 1071.49104175516, 19430.70853937192, 19511.707324389863, 19550.608987820164, 19666.115024823917, 19835.611507194357, 983.0, 987.9407235565889, 1001.7946321004176, 1008.253892119826, 1068.989310106889, 10353.223508236912, 10951.780964380669, 10959.12327013837, 10967.945160274307, 10990.120790336754, 476110.0, 480003.0, 489988.0, 518287.0, 519764.0, 91297.0, 91485.54257228671, 94195.0, 94668.0533194673, 96272.51863740636, 1021.7496713305288, 1028.3161697471248, 1091.0780390569955, 1106.9667909962714, 1107.2802678259036, 17062.48812535626, 17414.854493124156, 17421.95468271908, 17490.300387984338, 17571.560710981816, 42399.788001059795, 44047.11905761931, 44996.32505512486, 46373.53626463827, 46530.0, 59572.0, 60073.699631501564, 60667.69666151641, 61449.69275153775, 61609.0, 8591.527465989431, 8771.692990745294, 8907.643694252416, 8980.101989800967, 9280.0, 12900.612981610566, 13057.21656700601, 13361.465541378237, 13372.598822035354, 13539.11995720275, 11201.215914886207, 11421.600243991421, 11489.597864074718, 11592.362420066976, 11598.94200528992, 11058.502367393326, 11198.664040078811, 11217.158713096387, 11562.595309164139, 11670.416479175838, 11414.543418263176, 11424.0, 11668.88331116678, 11702.70743231426, 12116.697082573006, 7794.610269486389, 8446.746597602081, 8462.788430289045, 8679.60941757635, 9052.864207037032, 9204.585793639168, 11392.462017627515, 11446.885531144582, 11526.711832204262, 11621.593244236412], "value": 9481.13491053202, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.5988962924828, 1543.5678010157155, 1701.8978861268324, 1790.0960015192318, 1795.2908601102556, 8032.196780321965, 8270.255676989069, 8504.149585041501, 8979.820403591932, 9007.504587247708, 8362.581870906446, 8680.652773889053, 8763.474191548496, 8765.342599305062, 8773.649054037847, 2395.461021270209, 2419.1049311754678, 2453.828232023759, 2464.2853572463964, 2468.2101727447225, 2433.892578876616, 2482.1808803095028, 2498.8625625590585, 2503.0738626708144, 2510.585753350695, 2408.458096928186, 2417.0452671194867, 2424.9272521824373, 2433.124075332879, 2438.0247900839627, 2296.311106667993, 2350.224425939436, 2353.235198560466, 2375.2517956843712, 2376.192094687806, 2370.7629237076326, 2392.031227352925, 2392.9760702392928, 2418.504206637635, 2421.806255499556, 8865.556722163867, 8912.777180570472, 8928.10718928102, 8967.641294348217, 8970.641174353019, 5397.379301380352, 5499.285092937933, 5510.476504732044, 5535.640183388067, 5553.583481238883, 3335.5997280326515, 3393.355262500117, 3403.5745531808525, 3405.8467368968454, 3492.755507114503, 1077.983830242547, 1098.0831006109909, 1103.382106020623, 1145.2956431794387, 1167.97080072998, 12111.152219344649, 12260.0191984641, 12290.877091229062, 12333.0, 12450.875491245062, 4504.121696269196, 4693.366395536627, 4812.917093653899, 4821.951780482221, 4848.200046992207, 10192.13366863825, 10234.33476824004, 10357.274990750575, 10364.948175259226, 10365.896341036492, 5481.671099734029, 5483.4516548344845, 5483.533899618577, 5483.917741233885, 5498.532624726863, 4535.160995215896, 4560.566746159176, 4861.732604706775, 4901.166801643729, 5019.397672279277, 4016.5983401660183, 4043.2722110020477, 4115.176964607091, 4127.236461254677, 4132.896677583084, 1306.203216038216, 1363.277462944641, 1363.4682473835212, 1365.9658508537168, 1373.4231622718482, 938.9154976052188, 959.1176117971482, 972.5283237629744, 982.4350998176077, 1005.8843233028149, 5859.794907178229, 5871.031279838779, 5916.7337469813965, 5929.614575052694, 6055.576109672281, 504.76023888652594, 507.16064912569755, 508.37216038192804, 508.8498892826625, 518.5255491225562, 3965.088029753173, 3977.9801100994887, 3982.183652351261, 3993.9201215975518, 4011.4183443400543, 10465.529051192563, 10877.564897404174, 10923.617673381552, 10983.340999540053, 10984.945075274733, 10816.56733730642, 10816.72958176036, 10849.620263290746, 10861.40262285582, 10867.619633312795, 8116.75649730509, 8222.917770822334, 8238.670453181925, 8317.41778075529, 8352.415330926899, 5707.0, 5769.567282453749, 5801.709914504342, 5844.298684157929, 5868.119782032559, 9094.909050909406, 9807.509624518603, 9848.359856609297, 9891.455969921722, 10013.799724005334, 9656.179224765692, 9685.32202745801, 9703.223742100756, 9735.756606084904, 9764.85352719724, 7078.858422831618, 7124.85750284981, 7612.733554325572, 7766.106897706836, 7895.1315355309725, 8470.0, 8594.699185528476, 8597.441166324168, 8624.09447008055, 8631.136886311318, 7449.44129190302, 7455.552666840007, 7531.58576278288, 7544.924550754422, 7694.07671079474, 7588.734394296173, 7635.503692259986, 7685.807854803675, 7714.421418393756, 7815.8436831261915, 7067.57594544329, 7073.469489788184, 7186.10173728284, 7191.460640451883, 7198.676059577227, 5027.974860125676, 5034.697918124924, 5070.670406423571, 5073.543381095719, 5189.948100518946, 5104.642675012862, 5174.870628234325, 5177.068127737043, 5184.222366645034, 5376.542993845567], "value": 4601.786849577378, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.40066877947737, 341.7258147031503, 347.4198089191052, 359.60802725029714, 359.6475454055026, 5473.616846820724, 5560.6941618211085, 5638.859028524289, 5693.829185124448, 5702.885942281152, 5426.0, 5523.475269849368, 5546.613346663335, 5556.583256255787, 5557.38868724441, 4438.312061630452, 4440.245158323085, 4456.621187199092, 4463.375127482155, 4478.373027776114, 4155.252054630166, 4320.308750599905, 4340.370646256291, 4425.269830477967, 4460.0, 4291.699581029329, 4310.245707001278, 4329.437173167499, 4332.0, 4338.284183109783, 4307.8492252771, 4314.813426307759, 4322.200392927319, 4324.329728892011, 4326.199653064177, 3731.533558305212, 3759.4360845873066, 3819.618038196186, 3840.750351227189, 3851.5185601799776, 5353.491418315254, 5363.329583802025, 5363.597730170253, 5376.758045887945, 5412.648177868426, 4900.289458028566, 4919.950800491985, 4923.08922849274, 4937.358143441365, 4969.726665033421, 5485.61600687952, 5786.47921687046, 5814.273215848019, 5826.912596311059, 5861.443162899561, 4213.726107802983, 4256.851010214627, 4266.296061149907, 4268.573142685737, 4279.97860010698, 6034.24571928509, 6048.516118710492, 6052.394760523956, 6062.424069713415, 6078.96960515199, 4258.659307255412, 4297.419848320499, 4341.761203133858, 4341.8480353188115, 4356.934645980313, 4371.060222052274, 4390.670699697535, 4410.735355878657, 4412.161689279027, 4435.911281774346, 4927.339236812153, 4979.207485305287, 4995.175795993693, 5002.174641184237, 5022.949770502249, 5641.12562552805, 5710.972604725346, 5827.912581311284, 5832.329282132524, 5867.826434713074, 1463.9707205855823, 1479.186447453896, 1481.6444053427315, 1488.8138982627172, 1498.4380857178558, 1016.2124353625851, 1031.6073301043682, 1039.9116075133547, 1040.564021650133, 1055.7911191685478, 5532.7786888524815, 5554.333479982347, 5556.0831513127905, 5563.972180139073, 5572.857564199329, 5773.24947756789, 5776.584736739525, 5811.343767026462, 5821.27234095738, 5825.563082768809, 5420.0, 5423.186522021729, 5467.617266791366, 5499.700179892113, 5540.168974653834, 3082.737967272807, 3086.382723455318, 3088.4132014917545, 3096.3188098618266, 3106.48742957414, 6031.24609423822, 6062.333143354227, 6067.484263837623, 6068.666223357758, 6108.908366374508, 6122.326544080148, 6152.415520525543, 6190.907136392958, 6212.875742485125, 6213.347598502182, 6353.8729225416155, 6363.172787537591, 6371.490280777527, 6375.3624637536805, 6386.2336519618875, 5915.385998920849, 6030.6080104793045, 6057.4851137653795, 6071.787487437919, 6088.178095956989, 5967.6419414835245, 6005.489533389711, 6008.87982240344, 6008.969955150196, 6018.247719035121, 6121.0, 6279.403456671609, 6288.842778930563, 6410.166678331787, 6437.291897891322, 4336.739795612273, 4345.652347812231, 4364.956350436582, 4366.781660917005, 4393.956060439355, 5895.498882595028, 6027.879442411215, 6082.695865206633, 6125.774845030923, 6135.785247516315, 5793.420657934173, 5869.325027621878, 5890.9116363253725, 5893.823185304448, 5938.584299099021, 5888.381719919518, 5910.468057874812, 5913.58604897653, 5922.615030023035, 5995.730192141277, 5730.0, 5820.854478638068, 5853.882922341614, 5867.005218225824, 5882.382349853204, 5913.319968203712, 5915.438033386821, 5923.763049477972, 5943.762249509971, 5947.6431414115295, 5670.8374783170175, 5760.913586296293, 5793.884122317614, 5808.722081142142, 5841.415858414124], "value": 4474.661956184587, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.3655817299046, 676.6041865508677, 734.2657342657342, 736.5470235804978, 783.6630248992931, 14119.152850828945, 14872.256387180652, 14889.702205955888, 14978.176200308992, 15644.452444164457, 14495.565133045999, 14636.048656837298, 14689.485867994596, 14711.632209194775, 14712.190829504372, 832.9541875196892, 833.0669649992018, 833.7207035643066, 834.3033566971586, 841.0, 843.6709683223547, 859.1751918158575, 859.5530324231396, 865.8008658008662, 874.9518776467291, 910.7085732565581, 913.9314551408638, 916.6745805239144, 917.0279503726039, 918.0, 909.495230147268, 911.0434044253508, 912.0788004115824, 913.3606475467167, 913.9817203655923, 666.0209492046683, 668.7091115364832, 668.9598624082571, 668.9698963546653, 669.3641041011059, 15115.546533604009, 15327.846721532753, 15390.384384624602, 15453.995490293095, 15537.844621553753, 13161.73676526464, 13639.454421823115, 13727.0, 13923.0, 14114.153150810984, 10804.1896857736, 10892.455377231106, 10929.781404371868, 10956.0, 11118.277311974696, 3800.1639639279315, 3802.4676545283683, 3803.9809800951093, 3846.0769415340396, 3865.632764887331, 64313.999999999534, 65291.347086529, 65665.0, 66543.3345666542, 66591.0, 10795.244332896778, 11290.604828831116, 11349.489272982735, 11629.418529073513, 11705.941470292764, 19909.402717918485, 20064.297749578694, 20109.698354524695, 20203.48473864466, 20385.694214586794, 7897.131315555284, 7906.841863162705, 7967.601619919097, 7988.800279993046, 8191.426600138052, 4455.68810183284, 4501.504834468205, 4504.684672072989, 4549.590536851633, 4578.931316030262, 3292.967070329266, 3415.7096646785303, 3442.4664177052596, 3442.913927151841, 3448.0690213642174, 613.7054213977316, 621.8321053315669, 627.8147946355745, 632.250782822357, 649.6426965169138, 614.3242433323397, 615.9168512250878, 665.820228538292, 675.8141511084393, 698.3296035805683, 9156.450612963243, 9994.0, 10012.14775266578, 10240.743981400525, 10487.737806554744, 661.5071771530145, 742.736328603338, 752.7403045949138, 772.3820943245381, 816.0859836982618, 4632.62938964882, 4900.754962251873, 4951.777170027357, 4968.205087186033, 5030.471800460972, 77392.0, 81185.0, 82598.58700706458, 84896.0, 85034.0, 71346.0, 72640.27359726335, 74240.17827830024, 76431.61784191155, 76857.23142768501, 66180.33819661742, 66667.99129717708, 67558.0, 67777.3222267771, 68438.65780671065, 9291.396059256127, 9349.25205983506, 9427.952860235655, 9537.0, 9539.0, 44068.55931440773, 44510.554894450644, 45047.56269175435, 45621.08757824892, 46382.53617463782, 61626.0, 62089.68955155195, 62152.0, 63373.36626633859, 65626.67186664227, 11883.881161188277, 11953.342566158944, 12527.0, 12707.428165732379, 12823.807642885178, 13591.0, 14077.507287244896, 14236.430542778588, 14342.139471631319, 15326.923365383102, 13835.308234588028, 13900.582982510541, 13957.441702331793, 14321.713565728418, 14954.327055282321, 14195.432182712575, 14436.133831970115, 14457.855421446071, 14607.780883286547, 14663.926680366956, 12859.16415432994, 12884.677883052998, 13115.540956066492, 13291.20252784836, 13356.599302020955, 10614.575416983544, 10889.401082940198, 11228.326300422, 11495.195336326376, 11682.357470339213, 10915.890841091805, 11846.348450835287, 11943.402829858645, 12100.697482563006, 12118.272903625459], "value": 7277.313089846721, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1488.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 113.0, 112.0, 112.0, 113.0, 112.0, 115.0, 112.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 124.0, 126.0, 159.0, 123.0, 122.0, 123.0, 122.0, 151.0, 130.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 164.0, 163.0, 161.0, 161.0, 162.0, 162.0, 164.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 78.0, 103.0, 75.0, 76.0, 76.0, 78.0, 105.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 119.0, 84.0, 83.0, 83.0, 103.0, 82.0, 82.0, 113.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 119.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 148.0, 150.0, 147.0, 147.0, 148.0, 149.0, 149.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 85.0, 87.0, 86.0, 85.0, 85.0, 85.0, 87.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 53.0, 52.0, 52.0, 55.0, 52.0, 55.0, 59.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 63.0, 59.0, 59.0, 58.0, 60.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 82.0, 76.0, 75.0, 75.0, 81.0, 75.0, 75.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 140.0, 141.0, 140.0, 134.0, 140.0, 127.0, 137.0, 177.0, 127.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 163.0, 160.0, 164.0, 161.0, 158.0, 172.0, 161.0, 161.0, 160.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 65.0, 64.0, 64.0, 67.0, 64.0, 63.0, 70.0], "value": 65.6, "unit": "score"}]}]} 16:09:26 INFO - Return code: 0 16:09:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:09:26 ERROR - # TBPL SUCCESS # 16:09:26 INFO - Running post-action listener: _resource_record_post_action 16:09:26 INFO - [mozharness: 2016-12-03 00:09:26.791752Z] Finished run-tests step (success) 16:09:26 INFO - Running post-run listener: _resource_record_post_run 16:09:26 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 354344960; Read time: 36; Write time: 299524 16:09:26 INFO - TinderboxPrint: CPU usage
13.3% 16:09:26 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 36 16:09:26 INFO - TinderboxPrint: I/O write bytes / time
354,344,960 / 299,524 16:09:26 INFO - TinderboxPrint: CPU idle
8,237.5 (86.7%) 16:09:26 INFO - TinderboxPrint: CPU user
1,205.3 (12.7%) 16:09:26 INFO - TinderboxPrint: Swap in / out
0 / 0 16:09:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108011520; Read time: 0; Write time: 118860 16:09:26 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 246329344; Read time: 28; Write time: 180664 16:09:27 INFO - Running post-run listener: _upload_blobber_files 16:09:27 INFO - Blob upload gear active. 16:09:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:09:27 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 16:09:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:09:27 INFO - (blobuploader) - INFO - Open directory for files ... 16:09:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:09:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:09:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:28 INFO - (blobuploader) - INFO - Done attempting. 16:09:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:09:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:09:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:32 INFO - (blobuploader) - INFO - Done attempting. 16:09:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:09:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:09:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:33 INFO - (blobuploader) - INFO - Done attempting. 16:09:33 INFO - (blobuploader) - INFO - Iteration through files over. 16:09:33 INFO - Return code: 0 16:09:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:09:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:09:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2e4b85189fdd2214144161d5725c8d0282eb77155b97b4a23d0ab0fbdd14d5191b61b5dec252a5c82b98f499d3415809cc44fb49bc518cd1887de2213f030ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/379bfa8063fb316e4626360ba92f24b5129389ebf6a8ebfc42aebc6d3241540c9b941d5bbe6efe9634a6a49a82eafcf810ce8cb8a3f7e796e78ab65f00f4a476", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89c3d3966ff6b6b6195fd87de4eaf569c7e0f48139e2bbeeddc193b43cdd449c997d2206b13a45023c3fc456735d55c25e4688d3e9b0b325a88b7d61ec01eec7"} 16:09:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:09:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:09:33 INFO - Contents: 16:09:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2e4b85189fdd2214144161d5725c8d0282eb77155b97b4a23d0ab0fbdd14d5191b61b5dec252a5c82b98f499d3415809cc44fb49bc518cd1887de2213f030ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/379bfa8063fb316e4626360ba92f24b5129389ebf6a8ebfc42aebc6d3241540c9b941d5bbe6efe9634a6a49a82eafcf810ce8cb8a3f7e796e78ab65f00f4a476", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89c3d3966ff6b6b6195fd87de4eaf569c7e0f48139e2bbeeddc193b43cdd449c997d2206b13a45023c3fc456735d55c25e4688d3e9b0b325a88b7d61ec01eec7"} 16:09:33 INFO - Running post-run listener: copy_logs_to_upload_dir 16:09:33 INFO - Copying logs to upload dir... 16:09:33 INFO - mkdir: /builds/slave/test/build/upload/logs 16:09:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.115689 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-12-02 16:09:33.541550) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 16:09:33.545387) ========= 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=41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2e4b85189fdd2214144161d5725c8d0282eb77155b97b4a23d0ab0fbdd14d5191b61b5dec252a5c82b98f499d3415809cc44fb49bc518cd1887de2213f030ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/379bfa8063fb316e4626360ba92f24b5129389ebf6a8ebfc42aebc6d3241540c9b941d5bbe6efe9634a6a49a82eafcf810ce8cb8a3f7e796e78ab65f00f4a476", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89c3d3966ff6b6b6195fd87de4eaf569c7e0f48139e2bbeeddc193b43cdd449c997d2206b13a45023c3fc456735d55c25e4688d3e9b0b325a88b7d61ec01eec7"} build_url:https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/Q_Kr1C85Q_GZ-Smvbiz3LQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2e4b85189fdd2214144161d5725c8d0282eb77155b97b4a23d0ab0fbdd14d5191b61b5dec252a5c82b98f499d3415809cc44fb49bc518cd1887de2213f030ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/379bfa8063fb316e4626360ba92f24b5129389ebf6a8ebfc42aebc6d3241540c9b941d5bbe6efe9634a6a49a82eafcf810ce8cb8a3f7e796e78ab65f00f4a476", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89c3d3966ff6b6b6195fd87de4eaf569c7e0f48139e2bbeeddc193b43cdd449c997d2206b13a45023c3fc456735d55c25e4688d3e9b0b325a88b7d61ec01eec7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 16:09:33.571683) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 16:09:33.572076) ========= 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=41a7e32711b8e08598a63237000001d6-1480720864.724039-240336599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 16:09:33.657925) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 16:09:33.658290) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 16:09:33.658652) ========= ========= Total master_lag: 0.19 =========