builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-083 starttime: 1487277228.81 results: success (0) buildid: 20170216105119 builduid: af369f3d3eb44e6ba0b6c22d14a20ce6 revision: 820bc5bd3120853d611af1056f4a2b35528bb927 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 12:33:48.814852) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 12:33:48.815311) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 12:33:48.815600) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 12:33:48.831676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 12:33:48.831938) ========= 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=3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-16 12:33:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2017-02-16 12:33:49 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121948 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 12:33:48.967298) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 12:33:48.967628) ========= 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=3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017881 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 12:33:49.017568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 12:33:49.017916) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 820bc5bd3120853d611af1056f4a2b35528bb927 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 820bc5bd3120853d611af1056f4a2b35528bb927 --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=3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-16 12:33:49,742 truncating revision to first 12 chars 2017-02-16 12:33:49,742 Setting DEBUG logging. 2017-02-16 12:33:49,742 attempt 1/10 2017-02-16 12:33:49,742 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/820bc5bd3120?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-16 12:33:50,241 unpacking tar archive at: mozilla-beta-820bc5bd3120/testing/mozharness/ program finished with exit code 0 elapsedTime=0.869625 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 12:33:49.900579) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 12:33:49.900932) ========= script_repo_revision: 820bc5bd3120853d611af1056f4a2b35528bb927 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 12:33:49.901321) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 12:33:49.901604) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 12:33:49.910314) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-02-16 12:33:49.910746) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:33:50 INFO - MultiFileLogger online at 20170216 12:33:50 in /builds/slave/test 12:33:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:33:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:33:50 INFO - {'append_to_log': False, 12:33:50 INFO - 'base_work_dir': '/builds/slave/test', 12:33:50 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:33:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:33:50 INFO - 'branch': 'Mozilla-Beta', 12:33:50 INFO - 'buildbot_json_path': 'buildprops.json', 12:33:50 INFO - 'config_files': ('talos/linux_config.py',), 12:33:50 INFO - 'default_actions': ('clobber', 12:33:50 INFO - 'read-buildbot-config', 12:33:50 INFO - 'download-and-extract', 12:33:50 INFO - 'populate-webroot', 12:33:50 INFO - 'create-virtualenv', 12:33:50 INFO - 'install', 12:33:50 INFO - 'run-tests'), 12:33:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:33:50 INFO - 'download_minidump_stackwalk': True, 12:33:50 INFO - 'download_symbols': 'ondemand', 12:33:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:33:50 INFO - 'tooltool.py': '/tools/tooltool.py', 12:33:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:33:50 INFO - '/tools/misc-python/virtualenv.py')}, 12:33:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:33:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:33:50 INFO - 'installer_path': 'installer.exe', 12:33:50 INFO - 'log_level': 'info', 12:33:50 INFO - 'log_name': 'talos', 12:33:50 INFO - 'log_to_console': True, 12:33:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:33:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:33:50 INFO - 'opt_config_files': (), 12:33:50 INFO - 'pip_index': False, 12:33:50 INFO - 'sps_profile': False, 12:33:50 INFO - 'sps_profile_interval': 0, 12:33:50 INFO - 'suite': 'dromaeojs', 12:33:50 INFO - 'system_bits': '32', 12:33:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:33:50 INFO - 'title': 'talos-linux64-ix-083', 12:33:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:33:50 INFO - 'use_talos_json': True, 12:33:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:33:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:33:50 INFO - 'work_dir': 'build'} 12:33:50 INFO - [mozharness: 2017-02-16 20:33:50.737793Z] Running clobber step. 12:33:50 INFO - Running pre-action listener: _resource_record_pre_action 12:33:50 INFO - Running main action method: clobber 12:33:50 INFO - rmtree: /builds/slave/test/build 12:33:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:33:52 INFO - Running post-action listener: _resource_record_post_action 12:33:52 INFO - [mozharness: 2017-02-16 20:33:52.300063Z] Finished clobber step (success) 12:33:52 INFO - [mozharness: 2017-02-16 20:33:52.300161Z] Running read-buildbot-config step. 12:33:52 INFO - Running pre-action listener: _resource_record_pre_action 12:33:52 INFO - Running main action method: read_buildbot_config 12:33:52 INFO - Using buildbot properties: 12:33:52 INFO - { 12:33:52 INFO - "project": "", 12:33:52 INFO - "product": "firefox", 12:33:52 INFO - "script_repo_revision": "production", 12:33:52 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:33:52 INFO - "repository": "", 12:33:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 12:33:52 INFO - "buildid": "20170216105119", 12:33:52 INFO - "pgo_build": "True", 12:33:52 INFO - "basedir": "/builds/slave/test", 12:33:52 INFO - "buildnumber": 145, 12:33:52 INFO - "slavename": "talos-linux64-ix-083", 12:33:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:33:52 INFO - "platform": "ubuntu64_hw", 12:33:52 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:33:52 INFO - "branch": "mozilla-beta", 12:33:52 INFO - "repo_path": "releases/mozilla-beta", 12:33:52 INFO - "revision": "820bc5bd3120853d611af1056f4a2b35528bb927", 12:33:52 INFO - "stage_platform": "linux64-pgo", 12:33:52 INFO - "builduid": "af369f3d3eb44e6ba0b6c22d14a20ce6", 12:33:52 INFO - "slavebuilddir": "test" 12:33:52 INFO - } 12:33:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 12:33:52 INFO - Running post-action listener: _resource_record_post_action 12:33:52 INFO - [mozharness: 2017-02-16 20:33:52.302575Z] Finished read-buildbot-config step (success) 12:33:52 INFO - [mozharness: 2017-02-16 20:33:52.302663Z] Running download-and-extract step. 12:33:52 INFO - Running pre-action listener: _resource_record_pre_action 12:33:52 INFO - Running main action method: download_and_extract 12:33:52 INFO - mkdir: /builds/slave/test/build/tests 12:33:52 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')]} 12:33:52 INFO - trying https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 12:33:52 INFO - Downloading https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 12:33:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:33:52 INFO - Downloaded 1327 bytes. 12:33:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 12:33:52 INFO - Using the following test package requirements: 12:33:52 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 12:33:52 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:33:52 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:33:52 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:33:52 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 12:33:52 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:33:52 INFO - u'jsshell-linux-x86_64.zip'], 12:33:52 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:33:52 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:33:52 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 12:33:52 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:33:52 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 12:33:52 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:33:52 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 12:33:52 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:33:52 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:33:52 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:33:52 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:33:52 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:33:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 12:33:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:33:52 INFO - Fetch https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 12:33:53 INFO - Http code: 200 12:33:53 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 12:33:53 INFO - x-amz-cf-id: mWuufl_Zq3GmmZGX62lynCwEkHee4pUawxKYQzinvP_pRE5VIvRJVw== 12:33:53 INFO - x-amz-version-id: rY8XNBXM_Ce0IWKSWLhhujxO1RQ8up_a 12:33:53 INFO - Expected file size: 21956780 12:33:53 INFO - Obtained file size: 21956780 12:33:57 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:33:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 12:33:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:33:57 INFO - Fetch https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 12:33:58 INFO - Http code: 200 12:33:58 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 12:33:58 INFO - x-amz-cf-id: xaVynHYavscvdPfUdMODtLTJ5PhQ8tPuWynJP944Y2NItQ2QBVCo7A== 12:33:58 INFO - x-amz-version-id: rY8XNBXM_Ce0IWKSWLhhujxO1RQ8up_a 12:33:58 INFO - Expected file size: 21956780 12:33:58 INFO - Obtained file size: 21956780 12:34:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 12:34:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:34:02 INFO - Fetch https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 12:34:03 INFO - Http code: 200 12:34:03 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 12:34:03 INFO - x-amz-cf-id: O5ba_NnrwV8D__fXAGhnJz_hSHMygOiA-Tofv2D9EenmhAIouDoY8Q== 12:34:03 INFO - x-amz-version-id: PerLoVyWtJ90CY_q2gonSYcetrt9TBpD 12:34:03 INFO - Expected file size: 14403005 12:34:03 INFO - Obtained file size: 14403005 12:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:03 INFO - trying https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:34:03 INFO - Downloading https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:34:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:34:05 INFO - Downloaded 57769948 bytes. 12:34:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:34:05 INFO - mkdir: /builds/slave/test/properties 12:34:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:34:05 INFO - Writing to file /builds/slave/test/properties/build_url 12:34:05 INFO - Contents: 12:34:05 INFO - build_url:https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:34:05 INFO - Running post-action listener: _resource_record_post_action 12:34:05 INFO - Running post-action listener: set_extra_try_arguments 12:34:05 INFO - [mozharness: 2017-02-16 20:34:05.778225Z] Finished download-and-extract step (success) 12:34:05 INFO - [mozharness: 2017-02-16 20:34:05.778450Z] Running populate-webroot step. 12:34:05 INFO - Running pre-action listener: _resource_record_pre_action 12:34:05 INFO - Running main action method: populate_webroot 12:34:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:34:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:34:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:34:05 INFO - '--tppagecycles', 12:34:05 INFO - '7'], 12:34:05 INFO - 'tests': ['tsvgm']}}, 12:34:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:34:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:34:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:34:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:34:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:34:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:34:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:05 INFO - 'talos_options': ['--disable-e10s'], 12:34:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:34:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:34:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:05 INFO - 'talos_options': ['--disable-e10s'], 12:34:05 INFO - 'tests': ['damp', 'tps']}, 12:34:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:05 INFO - 'tests': ['damp', 'tps']}, 12:34:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:34:05 INFO - 'tests': ['dromaeo_dom']}, 12:34:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:34:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:34:05 INFO - 'tests': ['basic_compositor_video']}, 12:34:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:34:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:34:05 INFO - 'tests': ['a11yr', 12:34:05 INFO - 'ts_paint', 12:34:05 INFO - 'tpaint', 12:34:05 INFO - 'sessionrestore', 12:34:05 INFO - 'sessionrestore_no_auto_restore', 12:34:05 INFO - 'tabpaint']}, 12:34:05 INFO - 'other-e10s': {'tests': ['a11yr', 12:34:05 INFO - 'ts_paint', 12:34:05 INFO - 'tpaint', 12:34:05 INFO - 'sessionrestore', 12:34:05 INFO - 'sessionrestore_no_auto_restore', 12:34:05 INFO - 'tabpaint']}, 12:34:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:34:05 INFO - 'ts_paint', 12:34:05 INFO - 'tpaint', 12:34:05 INFO - 'sessionrestore', 12:34:05 INFO - 'sessionrestore_no_auto_restore', 12:34:05 INFO - 'tabpaint']}, 12:34:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:34:05 INFO - 'ts_paint', 12:34:05 INFO - 'tpaint', 12:34:05 INFO - 'sessionrestore', 12:34:05 INFO - 'sessionrestore_no_auto_restore', 12:34:05 INFO - 'tabpaint']}, 12:34:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:34:05 INFO - 'tests': ['a11yr', 12:34:05 INFO - 'ts_paint', 12:34:05 INFO - 'tpaint', 12:34:05 INFO - 'sessionrestore', 12:34:05 INFO - 'sessionrestore_no_auto_restore', 12:34:05 INFO - 'tabpaint']}, 12:34:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:34:05 INFO - 'tests': ['a11yr', 12:34:05 INFO - 'ts_paint', 12:34:05 INFO - 'tpaint', 12:34:05 INFO - 'sessionrestore', 12:34:05 INFO - 'sessionrestore_no_auto_restore', 12:34:05 INFO - 'tabpaint']}, 12:34:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:34:05 INFO - 'tests': ['tsvgx', 12:34:05 INFO - 'tsvgr_opacity', 12:34:05 INFO - 'tart', 12:34:05 INFO - 'tscrollx', 12:34:05 INFO - 'cart']}, 12:34:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:34:05 INFO - 'tsvgr_opacity', 12:34:05 INFO - 'tart', 12:34:05 INFO - 'tscrollx', 12:34:05 INFO - 'cart']}, 12:34:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:05 INFO - 'talos_options': ['--disable-e10s'], 12:34:05 INFO - 'tests': ['tp5o']}, 12:34:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:05 INFO - 'tests': ['tp5o']}, 12:34:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:05 INFO - 'talos_options': ['--disable-e10s', 12:34:05 INFO - '--xperf_path', 12:34:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:34:05 INFO - 'tests': ['tp5n']}, 12:34:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:05 INFO - 'talos_options': ['--xperf_path', 12:34:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:34:05 INFO - 'tests': ['tp5n']}}, 12:34:05 INFO - 'talos.zip': {'path': '', 12:34:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:34:05 INFO - Running post-action listener: _resource_record_post_action 12:34:05 INFO - [mozharness: 2017-02-16 20:34:05.796120Z] Finished populate-webroot step (success) 12:34:05 INFO - [mozharness: 2017-02-16 20:34:05.796208Z] Running create-virtualenv step. 12:34:05 INFO - Running pre-action listener: _resource_record_pre_action 12:34:05 INFO - Running main action method: create_virtualenv 12:34:05 INFO - Creating virtualenv /builds/slave/test/build/venv 12:34:05 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 12:34:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:34:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:34:05 INFO - Using real prefix '/usr' 12:34:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:34:06 INFO - Installing distribute.............................................................................................................................................................................................done. 12:34:08 INFO - Installing pip.................done. 12:34:08 INFO - Return code: 0 12:34:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:34:08 INFO - Reading from file tmpfile_stdout 12:34:08 INFO - Output received: 12:34:08 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) 12:34:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:08 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 0x7f632982af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1932ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ff60>, '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 0x1930d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19311d0>, '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': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', '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 12:34:08 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 12:34:08 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 12:34:08 INFO - Using env: {'DISPLAY': ':0', 12:34:08 INFO - 'HOME': '/home/cltbld', 12:34:08 INFO - 'LANG': 'en_US.UTF-8', 12:34:08 INFO - 'LANGUAGE': 'en_US:en', 12:34:08 INFO - 'LOGNAME': 'cltbld', 12:34:08 INFO - 'MAIL': '/var/mail/cltbld', 12:34:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:08 INFO - 'MOZ_NO_REMOTE': '1', 12:34:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:08 INFO - 'NO_EM_RESTART': '1', 12:34:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:08 INFO - 'PWD': '/builds/slave/test', 12:34:08 INFO - 'SHELL': '/bin/bash', 12:34:08 INFO - 'SHLVL': '1', 12:34:08 INFO - 'TERM': 'linux', 12:34:08 INFO - 'TMOUT': '86400', 12:34:08 INFO - 'USER': 'cltbld', 12:34:08 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', 12:34:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:08 INFO - '_': '/tools/buildbot/bin/python'} 12:34:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:08 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 12:34:08 INFO - Cleaning up... 12:34:08 INFO - Return code: 0 12:34:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:08 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 0x7f632982af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1932ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ff60>, '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 0x1930d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19311d0>, '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': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', '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 12:34:08 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 12:34:08 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 12:34:08 INFO - Using env: {'DISPLAY': ':0', 12:34:08 INFO - 'HOME': '/home/cltbld', 12:34:08 INFO - 'LANG': 'en_US.UTF-8', 12:34:08 INFO - 'LANGUAGE': 'en_US:en', 12:34:08 INFO - 'LOGNAME': 'cltbld', 12:34:08 INFO - 'MAIL': '/var/mail/cltbld', 12:34:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:08 INFO - 'MOZ_NO_REMOTE': '1', 12:34:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:08 INFO - 'NO_EM_RESTART': '1', 12:34:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:08 INFO - 'PWD': '/builds/slave/test', 12:34:08 INFO - 'SHELL': '/bin/bash', 12:34:08 INFO - 'SHLVL': '1', 12:34:08 INFO - 'TERM': 'linux', 12:34:08 INFO - 'TMOUT': '86400', 12:34:08 INFO - 'USER': 'cltbld', 12:34:08 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', 12:34:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:08 INFO - '_': '/tools/buildbot/bin/python'} 12:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:09 INFO - Downloading/unpacking psutil>=3.1.1 12:34:09 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 12:34:09 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 12:34:09 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 12:34:09 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 12:34:09 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 12:34:09 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 12:34:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:34:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:34:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:34:11 INFO - Installing collected packages: psutil 12:34:11 INFO - Running setup.py install for psutil 12:34:11 INFO - building 'psutil._psutil_linux' extension 12:34:11 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 12:34:11 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 12:34:11 INFO - building 'psutil._psutil_posix' extension 12:34:11 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 12:34:11 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 12:34:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:34:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:34:11 INFO - Successfully installed psutil 12:34:11 INFO - Cleaning up... 12:34:11 INFO - Return code: 0 12:34:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:11 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 0x7f632982af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1932ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ff60>, '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 0x1930d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19311d0>, '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': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', '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 12:34:11 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 12:34:11 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 12:34:11 INFO - Using env: {'DISPLAY': ':0', 12:34:11 INFO - 'HOME': '/home/cltbld', 12:34:11 INFO - 'LANG': 'en_US.UTF-8', 12:34:11 INFO - 'LANGUAGE': 'en_US:en', 12:34:11 INFO - 'LOGNAME': 'cltbld', 12:34:11 INFO - 'MAIL': '/var/mail/cltbld', 12:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:11 INFO - 'MOZ_NO_REMOTE': '1', 12:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:11 INFO - 'NO_EM_RESTART': '1', 12:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:11 INFO - 'PWD': '/builds/slave/test', 12:34:11 INFO - 'SHELL': '/bin/bash', 12:34:11 INFO - 'SHLVL': '1', 12:34:11 INFO - 'TERM': 'linux', 12:34:11 INFO - 'TMOUT': '86400', 12:34:11 INFO - 'USER': 'cltbld', 12:34:11 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', 12:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:11 INFO - '_': '/tools/buildbot/bin/python'} 12:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:34:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:34:14 INFO - Installing collected packages: mozsystemmonitor 12:34:14 INFO - Running setup.py install for mozsystemmonitor 12:34:14 INFO - Successfully installed mozsystemmonitor 12:34:14 INFO - Cleaning up... 12:34:14 INFO - Return code: 0 12:34:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f632982af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1932ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ff60>, '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 0x1930d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19311d0>, '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': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', '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 12:34:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:34:14 INFO - Using env: {'DISPLAY': ':0', 12:34:14 INFO - 'HOME': '/home/cltbld', 12:34:14 INFO - 'LANG': 'en_US.UTF-8', 12:34:14 INFO - 'LANGUAGE': 'en_US:en', 12:34:14 INFO - 'LOGNAME': 'cltbld', 12:34:14 INFO - 'MAIL': '/var/mail/cltbld', 12:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:14 INFO - 'MOZ_NO_REMOTE': '1', 12:34:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:14 INFO - 'NO_EM_RESTART': '1', 12:34:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:14 INFO - 'PWD': '/builds/slave/test', 12:34:14 INFO - 'SHELL': '/bin/bash', 12:34:14 INFO - 'SHLVL': '1', 12:34:14 INFO - 'TERM': 'linux', 12:34:14 INFO - 'TMOUT': '86400', 12:34:14 INFO - 'USER': 'cltbld', 12:34:14 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', 12:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:14 INFO - '_': '/tools/buildbot/bin/python'} 12:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:14 INFO - Downloading/unpacking jsonschema==2.5.1 12:34:14 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 12:34:14 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 12:34:14 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 12:34:14 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 12:34:14 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 12:34:14 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 12:34:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:34:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:34:16 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 12:34:16 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 12:34:16 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 12:34:16 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 12:34:16 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 12:34:16 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 12:34:16 INFO - Downloading functools32-3.2.3-2.tar.gz 12:34:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:34:16 INFO - warning: no files found matching '*.txt' 12:34:16 INFO - no previously-included directories found matching 'build' 12:34:16 INFO - no previously-included directories found matching 'dist' 12:34:16 INFO - no previously-included directories found matching '.git*' 12:34:16 INFO - Installing collected packages: jsonschema, functools32 12:34:16 INFO - Running setup.py install for functools32 12:34:16 INFO - warning: no files found matching '*.txt' 12:34:16 INFO - no previously-included directories found matching 'build' 12:34:16 INFO - no previously-included directories found matching 'dist' 12:34:16 INFO - no previously-included directories found matching '.git*' 12:34:16 INFO - Successfully installed jsonschema functools32 12:34:16 INFO - Cleaning up... 12:34:16 INFO - Return code: 0 12:34:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:34:16 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')]} 12:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:16 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')]} 12:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:16 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 0x7f632982af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1932ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ff60>, '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 0x1930d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19311d0>, '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': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', '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 12:34:16 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 12:34:16 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 12:34:16 INFO - Using env: {'DISPLAY': ':0', 12:34:16 INFO - 'HOME': '/home/cltbld', 12:34:16 INFO - 'LANG': 'en_US.UTF-8', 12:34:16 INFO - 'LANGUAGE': 'en_US:en', 12:34:16 INFO - 'LOGNAME': 'cltbld', 12:34:16 INFO - 'MAIL': '/var/mail/cltbld', 12:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:16 INFO - 'MOZ_NO_REMOTE': '1', 12:34:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:16 INFO - 'NO_EM_RESTART': '1', 12:34:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:16 INFO - 'PWD': '/builds/slave/test', 12:34:16 INFO - 'SHELL': '/bin/bash', 12:34:16 INFO - 'SHLVL': '1', 12:34:16 INFO - 'TERM': 'linux', 12:34:16 INFO - 'TMOUT': '86400', 12:34:16 INFO - 'USER': 'cltbld', 12:34:16 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', 12:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:16 INFO - '_': '/tools/buildbot/bin/python'} 12:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:34:17 INFO - Cleaning up... 12:34:17 INFO - Return code: 0 12:34:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:34:17 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')]} 12:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:17 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')]} 12:34:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:17 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 0x7f632982af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1932ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ff60>, '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 0x1930d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19311d0>, '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': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', '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 12:34:17 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 12:34:17 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 12:34:17 INFO - Using env: {'DISPLAY': ':0', 12:34:17 INFO - 'HOME': '/home/cltbld', 12:34:17 INFO - 'LANG': 'en_US.UTF-8', 12:34:17 INFO - 'LANGUAGE': 'en_US:en', 12:34:17 INFO - 'LOGNAME': 'cltbld', 12:34:17 INFO - 'MAIL': '/var/mail/cltbld', 12:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:17 INFO - 'MOZ_NO_REMOTE': '1', 12:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:17 INFO - 'NO_EM_RESTART': '1', 12:34:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:17 INFO - 'PWD': '/builds/slave/test', 12:34:17 INFO - 'SHELL': '/bin/bash', 12:34:17 INFO - 'SHLVL': '1', 12:34:17 INFO - 'TERM': 'linux', 12:34:17 INFO - 'TMOUT': '86400', 12:34:17 INFO - 'USER': 'cltbld', 12:34:17 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', 12:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:17 INFO - '_': '/tools/buildbot/bin/python'} 12:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:17 INFO - Downloading/unpacking blobuploader==1.2.4 12:34:17 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 12:34:17 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 12:34:17 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 12:34:17 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 12:34:17 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 12:34:17 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 12:34:19 INFO - Downloading blobuploader-1.2.4.tar.gz 12:34:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:34:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:34:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:20 INFO - Downloading docopt-0.6.1.tar.gz 12:34:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:34:20 INFO - Installing collected packages: blobuploader, requests, docopt 12:34:20 INFO - Running setup.py install for blobuploader 12:34:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:34:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:34:20 INFO - Running setup.py install for requests 12:34:20 INFO - Running setup.py install for docopt 12:34:20 INFO - Successfully installed blobuploader requests docopt 12:34:20 INFO - Cleaning up... 12:34:20 INFO - Return code: 0 12:34:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:34: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')]} 12:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34: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')]} 12:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:20 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 0x7f632982af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1932ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ff60>, '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 0x1930d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19311d0>, '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': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', '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 12:34:20 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 12:34:20 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 12:34:20 INFO - Using env: {'DISPLAY': ':0', 12:34:20 INFO - 'HOME': '/home/cltbld', 12:34:20 INFO - 'LANG': 'en_US.UTF-8', 12:34:20 INFO - 'LANGUAGE': 'en_US:en', 12:34:20 INFO - 'LOGNAME': 'cltbld', 12:34:20 INFO - 'MAIL': '/var/mail/cltbld', 12:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:20 INFO - 'MOZ_NO_REMOTE': '1', 12:34:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:20 INFO - 'NO_EM_RESTART': '1', 12:34:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:20 INFO - 'PWD': '/builds/slave/test', 12:34:20 INFO - 'SHELL': '/bin/bash', 12:34:20 INFO - 'SHLVL': '1', 12:34:20 INFO - 'TERM': 'linux', 12:34:20 INFO - 'TMOUT': '86400', 12:34:20 INFO - 'USER': 'cltbld', 12:34:20 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', 12:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:20 INFO - '_': '/tools/buildbot/bin/python'} 12:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:34:20 INFO - Running setup.py (path:/tmp/pip-7FBRO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:34:21 INFO - Running setup.py (path:/tmp/pip-sKKnu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:34:21 INFO - Running setup.py (path:/tmp/pip-hThgMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:34:21 INFO - Running setup.py (path:/tmp/pip-Tq5TUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:34:21 INFO - Running setup.py (path:/tmp/pip-gHoabX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:34:21 INFO - Running setup.py (path:/tmp/pip-WpHz_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:34:21 INFO - Running setup.py (path:/tmp/pip-ACiHa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:34:21 INFO - Running setup.py (path:/tmp/pip-NxQWn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:34:21 INFO - Running setup.py (path:/tmp/pip-JQvhAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:34:21 INFO - Running setup.py (path:/tmp/pip-qFUlXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:34:21 INFO - Running setup.py (path:/tmp/pip-V_g7lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:34:21 INFO - Running setup.py (path:/tmp/pip-vlI9MV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:34:22 INFO - Running setup.py (path:/tmp/pip-EkrfU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:34:22 INFO - Running setup.py (path:/tmp/pip-yaEZJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:34:22 INFO - Running setup.py (path:/tmp/pip-7ONVA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:34:22 INFO - Running setup.py (path:/tmp/pip-T0id73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:34:22 INFO - Running setup.py (path:/tmp/pip-XEfUOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:34:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:34:22 INFO - Running setup.py install for manifestparser 12:34:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:34:22 INFO - Running setup.py install for mozcrash 12:34:22 INFO - Running setup.py install for mozdebug 12:34:22 INFO - Running setup.py install for mozdevice 12:34:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:34:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:34:22 INFO - Running setup.py install for mozfile 12:34:22 INFO - Running setup.py install for mozhttpd 12:34:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:34:23 INFO - Running setup.py install for mozinfo 12:34:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:34:23 INFO - Running setup.py install for mozInstall 12:34:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:34:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:34:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:34:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:34:23 INFO - Running setup.py install for mozleak 12:34:23 INFO - Running setup.py install for mozlog 12:34:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:34:23 INFO - Running setup.py install for moznetwork 12:34:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:34:23 INFO - Running setup.py install for mozprocess 12:34:23 INFO - Running setup.py install for mozprofile 12:34:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:34:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:34:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:34:23 INFO - Running setup.py install for mozrunner 12:34:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:34:23 INFO - Running setup.py install for mozscreenshot 12:34:23 INFO - Running setup.py install for moztest 12:34:24 INFO - Running setup.py install for mozversion 12:34:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:34:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:34:24 INFO - Cleaning up... 12:34:24 INFO - Return code: 0 12:34:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:24 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 0x7f632982af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1932ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ff60>, '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 0x1930d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19311d0>, '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': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', '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 12:34:24 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 12:34:24 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 12:34:24 INFO - Using env: {'DISPLAY': ':0', 12:34:24 INFO - 'HOME': '/home/cltbld', 12:34:24 INFO - 'LANG': 'en_US.UTF-8', 12:34:24 INFO - 'LANGUAGE': 'en_US:en', 12:34:24 INFO - 'LOGNAME': 'cltbld', 12:34:24 INFO - 'MAIL': '/var/mail/cltbld', 12:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:24 INFO - 'MOZ_NO_REMOTE': '1', 12:34:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:24 INFO - 'NO_EM_RESTART': '1', 12:34:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:24 INFO - 'PWD': '/builds/slave/test', 12:34:24 INFO - 'SHELL': '/bin/bash', 12:34:24 INFO - 'SHLVL': '1', 12:34:24 INFO - 'TERM': 'linux', 12:34:24 INFO - 'TMOUT': '86400', 12:34:24 INFO - 'USER': 'cltbld', 12:34:24 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', 12:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:24 INFO - '_': '/tools/buildbot/bin/python'} 12:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:34:24 INFO - Running setup.py (path:/tmp/pip-TL_N2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:34:24 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)) 12:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:34:24 INFO - Running setup.py (path:/tmp/pip-PWwEXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:34:24 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)) 12:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:34:24 INFO - Running setup.py (path:/tmp/pip-h0CX4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:34:24 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)) 12:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:34:24 INFO - Running setup.py (path:/tmp/pip-qUJCBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:34:24 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)) 12:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:34:24 INFO - Running setup.py (path:/tmp/pip-IRMhAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:34:24 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)) 12:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:34:24 INFO - Running setup.py (path:/tmp/pip-pJ8BVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:34:24 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)) 12:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:34:24 INFO - Running setup.py (path:/tmp/pip-6st6Yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:34:24 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)) 12:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:34:24 INFO - Running setup.py (path:/tmp/pip-z8ykDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:34:25 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)) 12:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:34:25 INFO - Running setup.py (path:/tmp/pip-2yvdpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:34:25 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)) 12:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:34:25 INFO - Running setup.py (path:/tmp/pip-emoiIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:34:25 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)) 12:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:34:25 INFO - Running setup.py (path:/tmp/pip-8m2Y25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:34:25 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)) 12:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:34:25 INFO - Running setup.py (path:/tmp/pip-0tGf6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:34:25 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)) 12:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:34:25 INFO - Running setup.py (path:/tmp/pip-Q2Ml3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:34:25 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)) 12:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:34:25 INFO - Running setup.py (path:/tmp/pip-MRiUhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:34:25 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)) 12:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:34:25 INFO - Running setup.py (path:/tmp/pip-PhsWaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:34:25 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)) 12:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:34:25 INFO - Running setup.py (path:/tmp/pip-7_aLK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:34:25 INFO - Running setup.py (path:/tmp/pip-NwTjcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:34:25 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)) 12:34:25 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)) 12:34:25 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)) 12:34:25 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)) 12:34:25 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)) 12:34:25 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)) 12:34:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:34:25 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 12:34:25 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 12:34:25 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 12:34:25 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 12:34:25 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 12:34:25 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 12:34:27 INFO - Downloading blessings-1.6.tar.gz 12:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:34:27 INFO - Installing collected packages: blessings 12:34:27 INFO - Running setup.py install for blessings 12:34:27 INFO - Successfully installed blessings 12:34:27 INFO - Cleaning up... 12:34:27 INFO - Return code: 0 12:34:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:34:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:34:28 INFO - Reading from file tmpfile_stdout 12:34:28 INFO - Current package versions: 12:34:28 INFO - argparse == 1.2.1 12:34:28 INFO - blessings == 1.6 12:34:28 INFO - blobuploader == 1.2.4 12:34:28 INFO - docopt == 0.6.1 12:34:28 INFO - functools32 == 3.2.3-2 12:34:28 INFO - jsonschema == 2.5.1 12:34:28 INFO - manifestparser == 1.1 12:34:28 INFO - mozInstall == 1.12 12:34:28 INFO - mozcrash == 1.0 12:34:28 INFO - mozdebug == 0.1 12:34:28 INFO - mozdevice == 0.48 12:34:28 INFO - mozfile == 1.2 12:34:28 INFO - mozhttpd == 0.7 12:34:28 INFO - mozinfo == 0.9 12:34:28 INFO - mozleak == 0.1 12:34:28 INFO - mozlog == 3.4 12:34:28 INFO - moznetwork == 0.27 12:34:28 INFO - mozprocess == 0.23 12:34:28 INFO - mozprofile == 0.28 12:34:28 INFO - mozrunner == 6.13 12:34:28 INFO - mozscreenshot == 0.1 12:34:28 INFO - mozsystemmonitor == 0.3 12:34:28 INFO - moztest == 0.8 12:34:28 INFO - mozversion == 1.4 12:34:28 INFO - psutil == 3.1.1 12:34:28 INFO - requests == 1.2.3 12:34:28 INFO - wsgiref == 0.1.2 12:34:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:28 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 0x7f632982af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1932ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ff60>, '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 0x1930d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19311d0>, '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': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', '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 12:34:28 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 12:34:28 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 12:34:28 INFO - Using env: {'DISPLAY': ':0', 12:34:28 INFO - 'HOME': '/home/cltbld', 12:34:28 INFO - 'LANG': 'en_US.UTF-8', 12:34:28 INFO - 'LANGUAGE': 'en_US:en', 12:34:28 INFO - 'LOGNAME': 'cltbld', 12:34:28 INFO - 'MAIL': '/var/mail/cltbld', 12:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:28 INFO - 'MOZ_NO_REMOTE': '1', 12:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:28 INFO - 'NO_EM_RESTART': '1', 12:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:28 INFO - 'PWD': '/builds/slave/test', 12:34:28 INFO - 'SHELL': '/bin/bash', 12:34:28 INFO - 'SHLVL': '1', 12:34:28 INFO - 'TERM': 'linux', 12:34:28 INFO - 'TMOUT': '86400', 12:34:28 INFO - 'USER': 'cltbld', 12:34:28 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', 12:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:28 INFO - '_': '/tools/buildbot/bin/python'} 12:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:28 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)) 12:34:28 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)) 12:34:28 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)) 12:34:28 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)) 12:34:28 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)) 12:34:28 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)) 12:34:28 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)) 12:34:28 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)) 12:34:28 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)) 12:34:28 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)) 12:34:28 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)) 12:34:28 INFO - Cleaning up... 12:34:28 INFO - Return code: 0 12:34:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:28 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 0x7f632982af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1932ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ff60>, '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 0x1930d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19311d0>, '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': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', '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 12:34:28 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 12:34:28 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 12:34:28 INFO - Using env: {'DISPLAY': ':0', 12:34:28 INFO - 'HOME': '/home/cltbld', 12:34:28 INFO - 'LANG': 'en_US.UTF-8', 12:34:28 INFO - 'LANGUAGE': 'en_US:en', 12:34:28 INFO - 'LOGNAME': 'cltbld', 12:34:28 INFO - 'MAIL': '/var/mail/cltbld', 12:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:28 INFO - 'MOZ_NO_REMOTE': '1', 12:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:28 INFO - 'NO_EM_RESTART': '1', 12:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:28 INFO - 'PWD': '/builds/slave/test', 12:34:28 INFO - 'SHELL': '/bin/bash', 12:34:28 INFO - 'SHLVL': '1', 12:34:28 INFO - 'TERM': 'linux', 12:34:28 INFO - 'TMOUT': '86400', 12:34:28 INFO - 'USER': 'cltbld', 12:34:28 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', 12:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:28 INFO - '_': '/tools/buildbot/bin/python'} 12:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:34:28 INFO - Cleaning up... 12:34:28 INFO - Return code: 0 12:34:28 INFO - Running post-action listener: _resource_record_post_action 12:34:28 INFO - Running post-action listener: _start_resource_monitoring 12:34:28 INFO - Starting resource monitoring. 12:34:28 INFO - [mozharness: 2017-02-16 20:34:28.672342Z] Finished create-virtualenv step (success) 12:34:28 INFO - [mozharness: 2017-02-16 20:34:28.672842Z] Running install step. 12:34:28 INFO - Running pre-action listener: _resource_record_pre_action 12:34:28 INFO - Running main action method: install 12:34:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:34:28 INFO - Reading from file tmpfile_stdout 12:34:28 INFO - Detecting whether we're running mozinstall >=1.0... 12:34:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:34:28 INFO - Reading from file tmpfile_stdout 12:34:28 INFO - Output received: 12:34:28 INFO - Usage: mozinstall [options] installer 12:34:28 INFO - Options: 12:34:28 INFO - -h, --help show this help message and exit 12:34:28 INFO - -d DEST, --destination=DEST 12:34:28 INFO - Directory to install application into. [default: 12:34:28 INFO - "/builds/slave/test"] 12:34:28 INFO - --app=APP Application being installed. [default: firefox] 12:34:28 INFO - mkdir: /builds/slave/test/build/application 12:34:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:34:42 INFO - Reading from file tmpfile_stdout 12:34:42 INFO - Output received: 12:34:42 INFO - /builds/slave/test/build/application/firefox/firefox 12:34:42 INFO - Running post-action listener: _resource_record_post_action 12:34:42 INFO - [mozharness: 2017-02-16 20:34:42.613999Z] Finished install step (success) 12:34:42 INFO - [mozharness: 2017-02-16 20:34:42.614240Z] Running run-tests step. 12:34:42 INFO - Running pre-action listener: _resource_record_pre_action 12:34:42 INFO - Running main action method: run_tests 12:34:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:34:42 INFO - Python 2.7.3 12:34:42 INFO - Return code: 0 12:34:42 INFO - grabbing minidump binary from tooltool 12:34:42 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')]} 12:34:42 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 0x192ff60>, '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 0x1930d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19311d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:34:42 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 12:34:42 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 12:34:42 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 12:34:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:34:42 INFO - Return code: 0 12:34:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:34:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:34:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:34:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:34:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:34:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-083 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:34:42 INFO - Using env: {'DISPLAY': ':0', 12:34:42 INFO - 'HOME': '/home/cltbld', 12:34:42 INFO - 'LANG': 'en_US.UTF-8', 12:34:42 INFO - 'LANGUAGE': 'en_US:en', 12:34:42 INFO - 'LOGNAME': 'cltbld', 12:34:42 INFO - 'MAIL': '/var/mail/cltbld', 12:34:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:34:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:42 INFO - 'MOZ_NO_REMOTE': '1', 12:34:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:34:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:42 INFO - 'NO_EM_RESTART': '1', 12:34:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:42 INFO - 'PWD': '/builds/slave/test', 12:34:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:34:42 INFO - 'SHELL': '/bin/bash', 12:34:42 INFO - 'SHLVL': '1', 12:34:42 INFO - 'TERM': 'linux', 12:34:42 INFO - 'TMOUT': '86400', 12:34:42 INFO - 'USER': 'cltbld', 12:34:42 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429', 12:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:42 INFO - '_': '/tools/buildbot/bin/python'} 12:34:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:34:42 INFO - mozversion application_buildid: 20170216105119 12:34:42 INFO - mozversion application_changeset: 820bc5bd3120853d611af1056f4a2b35528bb927 12:34:42 INFO - mozversion application_display_name: Firefox 12:34:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:34:42 INFO - mozversion application_name: Firefox 12:34:42 INFO - mozversion application_remotingname: firefox 12:34:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:34:42 INFO - mozversion application_vendor: Mozilla 12:34:42 INFO - mozversion application_version: 52.0 12:34:42 INFO - mozversion platform_buildid: 20170216105119 12:34:42 INFO - mozversion platform_changeset: 820bc5bd3120853d611af1056f4a2b35528bb927 12:34:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:34:42 INFO - mozversion platform_version: 52.0 12:34:42 INFO - using testdate: 1487277282 12:34:42 INFO - actual date: 1487277282 12:34:42 INFO - starting webserver on 'localhost:42935' 12:34:42 INFO - SUITE-START | Running 2 tests 12:34:42 INFO - TEST-START | dromaeo_css 12:34:42 INFO - operating with platform_type : linux_ 12:34:42 INFO - Initialising browser for dromaeo_css test... 12:34:42 INFO - TEST-INFO | started process 21672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_YYiEb/profile http://localhost:42935/getInfo.html) 12:34:46 INFO - PROCESS | 21672 | __metrics Screen width/height:1600/1200 12:34:46 INFO - PROCESS | 21672 | colorDepth:24 12:34:46 INFO - PROCESS | 21672 | Browser inner width/height: 1024/697 12:34:46 INFO - PROCESS | 21672 | __metrics 12:34:47 INFO - PROCESS | 21672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:34:47 INFO - PROCESS | 21672 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:34:48 INFO - TEST-INFO | 21672: exit 0 12:34:48 INFO - Browser initialized. 12:34:48 INFO - Running cycle 1/1 for dromaeo_css test... 12:34:48 INFO - TEST-INFO | started process 21764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_YYiEb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:35:00 INFO - PROCESS | 21764 | RSS: Main: 141963264 12:35:00 INFO - PROCESS | 21764 | 12:38:02 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:42935/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42935/tests/dromaeo/cssquery-ext.html) 12:38:03 INFO - PROCESS | 21764 | RSS: Main: 245800960 12:38:03 INFO - PROCESS | 21764 | 12:41:05 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:42935/tests/dromaeo/cssquery-ext.html (next: http://localhost:42935/tests/dromaeo/cssquery-jquery.html) 12:41:06 INFO - PROCESS | 21764 | RSS: Main: 238706688 12:41:06 INFO - PROCESS | 21764 | 12:44:07 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:42935/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42935/tests/dromaeo/cssquery-mootools.html) 12:44:08 INFO - PROCESS | 21764 | RSS: Main: 181940224 12:44:08 INFO - PROCESS | 21764 | 12:47:10 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:42935/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42935/tests/dromaeo/cssquery-prototype.html) 12:47:10 INFO - PROCESS | 21764 | RSS: Main: 224735232 12:47:10 INFO - PROCESS | 21764 | 12:50:13 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:42935/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42935/tests/dromaeo/cssquery-yui.html) 12:50:14 INFO - PROCESS | 21764 | RSS: Main: 176812032 12:50:14 INFO - PROCESS | 21764 | 12:53:16 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:42935/tests/dromaeo/cssquery-yui.html (next: http://localhost:42935/tests/dromaeo/cssquery-dojo.html) 12:53:16 INFO - PROCESS | 21764 | RSS: Main: 264208384 12:53:16 INFO - PROCESS | 21764 | 12:53:16 INFO - PROCESS | 21764 | __start_tp_report 12:53:16 INFO - PROCESS | 21764 | _x_x_mozilla_page_load 12:53:16 INFO - PROCESS | 21764 | _x_x_mozilla_page_load_details 12:53:16 INFO - PROCESS | 21764 | |i|pagename|runs| 12:53:16 INFO - PROCESS | 21764 | |0;dojo.html;3199.664035276296;3221.0497903118585;3221.259110404607;3243.3189030303633;3246.7402607791364;5436.619436639437;5554.444555544444;5576.721163941807;5578.079616863218;5581.609287349887;5488.1493368527845;5544.972275138629;5553.222548843165;5562.582806289524;5589.413111623282;4983.626228032903;5005.199168133099;5038.6724862883975;5061;5115.693058416488;4891.388576427947;4891.5353041461185;5043.823466178685;5088.745562721849;5090.618203634724;4892.706437613754;4905.117078925792;4916.0905232532095;4920.75396230187;4959.479254678261;4970.552650261476;4988.127077761395;5052.46949070346;5052.747362631853;5089.541941225308;4778.235482322846;4961.355023846877;4971.950280497185;4985.127602669519;5013.821751888303;5245.134552798783;5325.60057995648;5373.462653734634;5378.327709036371;5429.294191755086;5783.21926539916;5795.246617939683;5884.735186916599;5900.822975310704;5901.321348044987;5681.630694004876;5904.97047514764;5917.822465326047;5925.4370834770625;5930.229070220887;5364.249005139283;5425.945740542584;5490.615656903979;5493.587980901449;5541.5289700375915;5985.820425387245;6034.607750496291;6069.939300606938;6071.150038994544;6074.574779765462;5649.4633009864;5803;5806;5806.68063256525;5815.2149459822385;5753.769849206069;5833.854153646108;5871.588988770831;5875.618084824473;5981;5897.64614123154;5902.321233058167;5908.615939963888;5911.586188966731;5944.910826337608;5886.941130588725;5934.584579079423;5946.940530594725;5948.762049517971;5950.869334826369;4461.130079634505;4489.551044895485;4542.977285113553;4575.290829921368;4589.311603259538;4084.346504559256;4112.732672376286;4115.567865374092;4133.04939863833;4145.1295228002455;5691.004074287066;5697.173909783059;5699.629524080921;5701.258836351248;5741.311042674905;5675.659460432387;5726.455986681259;5807.709614519257;5857.648541087463;6005.159277701126;5598.468145526169;5602.831915042555;5606.579506537026;5622.550195984311;5640.041192997201;5106.514881086291;5136.948630513722;5145.4597267287145;5148.802997986668;5168.01807656544;5901.380355062743;5949.8215053548465;6070.6357618543025;6154.7230374633245;6167.4140956609945;5894.705264736832;5939.613925094855;5947.434993675594;5950.821475355746;5987.550933680079;6154.723037463235;6159.538034647329;6165.260168779775;6170.136180934583;6175.382461753788;5608.523275521627;5653.406392328746;5826.475617194473;5828.329742079545;5832.62087964281;5821.068629019336;5840.182374467493;5868.3251426086545;5894.646321220741;5928.614640048383;5658.886822263449;5776.595638305278;5795.565332600157;5798.942010580009;5802.7098645066735;5548;5759.798407055733;5771.336296325809;5772.278465191851;5772.913406298825;5526.392096869261;5689.77240910359;5706.058500347396;5727.226824378656;5830.271216097988;5874.853128671817;5885.234919460443;5887.381824908323;5888.263967004124;5895.734691938787;5501.284832971688;5558.944410555842;5606.579506537108;5679.261695979496;5726.398728133486 12:53:16 INFO - PROCESS | 21764 | |1;ext.html;580.7531798985431;610.5787006965195;639.0541997843194;652.8270008447762;665.9267480577139;33153.33693326132;43768;44814.775926120325;44907.77546112273;44976;46011.0797784045;46311.30533042007;46380.072398552096;46437.30344044833;46676.29985550211;8369.83260334793;8561.785955351104;9032.14194651507;9183.448993060438;9189.862152067724;10664.680059598224;11037.944810275978;11040.227184097117;11274.379909104997;11292.322460652387;11091.944540277287;11155.776884462306;11164;11175.776484470305;11187.272827266203;10954.890451095507;11000.449977501094;11016.06363459107;11016.834747478793;11017.338959662366;11118.555257789678;11168.944155279252;11173.49719262627;11182.944085279603;11192.44037798115;43977.78011109956;44206;44239.77880110611;44332.556674433166;44351.11297774059;3654.488371627948;3751.2872554214887;3766.1337892284655;3856.132370216707;4060.8984775380554;32194.678053219402;32431.51352729711;32614.184645384055;32627.347453050807;33834;4508.427736956864;4619.3763841881255;4628.44458664959;4652.092841895832;4719.5044520325555;241401;243669;245459;245943;246188;58816.41183588195;59725.40274597199;59738;59826.40173598295;59863;38733.612663873566;39957.60042399539;39968.60031399707;42054;42084.57915420868;18469.076546172637;18772.155253013647;18792;18792.90603547001;18801.623967520845;11448;11570.016548593296;13039.087263891626;13357.866421335857;13726.519571815139;19916.203351866054;20304.69542956857;20373.388798336073;20414.183432662823;20440.897795510926;7371.189169191384;7393.371563417169;7474.5888976106835;7512;7747.418943579254;948.8054948735493;1055.5408397347178;1112.6161474291357;1113;1158.368689064462;33346.3330733384;33592.32815343679;33607.48766305473;33758.66241337604;33940.49089263663;1133.3823066428815;1162.860456745196;1174.3775798826637;1177.4819079604947;1179.2040372748531;16144.354225830835;16960.91519542419;17007.659846802995;17010.149492525325;17085.402010929556;523407;540008;542230;544074;544360;58111.70944145337;58478.70760646169;58564.414355856745;58583.70708146432;58596.41403585995;1318.4923804335208;1384.7299776543477;1394.3934388540815;1415.6531649745673;1447.5657302809116;29070.56394154047;33732.83133584316;34161.48757768586;34271;34364.656353437145;50961.490385095676;51437.7428112857;51499;51546.22680659718;51652;407677;408632;409699;410029;411897;29647.851760741058;29682.703172967995;30766;30857;32203.194920127185;47276.52723472721;48168.518314817804;48609.756951215015;50053.24920126274;54134.72932635312;41630.58369416267;42494.36258456187;42637.5736242646;43295.56704432915;44209.778951105036;41571.37642935419;42265.366019510344;42423.3636495459;43649.78175109231;44121.11757764891;41461.79269103635;42127.36808947807;42968;42999;43003.35494967515;35200.11999700028;37149.6285037157;37717.05707357338;38192.23615527729;38279.61720382872;29258.754931741278;29444.852775735984;29575.704242957294;29672.851635741685;29704.702952970194 12:53:16 INFO - PROCESS | 21764 | |2;jquery.html;410.87057576863265;410.9753414795111;423.3945457995068;425.43842128390526;442.34312046610796;19008;19401.805981940175;20045.99770011497;20110.09504572294;20330.796692033113;19526.511837204078;19757.308494202705;20624.793752062513;20699.896500517512;20790.89604551979;5656.179853921179;5904.232449781543;5904.675242861641;5909.793157239476;5918.763249470016;5646.604737668365;5770.711464426783;5815.447532484428;5856.912146317809;5873.735681894325;5770.538356931435;5829.183914252008;5834.620749651281;5843.035899076647;5847.970760146214;5570.721463926788;5721.141828725683;5765.279340082489;5819.388964158766;5823.796167134151;5140.485951404867;5150.922736158961;5152.046871328778;5154.484551544853;5157.174852023658;23312.3006309811;23797.286081417584;24199.153029644054;24330.513389732285;24489.877550612135;2518.1312447205682;2608.5043841670213;2677.9866100669565;2740.287525243431;3169.413658473167;14872.851271487254;15053.172075535842;15112.697746045018;15339.156346400943;15614.45349412765;1974.3780709076595;1979.297349440942;1987.1653905359783;2005.2480319880044;2017.9192832286692;80170;80836;80928.59535702284;81154;82689.17310826934;10817.513211905325;11021.283616564897;11153.163512736577;11473.196876218752;11537.711557211136;16244.59388515273;16283.918580407022;16295;16298.348066077462;16300;8306.958465207756;8684.305255579538;8691.956540217385;8790.516521591373;8897.154770296811;8387.161283871686;8397.874031889527;8422.28410585095;8640.092790257058;8654.78363040929;6830.692618832065;6897.206821215625;6966.303369662993;7037.366637002694;7049.7885063448175;1982.762068551783;2043.1520918818524;2062.329742833555;2074.7614024387085;2089.861025740975;933.3000249812641;1075.6074032978063;1086.896744809242;1123.0061395664732;1126.983095253572;20084.19663213455;20213.393598192077;20292.492687682927;20573.794262057487;20707.378778636667;1020.3979652005204;1063.0591926145416;1067.6209945469402;1072.5656109275756;1100.7908497385472;10792.352458852338;11655.30068195911;11767.352795596324;11872.10959178065;11894.702632434259;447829;461566;463644;465293;468888;78225;79534;79666;81049;81796;1009.8990100989843;1017.6183931025865;1038.5638032026416;1050.5167622893555;1051.2483574244452;17383.652326953645;17896.91051544734;18260.26958921628;18323.08384580739;18544.443666690022;37155.814220928725;38243.42634860535;39383.60616393799;39496.60503395044;40857.79571102125;50652;50801;51234.23148652699;52361.47638523718;53930.19104713511;8728.258098061737;8813.471191728517;8894.42186257891;9140.177384035469;9189.816203676022;12927.482900683868;13339.866601333862;13422.932885335511;13477;13763.31183440804;10742.8388574173;11302.4913878874;11342.319460832376;11345.829812552653;11477.713057173303;11704.239224450383;11903.761924761284;12001.459934302802;12142.575009874612;12617.306048167438;8693.347998900234;11630.767384652429;12036.097292702907;12164.209326393757;12593;5294.179402192666;6963.303669632996;8566.571671416528;9008.676573252376;9178.770530736785;11434.94282528582;11940.701482463008;12000.15998880105;12088.818667720167;12308.753824923631 12:53:16 INFO - PROCESS | 21764 | |3;mootools.html;1431.2986636548094;1516.0827699241959;1548.798656174697;1671.6238846259594;1801.8108098649634;7638.541687498747;8587.441816281946;8809.339299552543;8820.338474614413;9023;8877.245434138105;8937.10628937106;8939.240164586;8951.731448056553;8976.237019853304;2432.20953190213;2462.2982450001755;2462.4336402627405;2462.889169987346;2463.2363967170236;2439.48770758141;2535.771780539751;2541.0217066429464;2542.186500319898;2542.7838633716156;2462.0398044762555;2465.6055031194924;2508;2510.309664842174;2512.1835403493847;2407.07327678844;2408.145108486497;2430.3438071720625;2435.281591930385;2446.1316232737477;2410.192585483865;2429.5748244057218;2454.5459090068216;2456.6437866509254;2463.519613675334;8471.915280847174;8869.645214191425;8949.64201431942;9002;9095.272378209727;5123.615728820316;5322.627416080876;5330.493603107699;5336.733163341817;5339.41266460689;3322.96677033229;3468.1676397664633;3531.1878267998504;3535.4166562517153;3615.8734444294587;1156.0866915137115;1172.0974849366025;1172.7419967607113;1178.4696886401155;1207.0946789907568;11840.348780817052;11878;11891.524339026428;11921.165518413714;11935.820962685653;4236;4495.685302028826;4583.587477127075;4599.6090332321455;4619.145458090264;9948.651797187063;9971.601135954481;9973.351732137387;9982.650607228712;9987.60049598008;5332.360116785933;5333.919991200135;5335;5354.946450535523;5357.5446087082255;4229.730469080295;4424.6239069678795;4532.161550113239;4546.204414227497;4985.501449855058;3890.591487893787;3897.8830635080994;4044.312466880637;4053.61490658387;4057.1479989202007;1182.804837201852;1189.3755778216505;1193.4987305331608;1202.5430336472084;1205.0419916166668;921.8064206516573;932.9533523323806;935.2891802230218;940.2431043010306;945.8912225094065;5732.59231122921;5868.354481007086;5910.527157827363;5979.4618484336615;6204.503639708812;466.5467070076754;476.7425590181263;996.3125443444001;999.4253304350028;1018.8064267789097;3902.6487616114687;4058.1072164123843;4069.2268468990796;4090.550039495653;4134.049168691218;10137.797244055078;10772.353658780341;10842.728931776768;10865.40240286776;10931.344119352865;10476.790464190673;10732.517036733365;10735.570577176826;10830.458477076114;10851.78296434067;8252.21603947624;8356.540390278471;8376.162383761575;8376.916230837736;8385.119562445978;6112.786052488142;6115.266168059861;6128.571000029955;6130.816075517741;6171.59884607499;9874.851877221703;9908.572399762104;9966.651167209113;10005.499725013866;10182.745431364276;9076.682316118904;9366.812663746823;10340.172786177238;10361.11930485887;10390.064894159563;7125.786226413215;7226.89159662616;7320.267973202637;7391.445641577011;7465.589392583242;8300.626471808662;8366.079731229682;8411.789705257417;8415.579221039046;8460.196281353261;7518.849623007619;7626.199249078989;7691.346235569816;7747.147813740371;7843.764687059169;7350.485466017328;7379.077615298088;7443.106827180773;7788;7813.804654883674;6996.335348141918;7059.329363710439;7059.647017649199;7065.894011589728;7067.57594544329;4988.8752781180765;5149.9227511586605;5164.612654051037;5222.321098257355;5415.539679127318;5195.5843532518065;5206.505381988705;5270.841874743764;5321.3880403754065;5457.672539647634 12:53:16 INFO - PROCESS | 21764 | |4;prototype.html;338.8034939734954;341.2288228603356;350.67036985233887;359.66551107470076;361.50112844274895;5275.393329767073;5346.492083252089;5424.294841670587;5441.156620723784;5488.588355873306;5330.3603567571945;5342.171963345678;5344.22508736233;5350.250964864912;5352.678839269646;4020.9597904021025;4243.6605071594195;4254.127903779733;4257.44653195085;4269.420314483646;3792;4107.67138628909;4111.813344657884;4194.664426845845;4202.117555313388;4164.1879833432495;4164.68764842638;4168.416421700964;4172.791360431981;4175.832966681329;4160.396742472324;4181.038361176916;4181.417807227355;4183.518895327046;4199.4750656168135;3635.1820840310984;3681.4661874028116;3708.332500149972;3716.201016781378;3734.458503516975;5148.845534633967;5153.768080436389;5157.8452646420665;5170.663906846043;5178.659764451945;4766.928496072562;4782.784774685113;4786.664933454659;4807.423109226916;4813.278008298783;5446.891062178774;5561.555075593943;5572.637778544382;5588.86027849307;5592.636478628876;4096.283150448659;4102.528209255914;4102.815373308208;4104.897377565555;4109.815058322382;5529.668219906778;5695.886082278331;5818.5345172386105;5845.766169353264;5856.121581762727;3897.6881849451975;4055.5741647127215;4056.3915412687743;4153.563875792998;4199.790010499524;4234.830606775695;4247.5964783345535;4250.171216612731;4250.42619246404;4252.532221455637;4631.726275274326;4797.40032495938;4799.18413869643;4800.855974320776;4810.254410566367;5598.664080155204;5605.971970140205;5607.299087614048;5619.297587801525;5642.633228840113;1405.894557908161;1406.4444544404903;1407.5495841330676;1412.6892083741561;1430.9427622894968;937.8218138553653;965.2181732796317;974.1427543761445;977.3158788847835;995.7908839143716;5210.5831533477985;5243.239730239094;5245.26566280721;5267.78928842842;5282.656627319212;5544.306961629796;5545;5563.833085007456;5566.387697353288;5568.331800184003;5094.592432605383;5221.686698798084;5246.23929530216;5275.129603615361;5276.841694749163;2952.660444048919;2956.541736030919;2963.185124090849;2970.2722832905642;2975.137210209015;5752.971235143881;5760.711964401763;5762.567807414461;5785.942140578624;5798.797042103506;5427.213054107211;5519.9448005520235;5629.831105066854;5652.9152062719095;5655.688937108416;5743.8851222976145;5766.769329226868;5784.363719990798;5793.362730099601;5800.390958949334;5454.809081682122;5532.585056120887;5564.805231816867;5581.972090139523;5742.827715168552;5740.1963725077685;5759.856003599776;5764.164196191613;5769.798057067983;5782.363939966516;5750.482456578928;5888.586739182651;5895.850309189666;5909.231799866162;6055.666938318434;3934.409838524244;4114.526829414655;4172.269852775691;4176.498820141603;4189.874303770892;5654;5752.942470575408;5760.308762948473;5760.683162426107;5768.625039372428;5594.4125866785025;5624.1035866527955;5635.577331700057;5642.322921249476;5642.802501912413;5556.472135147154;5571.415001424954;5610.831675049755;5612.971935140298;5631.000994647005;5426.321709786277;5525.889482210414;5558.3602837162325;5559.44405559457;5568.777248909998;5565.693886836263;5606.747696353756;5623.578231632562;5636.774529018793;5661.584603849038;5473.781048758005;5487.506124448819;5509.311336082989;5511.311086114236;5535.169724541351 12:53:16 INFO - PROCESS | 21764 | |5;yui.html;802.9277365037145;808.4074373484236;828.892244008279;856.1053698884665;868.856638654622;14783.113013219201;16117;16168.434104806334;16190.271437785299;16206.432774852898;14466.49367272143;14729.337179826907;14757.745591624698;14758.704825903476;14763.409463621443;731.1043971135343;748.1657951384221;833.5998720614109;850.7660393391805;856.9528675922821;867.5792240763225;869.7477731457869;869.7825543614097;869.8956125264978;871.7646235516406;917.7063339731288;918.4902379179553;918.6968300460832;919.204887772079;919.4391421233042;913.5158366065963;915.601713254733;916.2349438219095;916.3539704508372;917.3945196170496;674.9865002699968;675.7567275780715;675.7668604331546;675.8175292670951;676.5906626490952;14364.281785910664;14619.26903654813;14641.121532707964;14642.267886605734;15436.922815385851;14444;14830.406783728638;14931.925340373336;15273;15333.463328783439;11872.465739041763;12016.339101349422;12022.51909923602;12081.033517318594;12172.756544869053;3899.629535194152;3994.9201015979806;4040.7575545467366;4047.7166598337835;4073.7963101845085;61131.69434152801;61922;62303.37696623021;62576.68711656458;62861;11533.192676512732;11567.710807229718;11615.883841161649;11655.358955257543;11771.352575608253;21116.155353785984;21119;21213.469663258235;21287.148514059263;21303.573928521342;8231.670733170726;8233.670653173805;8258.504489730636;8359.958200209081;8417.64507889996;4463.152001119777;4576.405067341224;4635.420572428447;4643.558861908114;4708.952910470852;3292.506124081359;3359.412102881986;3389.084947064328;3404.7786893852317;3424.9486257706153;572.3589579670795;575.2665351676645;588.3469349022581;589.6226415094343;591.4972273567433;604.8941435248814;661.7088481068314;737.9631018449056;755.1655420759981;764.8279137194198;9270.860937085949;9438.575264112995;9571.330006899589;9762.633231347618;9881.715377001088;545.939946605873;554.7780887644893;593.9732712027969;598.1476396135489;627.1001113402282;4456.799444025027;4517.706349087299;4543.34121552373;4551.362809206714;4686.226772582554;55663.72168139214;86870;87494.1250587486;90919;92733;75385.62307188429;76179.61910190413;76663.23336766672;76684.61657691676;76713;70670;73483.63258183675;73770;74346;76099.61950190214;8749.75636816131;8888.866666999871;8973.641054357753;9014.608339382881;9020.368574199743;46597;47454.288185677935;48063.279050813566;48394.51605484041;48896;40102.19795604013;40377.1924561513;41431.7928410356;48257.51742482671;63895.680521597096;12024.268620316789;12084.45619947087;12141.939290303491;12203.633890983285;12351.135420520477;12990.935045324713;13115;13180.406881690154;13354.532591359255;13964.79052814229;11916.52333906634;12077.154599178324;12221.144519883523;12458.377081146087;12689.111762176928;12420.378981050731;12493.687657808627;12769.74460510766;13154.21074735519;13190.868091318964;11798.233114847508;11979.28124312544;12241;12430.502779888704;12717.173383730027;9511.429314241168;10201.74495637615;10241.180705543688;10263.332883362558;10295.897041029793;11581.826272606086;11731.790827457016;11784.941075294568;11802.704932376415;12302.876971230173 12:53:16 INFO - PROCESS | 21764 | __end_tp_report 12:53:16 INFO - PROCESS | 21764 | __start_cc_report 12:53:16 INFO - PROCESS | 21764 | _x_x_mozilla_cycle_collect,1094 12:53:16 INFO - PROCESS | 21764 | __end_cc_report 12:53:16 INFO - PROCESS | 21764 | __startTimestamp1487278396817__endTimestamp 12:53:16 INFO - PROCESS | 21764 | 12:53:16 INFO - PROCESS | 21764 | ------- Summary: start ------- 12:53:16 INFO - PROCESS | 21764 | Number of tests: 6 12:53:16 INFO - PROCESS | 21764 | 12:53:16 INFO - PROCESS | 21764 | [#0] dojo.html Cycles:165 Average:5476.27 Median:5689.77 stddev:613.68 (10.8%) stddev-sans-first:589.00 12:53:16 INFO - PROCESS | 21764 | Values: 3199.7 3221.0 3221.3 3243.3 3246.7 5436.6 5554.4 5576.7 5578.1 5581.6 5488.1 5545.0 5553.2 5562.6 5589.4 4983.6 5005.2 5038.7 5061.0 5115.7 4891.4 4891.5 5043.8 5088.7 5090.6 4892.7 4905.1 4916.1 4920.8 4959.5 4970.6 4988.1 5052.5 5052.7 5089.5 4778.2 4961.4 4972.0 4985.1 5013.8 5245.1 5325.6 5373.5 5378.3 5429.3 5783.2 5795.2 5884.7 5900.8 5901.3 5681.6 5905.0 5917.8 5925.4 5930.2 5364.2 5425.9 5490.6 5493.6 5541.5 5985.8 6034.6 6069.9 6071.2 6074.6 5649.5 5803.0 5806.0 5806.7 5815.2 5753.8 5833.9 5871.6 5875.6 5981.0 5897.6 5902.3 5908.6 5911.6 5944.9 5886.9 5934.6 5946.9 5948.8 5950.9 4461.1 4489.6 4543.0 4575.3 4589.3 4084.3 4112.7 4115.6 4133.0 4145.1 5691.0 5697.2 5699.6 5701.3 5741.3 5675.7 5726.5 5807.7 5857.6 6005.2 5598.5 5602.8 5606.6 5622.6 5640.0 5106.5 5136.9 5145.5 5148.8 5168.0 5901.4 5949.8 6070.6 6154.7 6167.4 5894.7 5939.6 5947.4 5950.8 5987.6 6154.7 6159.5 6165.3 6170.1 6175.4 5608.5 5653.4 5826.5 5828.3 5832.6 5821.1 5840.2 5868.3 5894.6 5928.6 5658.9 5776.6 5795.6 5798.9 5802.7 5548.0 5759.8 5771.3 5772.3 5772.9 5526.4 5689.8 5706.1 5727.2 5830.3 5874.9 5885.2 5887.4 5888.3 5895.7 5501.3 5558.9 5606.6 5679.3 5726.4 12:53:16 INFO - PROCESS | 21764 | 12:53:16 INFO - PROCESS | 21764 | [#1] ext.html Cycles:180 Average:57017.49 Median:37954.65 stddev:110157.76 (290.2%) stddev-sans-first:110385.28 12:53:16 INFO - PROCESS | 21764 | Values: 580.8 610.6 639.1 652.8 665.9 33153.3 43768.0 44814.8 44907.8 44976.0 46011.1 46311.3 46380.1 46437.3 46676.3 8369.8 8561.8 9032.1 9183.4 9189.9 10664.7 11037.9 11040.2 11274.4 11292.3 11091.9 11155.8 11164.0 11175.8 11187.3 10954.9 11000.4 11016.1 11016.8 11017.3 11118.6 11168.9 11173.5 11182.9 11192.4 43977.8 44206.0 44239.8 44332.6 44351.1 3654.5 3751.3 3766.1 3856.1 4060.9 32194.7 32431.5 32614.2 32627.3 33834.0 4508.4 4619.4 4628.4 4652.1 4719.5 241401.0 243669.0 245459.0 245943.0 246188.0 58816.4 59725.4 59738.0 59826.4 59863.0 38733.6 39957.6 39968.6 42054.0 42084.6 18469.1 18772.2 18792.0 18792.9 18801.6 11448.0 11570.0 13039.1 13357.9 13726.5 19916.2 20304.7 20373.4 20414.2 20440.9 7371.2 7393.4 7474.6 7512.0 7747.4 948.8 1055.5 1112.6 1113.0 1158.4 33346.3 33592.3 33607.5 33758.7 33940.5 1133.4 1162.9 1174.4 1177.5 1179.2 16144.4 16960.9 17007.7 17010.1 17085.4 523407.0 540008.0 542230.0 544074.0 544360.0 58111.7 58478.7 58564.4 58583.7 58596.4 1318.5 1384.7 1394.4 1415.7 1447.6 29070.6 33732.8 34161.5 34271.0 34364.7 50961.5 51437.7 51499.0 51546.2 51652.0 407677.0 408632.0 409699.0 410029.0 411897.0 29647.9 29682.7 30766.0 30857.0 32203.2 47276.5 48168.5 48609.8 50053.2 54134.7 41630.6 42494.4 42637.6 43295.6 44209.8 41571.4 42265.4 42423.4 43649.8 44121.1 41461.8 42127.4 42968.0 42999.0 43003.4 35200.1 37149.6 37717.1 38192.2 38279.6 29258.8 29444.9 29575.7 29672.9 29704.7 12:53:16 INFO - PROCESS | 21764 | 12:53:16 INFO - PROCESS | 21764 | [#2] jquery.html Cycles:180 Average:28055.79 Median:24264.83 stddev:75852.36 (312.6%) stddev-sans-first:76036.74 12:53:16 INFO - PROCESS | 21764 | Values: 410.9 411.0 423.4 425.4 442.3 19008.0 19401.8 20046.0 20110.1 20330.8 19526.5 19757.3 20624.8 20699.9 20790.9 5656.2 5904.2 5904.7 5909.8 5918.8 5646.6 5770.7 5815.4 5856.9 5873.7 5770.5 5829.2 5834.6 5843.0 5848.0 5570.7 5721.1 5765.3 5819.4 5823.8 5140.5 5150.9 5152.0 5154.5 5157.2 23312.3 23797.3 24199.2 24330.5 24489.9 2518.1 2608.5 2678.0 2740.3 3169.4 14872.9 15053.2 15112.7 15339.2 15614.5 1974.4 1979.3 1987.2 2005.2 2017.9 80170.0 80836.0 80928.6 81154.0 82689.2 10817.5 11021.3 11153.2 11473.2 11537.7 16244.6 16283.9 16295.0 16298.3 16300.0 8307.0 8684.3 8692.0 8790.5 8897.2 8387.2 8397.9 8422.3 8640.1 8654.8 6830.7 6897.2 6966.3 7037.4 7049.8 1982.8 2043.2 2062.3 2074.8 2089.9 933.3 1075.6 1086.9 1123.0 1127.0 20084.2 20213.4 20292.5 20573.8 20707.4 1020.4 1063.1 1067.6 1072.6 1100.8 10792.4 11655.3 11767.4 11872.1 11894.7 447829.0 461566.0 463644.0 465293.0 468888.0 78225.0 79534.0 79666.0 81049.0 81796.0 1009.9 1017.6 1038.6 1050.5 1051.2 17383.7 17896.9 18260.3 18323.1 18544.4 37155.8 38243.4 39383.6 39496.6 40857.8 50652.0 50801.0 51234.2 52361.5 53930.2 8728.3 8813.5 8894.4 9140.2 9189.8 12927.5 13339.9 13422.9 13477.0 13763.3 10742.8 11302.5 11342.3 11345.8 11477.7 11704.2 11903.8 12001.5 12142.6 12617.3 8693.3 11630.8 12036.1 12164.2 12593.0 5294.2 6963.3 8566.6 9008.7 9178.8 11434.9 11940.7 12000.2 12088.8 12308.8 12:53:16 INFO - PROCESS | 21764 | 12:53:16 INFO - PROCESS | 21764 | [#3] mootools.html Cycles:180 Average:5769.98 Median:5157.27 stddev:3213.59 (62.3%) stddev-sans-first:3206.07 12:53:16 INFO - PROCESS | 21764 | Values: 1431.3 1516.1 1548.8 1671.6 1801.8 7638.5 8587.4 8809.3 8820.3 9023.0 8877.2 8937.1 8939.2 8951.7 8976.2 2432.2 2462.3 2462.4 2462.9 2463.2 2439.5 2535.8 2541.0 2542.2 2542.8 2462.0 2465.6 2508.0 2510.3 2512.2 2407.1 2408.1 2430.3 2435.3 2446.1 2410.2 2429.6 2454.5 2456.6 2463.5 8471.9 8869.6 8949.6 9002.0 9095.3 5123.6 5322.6 5330.5 5336.7 5339.4 3323.0 3468.2 3531.2 3535.4 3615.9 1156.1 1172.1 1172.7 1178.5 1207.1 11840.3 11878.0 11891.5 11921.2 11935.8 4236.0 4495.7 4583.6 4599.6 4619.1 9948.7 9971.6 9973.4 9982.7 9987.6 5332.4 5333.9 5335.0 5354.9 5357.5 4229.7 4424.6 4532.2 4546.2 4985.5 3890.6 3897.9 4044.3 4053.6 4057.1 1182.8 1189.4 1193.5 1202.5 1205.0 921.8 933.0 935.3 940.2 945.9 5732.6 5868.4 5910.5 5979.5 6204.5 466.5 476.7 996.3 999.4 1018.8 3902.6 4058.1 4069.2 4090.6 4134.0 10137.8 10772.4 10842.7 10865.4 10931.3 10476.8 10732.5 10735.6 10830.5 10851.8 8252.2 8356.5 8376.2 8376.9 8385.1 6112.8 6115.3 6128.6 6130.8 6171.6 9874.9 9908.6 9966.7 10005.5 10182.7 9076.7 9366.8 10340.2 10361.1 10390.1 7125.8 7226.9 7320.3 7391.4 7465.6 8300.6 8366.1 8411.8 8415.6 8460.2 7518.8 7626.2 7691.3 7747.1 7843.8 7350.5 7379.1 7443.1 7788.0 7813.8 6996.3 7059.3 7059.6 7065.9 7067.6 4988.9 5149.9 5164.6 5222.3 5415.5 5195.6 5206.5 5270.8 5321.4 5457.7 12:53:16 INFO - PROCESS | 21764 | 12:53:16 INFO - PROCESS | 21764 | [#4] prototype.html Cycles:180 Average:4693.34 Median:5351.46 stddev:1364.85 (25.5%) stddev-sans-first:1328.97 12:53:16 INFO - PROCESS | 21764 | Values: 338.8 341.2 350.7 359.7 361.5 5275.4 5346.5 5424.3 5441.2 5488.6 5330.4 5342.2 5344.2 5350.3 5352.7 4021.0 4243.7 4254.1 4257.4 4269.4 3792.0 4107.7 4111.8 4194.7 4202.1 4164.2 4164.7 4168.4 4172.8 4175.8 4160.4 4181.0 4181.4 4183.5 4199.5 3635.2 3681.5 3708.3 3716.2 3734.5 5148.8 5153.8 5157.8 5170.7 5178.7 4766.9 4782.8 4786.7 4807.4 4813.3 5446.9 5561.6 5572.6 5588.9 5592.6 4096.3 4102.5 4102.8 4104.9 4109.8 5529.7 5695.9 5818.5 5845.8 5856.1 3897.7 4055.6 4056.4 4153.6 4199.8 4234.8 4247.6 4250.2 4250.4 4252.5 4631.7 4797.4 4799.2 4800.9 4810.3 5598.7 5606.0 5607.3 5619.3 5642.6 1405.9 1406.4 1407.5 1412.7 1430.9 937.8 965.2 974.1 977.3 995.8 5210.6 5243.2 5245.3 5267.8 5282.7 5544.3 5545.0 5563.8 5566.4 5568.3 5094.6 5221.7 5246.2 5275.1 5276.8 2952.7 2956.5 2963.2 2970.3 2975.1 5753.0 5760.7 5762.6 5785.9 5798.8 5427.2 5519.9 5629.8 5652.9 5655.7 5743.9 5766.8 5784.4 5793.4 5800.4 5454.8 5532.6 5564.8 5582.0 5742.8 5740.2 5759.9 5764.2 5769.8 5782.4 5750.5 5888.6 5895.9 5909.2 6055.7 3934.4 4114.5 4172.3 4176.5 4189.9 5654.0 5752.9 5760.3 5760.7 5768.6 5594.4 5624.1 5635.6 5642.3 5642.8 5556.5 5571.4 5610.8 5613.0 5631.0 5426.3 5525.9 5558.4 5559.4 5568.8 5565.7 5606.7 5623.6 5636.8 5661.6 5473.8 5487.5 5509.3 5511.3 5535.2 12:53:16 INFO - PROCESS | 21764 | 12:53:16 INFO - PROCESS | 21764 | [#5] yui.html Cycles:180 Average:17492.57 Median:25641.61 stddev:22850.48 (89.1%) stddev-sans-first:22880.21 12:53:16 INFO - PROCESS | 21764 | Values: 802.9 808.4 828.9 856.1 868.9 14783.1 16117.0 16168.4 16190.3 16206.4 14466.5 14729.3 14757.7 14758.7 14763.4 731.1 748.2 833.6 850.8 857.0 867.6 869.7 869.8 869.9 871.8 917.7 918.5 918.7 919.2 919.4 913.5 915.6 916.2 916.4 917.4 675.0 675.8 675.8 675.8 676.6 14364.3 14619.3 14641.1 14642.3 15436.9 14444.0 14830.4 14931.9 15273.0 15333.5 11872.5 12016.3 12022.5 12081.0 12172.8 3899.6 3994.9 4040.8 4047.7 4073.8 61131.7 61922.0 62303.4 62576.7 62861.0 11533.2 11567.7 11615.9 11655.4 11771.4 21116.2 21119.0 21213.5 21287.1 21303.6 8231.7 8233.7 8258.5 8360.0 8417.6 4463.2 4576.4 4635.4 4643.6 4709.0 3292.5 3359.4 3389.1 3404.8 3424.9 572.4 575.3 588.3 589.6 591.5 604.9 661.7 738.0 755.2 764.8 9270.9 9438.6 9571.3 9762.6 9881.7 545.9 554.8 594.0 598.1 627.1 4456.8 4517.7 4543.3 4551.4 4686.2 55663.7 86870.0 87494.1 90919.0 92733.0 75385.6 76179.6 76663.2 76684.6 76713.0 70670.0 73483.6 73770.0 74346.0 76099.6 8749.8 8888.9 8973.6 9014.6 9020.4 46597.0 47454.3 48063.3 48394.5 48896.0 40102.2 40377.2 41431.8 48257.5 63895.7 12024.3 12084.5 12141.9 12203.6 12351.1 12990.9 13115.0 13180.4 13354.5 13964.8 11916.5 12077.2 12221.1 12458.4 12689.1 12420.4 12493.7 12769.7 13154.2 13190.9 11798.2 11979.3 12241.0 12430.5 12717.2 9511.4 10201.7 10241.2 10263.3 10295.9 11581.8 11731.8 11784.9 11802.7 12302.9 12:53:16 INFO - PROCESS | 21764 | -------- Summary: end -------- 12:53:16 INFO - PROCESS | 21764 | 12:53:17 INFO - TEST-INFO | 21764: exit 0 12:53:17 INFO - TEST-OK | dromaeo_css | took 1114650ms 12:53:17 INFO - TEST-START | kraken 12:53:17 INFO - operating with platform_type : linux_ 12:53:17 INFO - Initialising browser for kraken test... 12:53:17 INFO - TEST-INFO | started process 22072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMQg8GY/profile http://localhost:42935/getInfo.html) 12:53:21 INFO - PROCESS | 22072 | __metrics Screen width/height:1600/1200 12:53:21 INFO - PROCESS | 22072 | colorDepth:24 12:53:21 INFO - PROCESS | 22072 | Browser inner width/height: 1024/697 12:53:21 INFO - PROCESS | 22072 | __metrics 12:53:22 INFO - PROCESS | 22072 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:53:22 INFO - PROCESS | 22072 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:53:23 INFO - TEST-INFO | 22072: exit 0 12:53:23 INFO - Browser initialized. 12:53:23 INFO - Running cycle 1/1 for kraken test... 12:53:23 INFO - TEST-INFO | started process 22165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMQg8GY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:53:35 INFO - PROCESS | 22165 | RSS: Main: 142192640 12:53:35 INFO - PROCESS | 22165 | 12:53:37 INFO - PROCESS | 22165 | Cycle 1(1): loaded http://localhost:42935/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42935/tests/kraken/driver.html?testName=audio-beat-detection) 12:53:38 INFO - PROCESS | 22165 | RSS: Main: 183889920 12:53:38 INFO - PROCESS | 22165 | 12:53:40 INFO - PROCESS | 22165 | Cycle 1(1): loaded http://localhost:42935/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42935/tests/kraken/driver.html?testName=audio-dft) 12:53:41 INFO - PROCESS | 22165 | RSS: Main: 173817856 12:53:41 INFO - PROCESS | 22165 | 12:53:44 INFO - PROCESS | 22165 | Cycle 1(1): loaded http://localhost:42935/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42935/tests/kraken/driver.html?testName=audio-fft) 12:53:44 INFO - PROCESS | 22165 | RSS: Main: 264855552 12:53:44 INFO - PROCESS | 22165 | 12:53:46 INFO - PROCESS | 22165 | Cycle 1(1): loaded http://localhost:42935/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42935/tests/kraken/driver.html?testName=audio-oscillator) 12:53:47 INFO - PROCESS | 22165 | RSS: Main: 171732992 12:53:47 INFO - PROCESS | 22165 | 12:53:49 INFO - PROCESS | 22165 | Cycle 1(1): loaded http://localhost:42935/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42935/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:53:50 INFO - PROCESS | 22165 | RSS: Main: 173965312 12:53:50 INFO - PROCESS | 22165 | 12:53:53 INFO - PROCESS | 22165 | Cycle 1(1): loaded http://localhost:42935/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42935/tests/kraken/driver.html?testName=imaging-darkroom) 12:53:53 INFO - PROCESS | 22165 | RSS: Main: 213409792 12:53:53 INFO - PROCESS | 22165 | 12:53:57 INFO - PROCESS | 22165 | Cycle 1(1): loaded http://localhost:42935/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42935/tests/kraken/driver.html?testName=imaging-desaturate) 12:53:57 INFO - PROCESS | 22165 | RSS: Main: 211263488 12:53:57 INFO - PROCESS | 22165 | 12:54:00 INFO - PROCESS | 22165 | Cycle 1(1): loaded http://localhost:42935/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42935/tests/kraken/driver.html?testName=json-parse-financial) 12:54:00 INFO - PROCESS | 22165 | RSS: Main: 210288640 12:54:00 INFO - PROCESS | 22165 | 12:54:02 INFO - PROCESS | 22165 | Cycle 1(1): loaded http://localhost:42935/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42935/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:54:02 INFO - PROCESS | 22165 | RSS: Main: 172711936 12:54:02 INFO - PROCESS | 22165 | 12:54:04 INFO - PROCESS | 22165 | Cycle 1(1): loaded http://localhost:42935/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42935/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:54:05 INFO - PROCESS | 22165 | RSS: Main: 179687424 12:54:05 INFO - PROCESS | 22165 | 12:54:07 INFO - PROCESS | 22165 | Cycle 1(1): loaded http://localhost:42935/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42935/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:54:07 INFO - PROCESS | 22165 | RSS: Main: 189321216 12:54:07 INFO - PROCESS | 22165 | 12:54:10 INFO - PROCESS | 22165 | Cycle 1(1): loaded http://localhost:42935/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:54:11 INFO - PROCESS | 22165 | RSS: Main: 197099520 12:54:11 INFO - PROCESS | 22165 | 12:54:13 INFO - PROCESS | 22165 | Cycle 1(1): loaded http://localhost:42935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:54:14 INFO - PROCESS | 22165 | RSS: Main: 193875968 12:54:14 INFO - PROCESS | 22165 | 12:54:16 INFO - PROCESS | 22165 | Cycle 1(1): loaded http://localhost:42935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42935/tests/kraken/driver.html?testName=ai-astar) 12:54:16 INFO - PROCESS | 22165 | RSS: Main: 245338112 12:54:16 INFO - PROCESS | 22165 | 12:54:16 INFO - PROCESS | 22165 | __start_tp_report 12:54:16 INFO - PROCESS | 22165 | _x_x_mozilla_page_load 12:54:16 INFO - PROCESS | 22165 | _x_x_mozilla_page_load_details 12:54:16 INFO - PROCESS | 22165 | |i|pagename|runs| 12:54:16 INFO - PROCESS | 22165 | |0;ai-astar;101;112;111;109;112;113;111;111;112;111 12:54:16 INFO - PROCESS | 22165 | |1;audio-beat-detection;143;125;124;156;118;119;120;121;168;116 12:54:16 INFO - PROCESS | 22165 | |2;audio-dft;160;160;162;160;161;160;160;161;160;161 12:54:16 INFO - PROCESS | 22165 | |3;audio-fft;74;75;74;107;76;75;76;76;116;76 12:54:16 INFO - PROCESS | 22165 | |4;audio-oscillator;82;80;129;82;82;81;103;81;81;113 12:54:16 INFO - PROCESS | 22165 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;116;116 12:54:16 INFO - PROCESS | 22165 | |6;imaging-darkroom;148;146;146;146;147;146;145;146;147;145 12:54:16 INFO - PROCESS | 22165 | |7;imaging-desaturate;85;85;84;84;85;84;85;84;85;85 12:54:16 INFO - PROCESS | 22165 | |8;json-parse-financial;51;51;52;52;52;53;52;54;51;51 12:54:16 INFO - PROCESS | 22165 | |9;json-stringify-tinderbox;58;60;59;59;59;59;58;58;59;58 12:54:16 INFO - PROCESS | 22165 | |10;stanford-crypto-aes;77;80;74;75;75;78;75;75;80;74 12:54:16 INFO - PROCESS | 22165 | |11;stanford-crypto-ccm;121;130;133;133;122;123;120;130;163;127 12:54:16 INFO - PROCESS | 22165 | |12;stanford-crypto-pbkdf2;157;160;158;157;157;159;169;164;160;160 12:54:16 INFO - PROCESS | 22165 | |13;stanford-crypto-sha256-iterative;68;65;64;62;64;63;63;65;62;62 12:54:16 INFO - PROCESS | 22165 | __end_tp_report 12:54:16 INFO - PROCESS | 22165 | __start_cc_report 12:54:16 INFO - PROCESS | 22165 | _x_x_mozilla_cycle_collect,1575 12:54:16 INFO - PROCESS | 22165 | __end_cc_report 12:54:16 INFO - PROCESS | 22165 | __startTimestamp1487278456284__endTimestamp 12:54:16 INFO - PROCESS | 22165 | 12:54:16 INFO - PROCESS | 22165 | ------- Summary: start ------- 12:54:16 INFO - PROCESS | 22165 | Number of tests: 14 12:54:16 INFO - PROCESS | 22165 | 12:54:16 INFO - PROCESS | 22165 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.43 (3.1%) stddev-sans-first:1.12 12:54:16 INFO - PROCESS | 22165 | Values: 101.0 112.0 111.0 109.0 112.0 113.0 111.0 111.0 112.0 111.0 12:54:16 INFO - PROCESS | 22165 | 12:54:16 INFO - PROCESS | 22165 | [#1] audio-beat-detection Cycles:10 Average:131.00 Median:124.50 stddev:18.20 (14.6%) stddev-sans-first:18.78 12:54:16 INFO - PROCESS | 22165 | Values: 143.0 125.0 124.0 156.0 118.0 119.0 120.0 121.0 168.0 116.0 12:54:16 INFO - PROCESS | 22165 | 12:54:16 INFO - PROCESS | 22165 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 12:54:16 INFO - PROCESS | 22165 | Values: 160.0 160.0 162.0 160.0 161.0 160.0 160.0 161.0 160.0 161.0 12:54:16 INFO - PROCESS | 22165 | 12:54:16 INFO - PROCESS | 22165 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.50 stddev:15.45 (20.5%) stddev-sans-first:16.08 12:54:16 INFO - PROCESS | 22165 | Values: 74.0 75.0 74.0 107.0 76.0 75.0 76.0 76.0 116.0 76.0 12:54:16 INFO - PROCESS | 22165 | 12:54:16 INFO - PROCESS | 22165 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:81.00 stddev:17.43 (21.5%) stddev-sans-first:18.15 12:54:16 INFO - PROCESS | 22165 | Values: 82.0 80.0 129.0 82.0 82.0 81.0 103.0 81.0 81.0 113.0 12:54:16 INFO - PROCESS | 22165 | 12:54:16 INFO - PROCESS | 22165 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 12:54:16 INFO - PROCESS | 22165 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 12:54:16 INFO - PROCESS | 22165 | 12:54:16 INFO - PROCESS | 22165 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 12:54:16 INFO - PROCESS | 22165 | Values: 148.0 146.0 146.0 146.0 147.0 146.0 145.0 146.0 147.0 145.0 12:54:16 INFO - PROCESS | 22165 | 12:54:16 INFO - PROCESS | 22165 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 12:54:16 INFO - PROCESS | 22165 | Values: 85.0 85.0 84.0 84.0 85.0 84.0 85.0 84.0 85.0 85.0 12:54:16 INFO - PROCESS | 22165 | 12:54:16 INFO - PROCESS | 22165 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.99 (1.9%) stddev-sans-first:1.00 12:54:16 INFO - PROCESS | 22165 | Values: 51.0 51.0 52.0 52.0 52.0 53.0 52.0 54.0 51.0 51.0 12:54:16 INFO - PROCESS | 22165 | 12:54:16 INFO - PROCESS | 22165 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 12:54:16 INFO - PROCESS | 22165 | Values: 58.0 60.0 59.0 59.0 59.0 59.0 58.0 58.0 59.0 58.0 12:54:16 INFO - PROCESS | 22165 | 12:54:16 INFO - PROCESS | 22165 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:2.31 (3.0%) stddev-sans-first:2.44 12:54:16 INFO - PROCESS | 22165 | Values: 77.0 80.0 74.0 75.0 75.0 78.0 75.0 75.0 80.0 74.0 12:54:16 INFO - PROCESS | 22165 | 12:54:16 INFO - PROCESS | 22165 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:130.00 stddev:12.51 (9.6%) stddev-sans-first:12.82 12:54:16 INFO - PROCESS | 22165 | Values: 121.0 130.0 133.0 133.0 122.0 123.0 120.0 130.0 163.0 127.0 12:54:16 INFO - PROCESS | 22165 | 12:54:16 INFO - PROCESS | 22165 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:160.00 stddev:3.78 (2.4%) stddev-sans-first:3.84 12:54:16 INFO - PROCESS | 22165 | Values: 157.0 160.0 158.0 157.0 157.0 159.0 169.0 164.0 160.0 160.0 12:54:16 INFO - PROCESS | 22165 | 12:54:16 INFO - PROCESS | 22165 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.87 (2.9%) stddev-sans-first:1.22 12:54:16 INFO - PROCESS | 22165 | Values: 68.0 65.0 64.0 62.0 64.0 63.0 63.0 65.0 62.0 62.0 12:54:16 INFO - PROCESS | 22165 | -------- Summary: end -------- 12:54:16 INFO - PROCESS | 22165 | 12:54:17 INFO - TEST-INFO | 22165: exit 0 12:54:17 INFO - TEST-OK | kraken | took 59926ms 12:54:17 INFO - SUITE-END | took 1174s 12:54:17 INFO - Completed test suite (00:19:35) 12:54:17 INFO - javascript benchmark 12:54:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3199.664035276296, 3221.0497903118585, 3221.259110404607, 3243.3189030303633, 3246.7402607791364, 5436.619436639437, 5554.444555544444, 5576.721163941807, 5578.079616863218, 5581.609287349887, 5488.1493368527845, 5544.972275138629, 5553.222548843165, 5562.582806289524, 5589.413111623282, 4983.626228032903, 5005.199168133099, 5038.6724862883975, 5061.0, 5115.693058416488, 4891.388576427947, 4891.5353041461185, 5043.823466178685, 5088.745562721849, 5090.618203634724, 4892.706437613754, 4905.117078925792, 4916.0905232532095, 4920.75396230187, 4959.479254678261, 4970.552650261476, 4988.127077761395, 5052.46949070346, 5052.747362631853, 5089.541941225308, 4778.235482322846, 4961.355023846877, 4971.950280497185, 4985.127602669519, 5013.821751888303, 5245.134552798783, 5325.60057995648, 5373.462653734634, 5378.327709036371, 5429.294191755086, 5783.21926539916, 5795.246617939683, 5884.735186916599, 5900.822975310704, 5901.321348044987, 5681.630694004876, 5904.97047514764, 5917.822465326047, 5925.4370834770625, 5930.229070220887, 5364.249005139283, 5425.945740542584, 5490.615656903979, 5493.587980901449, 5541.5289700375915, 5985.820425387245, 6034.607750496291, 6069.939300606938, 6071.150038994544, 6074.574779765462, 5649.4633009864, 5803.0, 5806.0, 5806.68063256525, 5815.2149459822385, 5753.769849206069, 5833.854153646108, 5871.588988770831, 5875.618084824473, 5981.0, 5897.64614123154, 5902.321233058167, 5908.615939963888, 5911.586188966731, 5944.910826337608, 5886.941130588725, 5934.584579079423, 5946.940530594725, 5948.762049517971, 5950.869334826369, 4461.130079634505, 4489.551044895485, 4542.977285113553, 4575.290829921368, 4589.311603259538, 4084.346504559256, 4112.732672376286, 4115.567865374092, 4133.04939863833, 4145.1295228002455, 5691.004074287066, 5697.173909783059, 5699.629524080921, 5701.258836351248, 5741.311042674905, 5675.659460432387, 5726.455986681259, 5807.709614519257, 5857.648541087463, 6005.159277701126, 5598.468145526169, 5602.831915042555, 5606.579506537026, 5622.550195984311, 5640.041192997201, 5106.514881086291, 5136.948630513722, 5145.4597267287145, 5148.802997986668, 5168.01807656544, 5901.380355062743, 5949.8215053548465, 6070.6357618543025, 6154.7230374633245, 6167.4140956609945, 5894.705264736832, 5939.613925094855, 5947.434993675594, 5950.821475355746, 5987.550933680079, 6154.723037463235, 6159.538034647329, 6165.260168779775, 6170.136180934583, 6175.382461753788, 5608.523275521627, 5653.406392328746, 5826.475617194473, 5828.329742079545, 5832.62087964281, 5821.068629019336, 5840.182374467493, 5868.3251426086545, 5894.646321220741, 5928.614640048383, 5658.886822263449, 5776.595638305278, 5795.565332600157, 5798.942010580009, 5802.7098645066735, 5548.0, 5759.798407055733, 5771.336296325809, 5772.278465191851, 5772.913406298825, 5526.392096869261, 5689.77240910359, 5706.058500347396, 5727.226824378656, 5830.271216097988, 5874.853128671817, 5885.234919460443, 5887.381824908323, 5888.263967004124, 5895.734691938787, 5501.284832971688, 5558.944410555842, 5606.579506537108, 5679.261695979496, 5726.398728133486], "value": 5435.838120748531, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.7531798985431, 610.5787006965195, 639.0541997843194, 652.8270008447762, 665.9267480577139, 33153.33693326132, 43768.0, 44814.775926120325, 44907.77546112273, 44976.0, 46011.0797784045, 46311.30533042007, 46380.072398552096, 46437.30344044833, 46676.29985550211, 8369.83260334793, 8561.785955351104, 9032.14194651507, 9183.448993060438, 9189.862152067724, 10664.680059598224, 11037.944810275978, 11040.227184097117, 11274.379909104997, 11292.322460652387, 11091.944540277287, 11155.776884462306, 11164.0, 11175.776484470305, 11187.272827266203, 10954.890451095507, 11000.449977501094, 11016.06363459107, 11016.834747478793, 11017.338959662366, 11118.555257789678, 11168.944155279252, 11173.49719262627, 11182.944085279603, 11192.44037798115, 43977.78011109956, 44206.0, 44239.77880110611, 44332.556674433166, 44351.11297774059, 3654.488371627948, 3751.2872554214887, 3766.1337892284655, 3856.132370216707, 4060.8984775380554, 32194.678053219402, 32431.51352729711, 32614.184645384055, 32627.347453050807, 33834.0, 4508.427736956864, 4619.3763841881255, 4628.44458664959, 4652.092841895832, 4719.5044520325555, 241401.0, 243669.0, 245459.0, 245943.0, 246188.0, 58816.41183588195, 59725.40274597199, 59738.0, 59826.40173598295, 59863.0, 38733.612663873566, 39957.60042399539, 39968.60031399707, 42054.0, 42084.57915420868, 18469.076546172637, 18772.155253013647, 18792.0, 18792.90603547001, 18801.623967520845, 11448.0, 11570.016548593296, 13039.087263891626, 13357.866421335857, 13726.519571815139, 19916.203351866054, 20304.69542956857, 20373.388798336073, 20414.183432662823, 20440.897795510926, 7371.189169191384, 7393.371563417169, 7474.5888976106835, 7512.0, 7747.418943579254, 948.8054948735493, 1055.5408397347178, 1112.6161474291357, 1113.0, 1158.368689064462, 33346.3330733384, 33592.32815343679, 33607.48766305473, 33758.66241337604, 33940.49089263663, 1133.3823066428815, 1162.860456745196, 1174.3775798826637, 1177.4819079604947, 1179.2040372748531, 16144.354225830835, 16960.91519542419, 17007.659846802995, 17010.149492525325, 17085.402010929556, 523407.0, 540008.0, 542230.0, 544074.0, 544360.0, 58111.70944145337, 58478.70760646169, 58564.414355856745, 58583.70708146432, 58596.41403585995, 1318.4923804335208, 1384.7299776543477, 1394.3934388540815, 1415.6531649745673, 1447.5657302809116, 29070.56394154047, 33732.83133584316, 34161.48757768586, 34271.0, 34364.656353437145, 50961.490385095676, 51437.7428112857, 51499.0, 51546.22680659718, 51652.0, 407677.0, 408632.0, 409699.0, 410029.0, 411897.0, 29647.851760741058, 29682.703172967995, 30766.0, 30857.0, 32203.194920127185, 47276.52723472721, 48168.518314817804, 48609.756951215015, 50053.24920126274, 54134.72932635312, 41630.58369416267, 42494.36258456187, 42637.5736242646, 43295.56704432915, 44209.778951105036, 41571.37642935419, 42265.366019510344, 42423.3636495459, 43649.78175109231, 44121.11757764891, 41461.79269103635, 42127.36808947807, 42968.0, 42999.0, 43003.35494967515, 35200.11999700028, 37149.6285037157, 37717.05707357338, 38192.23615527729, 38279.61720382872, 29258.754931741278, 29444.852775735984, 29575.704242957294, 29672.851635741685, 29704.702952970194], "value": 20748.84343783976, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.87057576863265, 410.9753414795111, 423.3945457995068, 425.43842128390526, 442.34312046610796, 19008.0, 19401.805981940175, 20045.99770011497, 20110.09504572294, 20330.796692033113, 19526.511837204078, 19757.308494202705, 20624.793752062513, 20699.896500517512, 20790.89604551979, 5656.179853921179, 5904.232449781543, 5904.675242861641, 5909.793157239476, 5918.763249470016, 5646.604737668365, 5770.711464426783, 5815.447532484428, 5856.912146317809, 5873.735681894325, 5770.538356931435, 5829.183914252008, 5834.620749651281, 5843.035899076647, 5847.970760146214, 5570.721463926788, 5721.141828725683, 5765.279340082489, 5819.388964158766, 5823.796167134151, 5140.485951404867, 5150.922736158961, 5152.046871328778, 5154.484551544853, 5157.174852023658, 23312.3006309811, 23797.286081417584, 24199.153029644054, 24330.513389732285, 24489.877550612135, 2518.1312447205682, 2608.5043841670213, 2677.9866100669565, 2740.287525243431, 3169.413658473167, 14872.851271487254, 15053.172075535842, 15112.697746045018, 15339.156346400943, 15614.45349412765, 1974.3780709076595, 1979.297349440942, 1987.1653905359783, 2005.2480319880044, 2017.9192832286692, 80170.0, 80836.0, 80928.59535702284, 81154.0, 82689.17310826934, 10817.513211905325, 11021.283616564897, 11153.163512736577, 11473.196876218752, 11537.711557211136, 16244.59388515273, 16283.918580407022, 16295.0, 16298.348066077462, 16300.0, 8306.958465207756, 8684.305255579538, 8691.956540217385, 8790.516521591373, 8897.154770296811, 8387.161283871686, 8397.874031889527, 8422.28410585095, 8640.092790257058, 8654.78363040929, 6830.692618832065, 6897.206821215625, 6966.303369662993, 7037.366637002694, 7049.7885063448175, 1982.762068551783, 2043.1520918818524, 2062.329742833555, 2074.7614024387085, 2089.861025740975, 933.3000249812641, 1075.6074032978063, 1086.896744809242, 1123.0061395664732, 1126.983095253572, 20084.19663213455, 20213.393598192077, 20292.492687682927, 20573.794262057487, 20707.378778636667, 1020.3979652005204, 1063.0591926145416, 1067.6209945469402, 1072.5656109275756, 1100.7908497385472, 10792.352458852338, 11655.30068195911, 11767.352795596324, 11872.10959178065, 11894.702632434259, 447829.0, 461566.0, 463644.0, 465293.0, 468888.0, 78225.0, 79534.0, 79666.0, 81049.0, 81796.0, 1009.8990100989843, 1017.6183931025865, 1038.5638032026416, 1050.5167622893555, 1051.2483574244452, 17383.652326953645, 17896.91051544734, 18260.26958921628, 18323.08384580739, 18544.443666690022, 37155.814220928725, 38243.42634860535, 39383.60616393799, 39496.60503395044, 40857.79571102125, 50652.0, 50801.0, 51234.23148652699, 52361.47638523718, 53930.19104713511, 8728.258098061737, 8813.471191728517, 8894.42186257891, 9140.177384035469, 9189.816203676022, 12927.482900683868, 13339.866601333862, 13422.932885335511, 13477.0, 13763.31183440804, 10742.8388574173, 11302.4913878874, 11342.319460832376, 11345.829812552653, 11477.713057173303, 11704.239224450383, 11903.761924761284, 12001.459934302802, 12142.575009874612, 12617.306048167438, 8693.347998900234, 11630.767384652429, 12036.097292702907, 12164.209326393757, 12593.0, 5294.179402192666, 6963.303669632996, 8566.571671416528, 9008.676573252376, 9178.770530736785, 11434.94282528582, 11940.701482463008, 12000.15998880105, 12088.818667720167, 12308.753824923631], "value": 9564.661405993205, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.2986636548094, 1516.0827699241959, 1548.798656174697, 1671.6238846259594, 1801.8108098649634, 7638.541687498747, 8587.441816281946, 8809.339299552543, 8820.338474614413, 9023.0, 8877.245434138105, 8937.10628937106, 8939.240164586, 8951.731448056553, 8976.237019853304, 2432.20953190213, 2462.2982450001755, 2462.4336402627405, 2462.889169987346, 2463.2363967170236, 2439.48770758141, 2535.771780539751, 2541.0217066429464, 2542.186500319898, 2542.7838633716156, 2462.0398044762555, 2465.6055031194924, 2508.0, 2510.309664842174, 2512.1835403493847, 2407.07327678844, 2408.145108486497, 2430.3438071720625, 2435.281591930385, 2446.1316232737477, 2410.192585483865, 2429.5748244057218, 2454.5459090068216, 2456.6437866509254, 2463.519613675334, 8471.915280847174, 8869.645214191425, 8949.64201431942, 9002.0, 9095.272378209727, 5123.615728820316, 5322.627416080876, 5330.493603107699, 5336.733163341817, 5339.41266460689, 3322.96677033229, 3468.1676397664633, 3531.1878267998504, 3535.4166562517153, 3615.8734444294587, 1156.0866915137115, 1172.0974849366025, 1172.7419967607113, 1178.4696886401155, 1207.0946789907568, 11840.348780817052, 11878.0, 11891.524339026428, 11921.165518413714, 11935.820962685653, 4236.0, 4495.685302028826, 4583.587477127075, 4599.6090332321455, 4619.145458090264, 9948.651797187063, 9971.601135954481, 9973.351732137387, 9982.650607228712, 9987.60049598008, 5332.360116785933, 5333.919991200135, 5335.0, 5354.946450535523, 5357.5446087082255, 4229.730469080295, 4424.6239069678795, 4532.161550113239, 4546.204414227497, 4985.501449855058, 3890.591487893787, 3897.8830635080994, 4044.312466880637, 4053.61490658387, 4057.1479989202007, 1182.804837201852, 1189.3755778216505, 1193.4987305331608, 1202.5430336472084, 1205.0419916166668, 921.8064206516573, 932.9533523323806, 935.2891802230218, 940.2431043010306, 945.8912225094065, 5732.59231122921, 5868.354481007086, 5910.527157827363, 5979.4618484336615, 6204.503639708812, 466.5467070076754, 476.7425590181263, 996.3125443444001, 999.4253304350028, 1018.8064267789097, 3902.6487616114687, 4058.1072164123843, 4069.2268468990796, 4090.550039495653, 4134.049168691218, 10137.797244055078, 10772.353658780341, 10842.728931776768, 10865.40240286776, 10931.344119352865, 10476.790464190673, 10732.517036733365, 10735.570577176826, 10830.458477076114, 10851.78296434067, 8252.21603947624, 8356.540390278471, 8376.162383761575, 8376.916230837736, 8385.119562445978, 6112.786052488142, 6115.266168059861, 6128.571000029955, 6130.816075517741, 6171.59884607499, 9874.851877221703, 9908.572399762104, 9966.651167209113, 10005.499725013866, 10182.745431364276, 9076.682316118904, 9366.812663746823, 10340.172786177238, 10361.11930485887, 10390.064894159563, 7125.786226413215, 7226.89159662616, 7320.267973202637, 7391.445641577011, 7465.589392583242, 8300.626471808662, 8366.079731229682, 8411.789705257417, 8415.579221039046, 8460.196281353261, 7518.849623007619, 7626.199249078989, 7691.346235569816, 7747.147813740371, 7843.764687059169, 7350.485466017328, 7379.077615298088, 7443.106827180773, 7788.0, 7813.804654883674, 6996.335348141918, 7059.329363710439, 7059.647017649199, 7065.894011589728, 7067.57594544329, 4988.8752781180765, 5149.9227511586605, 5164.612654051037, 5222.321098257355, 5415.539679127318, 5195.5843532518065, 5206.505381988705, 5270.841874743764, 5321.3880403754065, 5457.672539647634], "value": 4635.669215881939, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.8034939734954, 341.2288228603356, 350.67036985233887, 359.66551107470076, 361.50112844274895, 5275.393329767073, 5346.492083252089, 5424.294841670587, 5441.156620723784, 5488.588355873306, 5330.3603567571945, 5342.171963345678, 5344.22508736233, 5350.250964864912, 5352.678839269646, 4020.9597904021025, 4243.6605071594195, 4254.127903779733, 4257.44653195085, 4269.420314483646, 3792.0, 4107.67138628909, 4111.813344657884, 4194.664426845845, 4202.117555313388, 4164.1879833432495, 4164.68764842638, 4168.416421700964, 4172.791360431981, 4175.832966681329, 4160.396742472324, 4181.038361176916, 4181.417807227355, 4183.518895327046, 4199.4750656168135, 3635.1820840310984, 3681.4661874028116, 3708.332500149972, 3716.201016781378, 3734.458503516975, 5148.845534633967, 5153.768080436389, 5157.8452646420665, 5170.663906846043, 5178.659764451945, 4766.928496072562, 4782.784774685113, 4786.664933454659, 4807.423109226916, 4813.278008298783, 5446.891062178774, 5561.555075593943, 5572.637778544382, 5588.86027849307, 5592.636478628876, 4096.283150448659, 4102.528209255914, 4102.815373308208, 4104.897377565555, 4109.815058322382, 5529.668219906778, 5695.886082278331, 5818.5345172386105, 5845.766169353264, 5856.121581762727, 3897.6881849451975, 4055.5741647127215, 4056.3915412687743, 4153.563875792998, 4199.790010499524, 4234.830606775695, 4247.5964783345535, 4250.171216612731, 4250.42619246404, 4252.532221455637, 4631.726275274326, 4797.40032495938, 4799.18413869643, 4800.855974320776, 4810.254410566367, 5598.664080155204, 5605.971970140205, 5607.299087614048, 5619.297587801525, 5642.633228840113, 1405.894557908161, 1406.4444544404903, 1407.5495841330676, 1412.6892083741561, 1430.9427622894968, 937.8218138553653, 965.2181732796317, 974.1427543761445, 977.3158788847835, 995.7908839143716, 5210.5831533477985, 5243.239730239094, 5245.26566280721, 5267.78928842842, 5282.656627319212, 5544.306961629796, 5545.0, 5563.833085007456, 5566.387697353288, 5568.331800184003, 5094.592432605383, 5221.686698798084, 5246.23929530216, 5275.129603615361, 5276.841694749163, 2952.660444048919, 2956.541736030919, 2963.185124090849, 2970.2722832905642, 2975.137210209015, 5752.971235143881, 5760.711964401763, 5762.567807414461, 5785.942140578624, 5798.797042103506, 5427.213054107211, 5519.9448005520235, 5629.831105066854, 5652.9152062719095, 5655.688937108416, 5743.8851222976145, 5766.769329226868, 5784.363719990798, 5793.362730099601, 5800.390958949334, 5454.809081682122, 5532.585056120887, 5564.805231816867, 5581.972090139523, 5742.827715168552, 5740.1963725077685, 5759.856003599776, 5764.164196191613, 5769.798057067983, 5782.363939966516, 5750.482456578928, 5888.586739182651, 5895.850309189666, 5909.231799866162, 6055.666938318434, 3934.409838524244, 4114.526829414655, 4172.269852775691, 4176.498820141603, 4189.874303770892, 5654.0, 5752.942470575408, 5760.308762948473, 5760.683162426107, 5768.625039372428, 5594.4125866785025, 5624.1035866527955, 5635.577331700057, 5642.322921249476, 5642.802501912413, 5556.472135147154, 5571.415001424954, 5610.831675049755, 5612.971935140298, 5631.000994647005, 5426.321709786277, 5525.889482210414, 5558.3602837162325, 5559.44405559457, 5568.777248909998, 5565.693886836263, 5606.747696353756, 5623.578231632562, 5636.774529018793, 5661.584603849038, 5473.781048758005, 5487.506124448819, 5509.311336082989, 5511.311086114236, 5535.169724541351], "value": 4262.8732204257185, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.9277365037145, 808.4074373484236, 828.892244008279, 856.1053698884665, 868.856638654622, 14783.113013219201, 16117.0, 16168.434104806334, 16190.271437785299, 16206.432774852898, 14466.49367272143, 14729.337179826907, 14757.745591624698, 14758.704825903476, 14763.409463621443, 731.1043971135343, 748.1657951384221, 833.5998720614109, 850.7660393391805, 856.9528675922821, 867.5792240763225, 869.7477731457869, 869.7825543614097, 869.8956125264978, 871.7646235516406, 917.7063339731288, 918.4902379179553, 918.6968300460832, 919.204887772079, 919.4391421233042, 913.5158366065963, 915.601713254733, 916.2349438219095, 916.3539704508372, 917.3945196170496, 674.9865002699968, 675.7567275780715, 675.7668604331546, 675.8175292670951, 676.5906626490952, 14364.281785910664, 14619.26903654813, 14641.121532707964, 14642.267886605734, 15436.922815385851, 14444.0, 14830.406783728638, 14931.925340373336, 15273.0, 15333.463328783439, 11872.465739041763, 12016.339101349422, 12022.51909923602, 12081.033517318594, 12172.756544869053, 3899.629535194152, 3994.9201015979806, 4040.7575545467366, 4047.7166598337835, 4073.7963101845085, 61131.69434152801, 61922.0, 62303.37696623021, 62576.68711656458, 62861.0, 11533.192676512732, 11567.710807229718, 11615.883841161649, 11655.358955257543, 11771.352575608253, 21116.155353785984, 21119.0, 21213.469663258235, 21287.148514059263, 21303.573928521342, 8231.670733170726, 8233.670653173805, 8258.504489730636, 8359.958200209081, 8417.64507889996, 4463.152001119777, 4576.405067341224, 4635.420572428447, 4643.558861908114, 4708.952910470852, 3292.506124081359, 3359.412102881986, 3389.084947064328, 3404.7786893852317, 3424.9486257706153, 572.3589579670795, 575.2665351676645, 588.3469349022581, 589.6226415094343, 591.4972273567433, 604.8941435248814, 661.7088481068314, 737.9631018449056, 755.1655420759981, 764.8279137194198, 9270.860937085949, 9438.575264112995, 9571.330006899589, 9762.633231347618, 9881.715377001088, 545.939946605873, 554.7780887644893, 593.9732712027969, 598.1476396135489, 627.1001113402282, 4456.799444025027, 4517.706349087299, 4543.34121552373, 4551.362809206714, 4686.226772582554, 55663.72168139214, 86870.0, 87494.1250587486, 90919.0, 92733.0, 75385.62307188429, 76179.61910190413, 76663.23336766672, 76684.61657691676, 76713.0, 70670.0, 73483.63258183675, 73770.0, 74346.0, 76099.61950190214, 8749.75636816131, 8888.866666999871, 8973.641054357753, 9014.608339382881, 9020.368574199743, 46597.0, 47454.288185677935, 48063.279050813566, 48394.51605484041, 48896.0, 40102.19795604013, 40377.1924561513, 41431.7928410356, 48257.51742482671, 63895.680521597096, 12024.268620316789, 12084.45619947087, 12141.939290303491, 12203.633890983285, 12351.135420520477, 12990.935045324713, 13115.0, 13180.406881690154, 13354.532591359255, 13964.79052814229, 11916.52333906634, 12077.154599178324, 12221.144519883523, 12458.377081146087, 12689.111762176928, 12420.378981050731, 12493.687657808627, 12769.74460510766, 13154.21074735519, 13190.868091318964, 11798.233114847508, 11979.28124312544, 12241.0, 12430.502779888704, 12717.173383730027, 9511.429314241168, 10201.74495637615, 10241.180705543688, 10263.332883362558, 10295.897041029793, 11581.826272606086, 11731.790827457016, 11784.941075294568, 11802.704932376415, 12302.876971230173], "value": 7159.798635085221, "unit": "score"}], "name": "dromaeo_css", "value": 7310.525767133199, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 111.0, 109.0, 112.0, 113.0, 111.0, 111.0, 112.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 125.0, 124.0, 156.0, 118.0, 119.0, 120.0, 121.0, 168.0, 116.0], "value": 131.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 160.0, 161.0, 160.0, 160.0, 161.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 107.0, 76.0, 75.0, 76.0, 76.0, 116.0, 76.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 129.0, 82.0, 82.0, 81.0, 103.0, 81.0, 81.0, 113.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 147.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0, 85.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 52.0, 52.0, 53.0, 52.0, 54.0, 51.0, 51.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 59.0, 59.0, 59.0, 58.0, 58.0, 59.0, 58.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 74.0, 75.0, 75.0, 78.0, 75.0, 75.0, 80.0, 74.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 130.0, 133.0, 133.0, 122.0, 123.0, 120.0, 130.0, 163.0, 127.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 158.0, 157.0, 157.0, 159.0, 169.0, 164.0, 160.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 64.0, 62.0, 64.0, 63.0, 63.0, 65.0, 62.0, 62.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1464.1, "alertThreshold": 2.0}]} 12:54:18 INFO - Return code: 0 12:54:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:54:18 INFO - # TBPL SUCCESS # 12:54:18 INFO - Running post-action listener: _resource_record_post_action 12:54:18 INFO - [mozharness: 2017-02-16 20:54:18.113290Z] Finished run-tests step (success) 12:54:18 INFO - Running post-run listener: _resource_record_post_run 12:54:18 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 322334720; Read time: 0; Write time: 180396 12:54:18 INFO - TinderboxPrint: CPU usage
13.0% 12:54:18 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:54:18 INFO - TinderboxPrint: I/O write bytes / time
322,334,720 / 180,396 12:54:18 INFO - TinderboxPrint: CPU idle
8,262.2 (87.0%) 12:54:18 INFO - TinderboxPrint: CPU user
1,187.2 (12.5%) 12:54:18 INFO - TinderboxPrint: Swap in / out
0 / 0 12:54:18 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 97316864; Read time: 0; Write time: 79580 12:54:18 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 220622848; Read time: 0; Write time: 100340 12:54:18 INFO - Running post-run listener: _upload_blobber_files 12:54:18 INFO - Blob upload gear active. 12:54:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:54:18 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 12:54:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:54:19 INFO - (blobuploader) - INFO - Open directory for files ... 12:54:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:54:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:54:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:54:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:54:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:54:19 INFO - (blobuploader) - INFO - Done attempting. 12:54:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:54:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:54:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:54:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:54:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:54:20 INFO - (blobuploader) - INFO - Done attempting. 12:54:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:54:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:54:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:54:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:54:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:54:24 INFO - (blobuploader) - INFO - Done attempting. 12:54:24 INFO - (blobuploader) - INFO - Iteration through files over. 12:54:24 INFO - Return code: 0 12:54:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:54:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:54:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26b48ba413b6efabd7bf127c8ec95a15c3e22f4619d38e8b74660f2f2ecfba55f0aea43eb98dd5bed410d53b4496084a29ecb9985483caf79d28a873d9e16a52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/381e2b2cdf36bb9098fdd8948db36b5ba8ced741781eb4efe98f00ffc9e167c760b6374d4051fcf19a046493da87fa9f1b0786bbc3aa9dd907db00313f216fee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/32238370048958bf6c0f50468993f841637ab6b15b7f4a44ff110192d69a50aceaee3f31c56d67eed40565c026b6ac94bdecf623ae38f2023a956335f9a2e9a8"} 12:54:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:54:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:54:24 INFO - Contents: 12:54:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26b48ba413b6efabd7bf127c8ec95a15c3e22f4619d38e8b74660f2f2ecfba55f0aea43eb98dd5bed410d53b4496084a29ecb9985483caf79d28a873d9e16a52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/381e2b2cdf36bb9098fdd8948db36b5ba8ced741781eb4efe98f00ffc9e167c760b6374d4051fcf19a046493da87fa9f1b0786bbc3aa9dd907db00313f216fee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/32238370048958bf6c0f50468993f841637ab6b15b7f4a44ff110192d69a50aceaee3f31c56d67eed40565c026b6ac94bdecf623ae38f2023a956335f9a2e9a8"} 12:54:24 INFO - Running post-run listener: copy_logs_to_upload_dir 12:54:24 INFO - Copying logs to upload dir... 12:54:24 INFO - mkdir: /builds/slave/test/build/upload/logs 12:54:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.600202 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-02-16 12:54:23.636753) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 12:54:23.639918) ========= 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=3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26b48ba413b6efabd7bf127c8ec95a15c3e22f4619d38e8b74660f2f2ecfba55f0aea43eb98dd5bed410d53b4496084a29ecb9985483caf79d28a873d9e16a52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/381e2b2cdf36bb9098fdd8948db36b5ba8ced741781eb4efe98f00ffc9e167c760b6374d4051fcf19a046493da87fa9f1b0786bbc3aa9dd907db00313f216fee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/32238370048958bf6c0f50468993f841637ab6b15b7f4a44ff110192d69a50aceaee3f31c56d67eed40565c026b6ac94bdecf623ae38f2023a956335f9a2e9a8"} build_url:https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/X_tMmdl-TQe7uAH2lMZrPg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26b48ba413b6efabd7bf127c8ec95a15c3e22f4619d38e8b74660f2f2ecfba55f0aea43eb98dd5bed410d53b4496084a29ecb9985483caf79d28a873d9e16a52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/381e2b2cdf36bb9098fdd8948db36b5ba8ced741781eb4efe98f00ffc9e167c760b6374d4051fcf19a046493da87fa9f1b0786bbc3aa9dd907db00313f216fee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/32238370048958bf6c0f50468993f841637ab6b15b7f4a44ff110192d69a50aceaee3f31c56d67eed40565c026b6ac94bdecf623ae38f2023a956335f9a2e9a8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 12:54:23.672343) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 12:54:23.672987) ========= 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=3297cc2eebb5444a7688c33f000001b5-1487277228.815610-1078031429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 12:54:23.728590) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 12:54:23.728989) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 12:54:23.729323) ========= ========= Total master_lag: 0.26 =========