builder: cedar_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1478696664.39 results: success (0) buildid: 20161109022623 builduid: 895ccb49025445e2a2bd141e71060333 revision: 533b6efe3528fcb022c857e84bc432b77b5507ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-09 05:04:24.388118) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-09 05:04:24.388638) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 05:04:24.388983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 05:04:24.404043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 05:04:24.404384) ========= 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=920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-09 05:04:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.7M=0s 2016-11-09 05:04:24 (24.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108679 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 05:04:24.529705) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 05:04:24.530157) ========= 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=920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016992 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 05:04:24.583402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 05:04:24.583838) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 533b6efe3528fcb022c857e84bc432b77b5507ef --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 533b6efe3528fcb022c857e84bc432b77b5507ef --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=920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-09 05:04:24,735 truncating revision to first 12 chars 2016-11-09 05:04:24,735 Setting DEBUG logging. 2016-11-09 05:04:24,735 attempt 1/10 2016-11-09 05:04:24,735 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/533b6efe3528?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-09 05:04:25,258 unpacking tar archive at: cedar-533b6efe3528/testing/mozharness/ program finished with exit code 0 elapsedTime=0.856195 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 05:04:25.458559) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 05:04:25.459367) ========= script_repo_revision: 533b6efe3528fcb022c857e84bc432b77b5507ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 05:04:25.460318) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 05:04:25.460942) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 05:04:25.473091) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-09 05:04:25.473507) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:04:25 INFO - MultiFileLogger online at 20161109 05:04:25 in /builds/slave/test 05:04:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 05:04:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:04:25 INFO - {'append_to_log': False, 05:04:25 INFO - 'base_work_dir': '/builds/slave/test', 05:04:25 INFO - 'blob_upload_branch': 'Cedar', 05:04:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:04:25 INFO - 'branch': 'Cedar', 05:04:25 INFO - 'buildbot_json_path': 'buildprops.json', 05:04:25 INFO - 'config_files': ('talos/linux_config.py',), 05:04:25 INFO - 'default_actions': ('clobber', 05:04:25 INFO - 'read-buildbot-config', 05:04:25 INFO - 'download-and-extract', 05:04:25 INFO - 'populate-webroot', 05:04:25 INFO - 'create-virtualenv', 05:04:25 INFO - 'install', 05:04:25 INFO - 'run-tests'), 05:04:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:04:25 INFO - 'download_minidump_stackwalk': True, 05:04:25 INFO - 'download_symbols': 'ondemand', 05:04:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:04:25 INFO - 'tooltool.py': '/tools/tooltool.py', 05:04:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:04:25 INFO - '/tools/misc-python/virtualenv.py')}, 05:04:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:04:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:04:25 INFO - 'installer_path': 'installer.exe', 05:04:25 INFO - 'log_level': 'info', 05:04:25 INFO - 'log_name': 'talos', 05:04:25 INFO - 'log_to_console': True, 05:04:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:04:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:04:25 INFO - 'opt_config_files': (), 05:04:25 INFO - 'pip_index': False, 05:04:25 INFO - 'sps_profile': False, 05:04:25 INFO - 'sps_profile_interval': 0, 05:04:25 INFO - 'suite': 'dromaeojs', 05:04:25 INFO - 'system_bits': '32', 05:04:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:04:25 INFO - 'title': 'talos-linux64-ix-053', 05:04:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:04:25 INFO - 'use_talos_json': True, 05:04:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:04:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:04:25 INFO - 'work_dir': 'build'} 05:04:25 INFO - [mozharness: 2016-11-09 13:04:25.724652Z] Running clobber step. 05:04:25 INFO - Running pre-action listener: _resource_record_pre_action 05:04:25 INFO - Running main action method: clobber 05:04:25 INFO - rmtree: /builds/slave/test/build 05:04:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:04:26 INFO - Running post-action listener: _resource_record_post_action 05:04:26 INFO - [mozharness: 2016-11-09 13:04:26.192401Z] Finished clobber step (success) 05:04:26 INFO - [mozharness: 2016-11-09 13:04:26.192501Z] Running read-buildbot-config step. 05:04:26 INFO - Running pre-action listener: _resource_record_pre_action 05:04:26 INFO - Running main action method: read_buildbot_config 05:04:26 INFO - Using buildbot properties: 05:04:26 INFO - { 05:04:26 INFO - "project": "", 05:04:26 INFO - "product": "firefox", 05:04:26 INFO - "script_repo_revision": "default", 05:04:26 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs", 05:04:26 INFO - "repository": "", 05:04:26 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs", 05:04:26 INFO - "buildid": "20161109022623", 05:04:26 INFO - "pgo_build": "False", 05:04:26 INFO - "basedir": "/builds/slave/test", 05:04:26 INFO - "buildnumber": 3, 05:04:26 INFO - "slavename": "talos-linux64-ix-053", 05:04:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:04:26 INFO - "platform": "ubuntu64_hw", 05:04:26 INFO - "scheduler": "tests-cedar-linux64-talos", 05:04:26 INFO - "branch": "cedar", 05:04:26 INFO - "repo_path": "projects/cedar", 05:04:26 INFO - "revision": "533b6efe3528fcb022c857e84bc432b77b5507ef", 05:04:26 INFO - "stage_platform": "linux64", 05:04:26 INFO - "builduid": "895ccb49025445e2a2bd141e71060333", 05:04:26 INFO - "slavebuilddir": "test" 05:04:26 INFO - } 05:04:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:04:26 INFO - Running post-action listener: _resource_record_post_action 05:04:26 INFO - [mozharness: 2016-11-09 13:04:26.195461Z] Finished read-buildbot-config step (success) 05:04:26 INFO - [mozharness: 2016-11-09 13:04:26.195550Z] Running download-and-extract step. 05:04:26 INFO - Running pre-action listener: _resource_record_pre_action 05:04:26 INFO - Running main action method: download_and_extract 05:04:26 INFO - mkdir: /builds/slave/test/build/tests 05:04:26 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')]} 05:04:26 INFO - trying https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:04:26 INFO - Downloading https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:04:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:04:26 INFO - Downloaded 1361 bytes. 05:04:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:04:26 INFO - Using the following test package requirements: 05:04:26 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:04:26 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:04:26 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:04:26 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:26 INFO - u'jsshell-linux-x86_64.zip'], 05:04:26 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:04:26 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:04:26 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:04:26 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:04:26 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:04:26 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:04:26 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:04:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:04:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:04:26 INFO - Fetch https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:04:27 INFO - Http code: 200 05:04:27 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 05:04:27 INFO - x-amz-cf-id: 4kcDdkrx5BNtRBLYLtxng10fZLmbGSF8ihYSmJ8uzG6uaZxIfFyD7A== 05:04:27 INFO - x-amz-version-id: wycR6qV_cp.7jbHsC6LvCb2NGLU6q2ac 05:04:27 INFO - Expected file size: 20363467 05:04:27 INFO - Obtained file size: 20363467 05:04:31 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:04:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:04:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:04:31 INFO - Fetch https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:04:32 INFO - Http code: 200 05:04:32 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 05:04:32 INFO - x-amz-cf-id: T5fNvCVaUQgD8enwpgHvfwZQ2GVfHCeS7a3507sB8ps-K-Q49YjP6A== 05:04:32 INFO - x-amz-version-id: wycR6qV_cp.7jbHsC6LvCb2NGLU6q2ac 05:04:32 INFO - Expected file size: 20363467 05:04:32 INFO - Obtained file size: 20363467 05:04:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:04:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:04:36 INFO - Fetch https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:04:37 INFO - Http code: 200 05:04:37 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 05:04:37 INFO - x-amz-cf-id: s5qu-mF69GG5EPusOGRbwcTpcGNo_vjhD2VkcpVi14ihSs3qGg3cgA== 05:04:37 INFO - x-amz-version-id: CmFYXoCEk1IdO0xpUvnFRlSTQUHOSYiA 05:04:37 INFO - Expected file size: 14409038 05:04:37 INFO - Obtained file size: 14409038 05:04:37 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')]} 05:04:37 INFO - trying https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:04:37 INFO - Downloading https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:04:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:04:38 INFO - Downloaded 55947896 bytes. 05:04:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:04:38 INFO - mkdir: /builds/slave/test/properties 05:04:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:04:38 INFO - Writing to file /builds/slave/test/properties/build_url 05:04:38 INFO - Contents: 05:04:38 INFO - build_url:https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:04:39 INFO - Running post-action listener: _resource_record_post_action 05:04:39 INFO - Running post-action listener: set_extra_try_arguments 05:04:39 INFO - [mozharness: 2016-11-09 13:04:39.611767Z] Finished download-and-extract step (success) 05:04:39 INFO - [mozharness: 2016-11-09 13:04:39.611994Z] Running populate-webroot step. 05:04:39 INFO - Running pre-action listener: _resource_record_pre_action 05:04:39 INFO - Running main action method: populate_webroot 05:04:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:04:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:04:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:04:39 INFO - '--tppagecycles', 05:04:39 INFO - '7'], 05:04:39 INFO - 'tests': ['tsvgm']}}, 05:04:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:04:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:04:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:04:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:04:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:04:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:04:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:39 INFO - 'talos_options': ['--disable-e10s'], 05:04:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:39 INFO - 'talos_options': ['--disable-e10s'], 05:04:39 INFO - 'tests': ['damp', 'tps']}, 05:04:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:39 INFO - 'tests': ['damp', 'tps']}, 05:04:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:04:39 INFO - 'tests': ['dromaeo_dom']}, 05:04:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:04:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:04:39 INFO - 'tests': ['basic_compositor_video']}, 05:04:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:04:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:04:39 INFO - 'tests': ['a11yr', 05:04:39 INFO - 'ts_paint', 05:04:39 INFO - 'tpaint', 05:04:39 INFO - 'sessionrestore', 05:04:39 INFO - 'sessionrestore_no_auto_restore', 05:04:39 INFO - 'tabpaint']}, 05:04:39 INFO - 'other-e10s': {'tests': ['a11yr', 05:04:39 INFO - 'ts_paint', 05:04:39 INFO - 'tpaint', 05:04:39 INFO - 'sessionrestore', 05:04:39 INFO - 'sessionrestore_no_auto_restore', 05:04:39 INFO - 'tabpaint']}, 05:04:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:04:39 INFO - 'ts_paint', 05:04:39 INFO - 'tpaint', 05:04:39 INFO - 'sessionrestore', 05:04:39 INFO - 'sessionrestore_no_auto_restore', 05:04:39 INFO - 'tabpaint']}, 05:04:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:04:39 INFO - 'ts_paint', 05:04:39 INFO - 'tpaint', 05:04:39 INFO - 'sessionrestore', 05:04:39 INFO - 'sessionrestore_no_auto_restore', 05:04:39 INFO - 'tabpaint']}, 05:04:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:04:39 INFO - 'tests': ['a11yr', 05:04:39 INFO - 'ts_paint', 05:04:39 INFO - 'tpaint', 05:04:39 INFO - 'sessionrestore', 05:04:39 INFO - 'sessionrestore_no_auto_restore', 05:04:39 INFO - 'tabpaint']}, 05:04:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:04:39 INFO - 'tests': ['a11yr', 05:04:39 INFO - 'ts_paint', 05:04:39 INFO - 'tpaint', 05:04:39 INFO - 'sessionrestore', 05:04:39 INFO - 'sessionrestore_no_auto_restore', 05:04:39 INFO - 'tabpaint']}, 05:04:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:04:39 INFO - 'tests': ['tsvgx', 05:04:39 INFO - 'tsvgr_opacity', 05:04:39 INFO - 'tart', 05:04:39 INFO - 'tscrollx', 05:04:39 INFO - 'cart']}, 05:04:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:04:39 INFO - 'tsvgr_opacity', 05:04:39 INFO - 'tart', 05:04:39 INFO - 'tscrollx', 05:04:39 INFO - 'cart']}, 05:04:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:39 INFO - 'talos_options': ['--disable-e10s'], 05:04:39 INFO - 'tests': ['tp5o']}, 05:04:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:39 INFO - 'tests': ['tp5o']}, 05:04:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:39 INFO - 'talos_options': ['--disable-e10s', 05:04:39 INFO - '--xperf_path', 05:04:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:39 INFO - 'tests': ['tp5n']}, 05:04:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:39 INFO - 'talos_options': ['--xperf_path', 05:04:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:39 INFO - 'tests': ['tp5n']}}, 05:04:39 INFO - 'talos.zip': {'path': '', 05:04:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:04:39 INFO - Running post-action listener: _resource_record_post_action 05:04:39 INFO - [mozharness: 2016-11-09 13:04:39.628869Z] Finished populate-webroot step (success) 05:04:39 INFO - [mozharness: 2016-11-09 13:04:39.628957Z] Running create-virtualenv step. 05:04:39 INFO - Running pre-action listener: _resource_record_pre_action 05:04:39 INFO - Running main action method: create_virtualenv 05:04:39 INFO - Creating virtualenv /builds/slave/test/build/venv 05:04:39 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 05:04:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:04:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:04:39 INFO - Using real prefix '/usr' 05:04:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:04:40 INFO - Installing distribute.............................................................................................................................................................................................done. 05:04:42 INFO - Installing pip.................done. 05:04:42 INFO - Return code: 0 05:04:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:04:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:04:42 INFO - Reading from file tmpfile_stdout 05:04:42 INFO - Output received: 05:04:42 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) 05:04:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:42 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 0x7ff0e990ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2819790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816930>, '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 0x2817830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817cc0>, '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': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', '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 05:04:42 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 05:04:42 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 05:04:42 INFO - Using env: {'DISPLAY': ':0', 05:04:42 INFO - 'HOME': '/home/cltbld', 05:04:42 INFO - 'LANG': 'en_US.UTF-8', 05:04:42 INFO - 'LANGUAGE': 'en_US:en', 05:04:42 INFO - 'LOGNAME': 'cltbld', 05:04:42 INFO - 'MAIL': '/var/mail/cltbld', 05:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:42 INFO - 'MOZ_NO_REMOTE': '1', 05:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:42 INFO - 'NO_EM_RESTART': '1', 05:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:42 INFO - 'PWD': '/builds/slave/test', 05:04:42 INFO - 'SHELL': '/bin/bash', 05:04:42 INFO - 'SHLVL': '1', 05:04:42 INFO - 'TERM': 'linux', 05:04:42 INFO - 'TMOUT': '86400', 05:04:42 INFO - 'USER': 'cltbld', 05:04:42 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', 05:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:42 INFO - '_': '/tools/buildbot/bin/python'} 05:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:42 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 05:04:42 INFO - Cleaning up... 05:04:42 INFO - Return code: 0 05:04:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:42 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 0x7ff0e990ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2819790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816930>, '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 0x2817830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817cc0>, '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': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', '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 05:04:42 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 05:04:42 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 05:04:42 INFO - Using env: {'DISPLAY': ':0', 05:04:42 INFO - 'HOME': '/home/cltbld', 05:04:42 INFO - 'LANG': 'en_US.UTF-8', 05:04:42 INFO - 'LANGUAGE': 'en_US:en', 05:04:42 INFO - 'LOGNAME': 'cltbld', 05:04:42 INFO - 'MAIL': '/var/mail/cltbld', 05:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:42 INFO - 'MOZ_NO_REMOTE': '1', 05:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:42 INFO - 'NO_EM_RESTART': '1', 05:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:42 INFO - 'PWD': '/builds/slave/test', 05:04:42 INFO - 'SHELL': '/bin/bash', 05:04:42 INFO - 'SHLVL': '1', 05:04:42 INFO - 'TERM': 'linux', 05:04:42 INFO - 'TMOUT': '86400', 05:04:42 INFO - 'USER': 'cltbld', 05:04:42 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', 05:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:42 INFO - '_': '/tools/buildbot/bin/python'} 05:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:42 INFO - Downloading/unpacking psutil>=3.1.1 05:04:42 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 05:04:42 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 05:04:42 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 05:04:42 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 05:04:42 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 05:04:42 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 05:04:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:04:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:45 INFO - Installing collected packages: psutil 05:04:45 INFO - Running setup.py install for psutil 05:04:45 INFO - building 'psutil._psutil_linux' extension 05:04:45 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 05:04:46 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 05:04:46 INFO - building 'psutil._psutil_posix' extension 05:04:46 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 05:04:46 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 05:04:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:46 INFO - Successfully installed psutil 05:04:46 INFO - Cleaning up... 05:04:46 INFO - Return code: 0 05:04:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:04:46 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')]} 05:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:46 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')]} 05:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:46 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 0x7ff0e990ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2819790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816930>, '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 0x2817830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817cc0>, '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': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', '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 05:04:46 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 05:04:46 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 05:04:46 INFO - Using env: {'DISPLAY': ':0', 05:04:46 INFO - 'HOME': '/home/cltbld', 05:04:46 INFO - 'LANG': 'en_US.UTF-8', 05:04:46 INFO - 'LANGUAGE': 'en_US:en', 05:04:46 INFO - 'LOGNAME': 'cltbld', 05:04:46 INFO - 'MAIL': '/var/mail/cltbld', 05:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:46 INFO - 'MOZ_NO_REMOTE': '1', 05:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:46 INFO - 'NO_EM_RESTART': '1', 05:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:46 INFO - 'PWD': '/builds/slave/test', 05:04:46 INFO - 'SHELL': '/bin/bash', 05:04:46 INFO - 'SHLVL': '1', 05:04:46 INFO - 'TERM': 'linux', 05:04:46 INFO - 'TMOUT': '86400', 05:04:46 INFO - 'USER': 'cltbld', 05:04:46 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', 05:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:46 INFO - '_': '/tools/buildbot/bin/python'} 05:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:04:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:04:48 INFO - Installing collected packages: mozsystemmonitor 05:04:48 INFO - Running setup.py install for mozsystemmonitor 05:04:48 INFO - Successfully installed mozsystemmonitor 05:04:48 INFO - Cleaning up... 05:04:48 INFO - Return code: 0 05:04:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:48 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 0x7ff0e990ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2819790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816930>, '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 0x2817830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817cc0>, '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': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', '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 05:04:48 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 05:04:48 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 05:04:48 INFO - Using env: {'DISPLAY': ':0', 05:04:48 INFO - 'HOME': '/home/cltbld', 05:04:48 INFO - 'LANG': 'en_US.UTF-8', 05:04:48 INFO - 'LANGUAGE': 'en_US:en', 05:04:48 INFO - 'LOGNAME': 'cltbld', 05:04:48 INFO - 'MAIL': '/var/mail/cltbld', 05:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:48 INFO - 'MOZ_NO_REMOTE': '1', 05:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:48 INFO - 'NO_EM_RESTART': '1', 05:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:48 INFO - 'PWD': '/builds/slave/test', 05:04:48 INFO - 'SHELL': '/bin/bash', 05:04:48 INFO - 'SHLVL': '1', 05:04:48 INFO - 'TERM': 'linux', 05:04:48 INFO - 'TMOUT': '86400', 05:04:48 INFO - 'USER': 'cltbld', 05:04:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', 05:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:48 INFO - '_': '/tools/buildbot/bin/python'} 05:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:49 INFO - Downloading/unpacking jsonschema==2.5.1 05:04:49 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 05:04:49 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 05:04:49 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 05:04:49 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 05:04:49 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 05:04:49 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 05:04:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:04:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:04:50 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 05:04:50 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 05:04:50 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 05:04:50 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 05:04:50 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 05:04:50 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 05:04:51 INFO - Downloading functools32-3.2.3-2.tar.gz 05:04:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:04:51 INFO - warning: no files found matching '*.txt' 05:04:51 INFO - no previously-included directories found matching 'build' 05:04:51 INFO - no previously-included directories found matching 'dist' 05:04:51 INFO - no previously-included directories found matching '.git*' 05:04:51 INFO - Installing collected packages: jsonschema, functools32 05:04:51 INFO - Running setup.py install for functools32 05:04:51 INFO - warning: no files found matching '*.txt' 05:04:51 INFO - no previously-included directories found matching 'build' 05:04:51 INFO - no previously-included directories found matching 'dist' 05:04:51 INFO - no previously-included directories found matching '.git*' 05:04:51 INFO - Successfully installed jsonschema functools32 05:04:51 INFO - Cleaning up... 05:04:51 INFO - Return code: 0 05:04:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:51 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 0x7ff0e990ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2819790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816930>, '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 0x2817830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817cc0>, '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': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', '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 05:04:51 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 05:04:51 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 05:04:51 INFO - Using env: {'DISPLAY': ':0', 05:04:51 INFO - 'HOME': '/home/cltbld', 05:04:51 INFO - 'LANG': 'en_US.UTF-8', 05:04:51 INFO - 'LANGUAGE': 'en_US:en', 05:04:51 INFO - 'LOGNAME': 'cltbld', 05:04:51 INFO - 'MAIL': '/var/mail/cltbld', 05:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:51 INFO - 'MOZ_NO_REMOTE': '1', 05:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:51 INFO - 'NO_EM_RESTART': '1', 05:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:51 INFO - 'PWD': '/builds/slave/test', 05:04:51 INFO - 'SHELL': '/bin/bash', 05:04:51 INFO - 'SHLVL': '1', 05:04:51 INFO - 'TERM': 'linux', 05:04:51 INFO - 'TMOUT': '86400', 05:04:51 INFO - 'USER': 'cltbld', 05:04:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', 05:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:51 INFO - '_': '/tools/buildbot/bin/python'} 05:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:04:51 INFO - Cleaning up... 05:04:51 INFO - Return code: 0 05:04:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:51 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 0x7ff0e990ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2819790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816930>, '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 0x2817830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817cc0>, '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': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', '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 05:04:51 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 05:04:51 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 05:04:51 INFO - Using env: {'DISPLAY': ':0', 05:04:51 INFO - 'HOME': '/home/cltbld', 05:04:51 INFO - 'LANG': 'en_US.UTF-8', 05:04:51 INFO - 'LANGUAGE': 'en_US:en', 05:04:51 INFO - 'LOGNAME': 'cltbld', 05:04:51 INFO - 'MAIL': '/var/mail/cltbld', 05:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:51 INFO - 'MOZ_NO_REMOTE': '1', 05:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:51 INFO - 'NO_EM_RESTART': '1', 05:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:51 INFO - 'PWD': '/builds/slave/test', 05:04:51 INFO - 'SHELL': '/bin/bash', 05:04:51 INFO - 'SHLVL': '1', 05:04:51 INFO - 'TERM': 'linux', 05:04:51 INFO - 'TMOUT': '86400', 05:04:51 INFO - 'USER': 'cltbld', 05:04:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', 05:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:51 INFO - '_': '/tools/buildbot/bin/python'} 05:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:51 INFO - Downloading/unpacking blobuploader==1.2.4 05:04:51 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 05:04:51 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 05:04:51 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 05:04:51 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 05:04:51 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 05:04:51 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 05:04:53 INFO - Downloading blobuploader-1.2.4.tar.gz 05:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:04:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:04:53 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 05:04:53 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 05:04:53 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 05:04:53 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 05:04:53 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 05:04:53 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 05:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:04:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:04:54 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 05:04:54 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 05:04:54 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 05:04:54 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 05:04:54 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 05:04:54 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 05:04:54 INFO - Downloading docopt-0.6.1.tar.gz 05:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:04:54 INFO - Installing collected packages: blobuploader, requests, docopt 05:04:54 INFO - Running setup.py install for blobuploader 05:04:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:04:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:04:54 INFO - Running setup.py install for requests 05:04:55 INFO - Running setup.py install for docopt 05:04:55 INFO - Successfully installed blobuploader requests docopt 05:04:55 INFO - Cleaning up... 05:04:55 INFO - Return code: 0 05:04:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:55 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 0x7ff0e990ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2819790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816930>, '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 0x2817830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817cc0>, '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': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', '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 05:04:55 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 05:04:55 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 05:04:55 INFO - Using env: {'DISPLAY': ':0', 05:04:55 INFO - 'HOME': '/home/cltbld', 05:04:55 INFO - 'LANG': 'en_US.UTF-8', 05:04:55 INFO - 'LANGUAGE': 'en_US:en', 05:04:55 INFO - 'LOGNAME': 'cltbld', 05:04:55 INFO - 'MAIL': '/var/mail/cltbld', 05:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:55 INFO - 'MOZ_NO_REMOTE': '1', 05:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:55 INFO - 'NO_EM_RESTART': '1', 05:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:55 INFO - 'PWD': '/builds/slave/test', 05:04:55 INFO - 'SHELL': '/bin/bash', 05:04:55 INFO - 'SHLVL': '1', 05:04:55 INFO - 'TERM': 'linux', 05:04:55 INFO - 'TMOUT': '86400', 05:04:55 INFO - 'USER': 'cltbld', 05:04:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', 05:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:55 INFO - '_': '/tools/buildbot/bin/python'} 05:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:04:55 INFO - Running setup.py (path:/tmp/pip-yf60RW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:04:55 INFO - Running setup.py (path:/tmp/pip-HRVO0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:04:55 INFO - Running setup.py (path:/tmp/pip-4XvcHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:04:55 INFO - Running setup.py (path:/tmp/pip-VOprhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:04:55 INFO - Running setup.py (path:/tmp/pip-JTF1sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:04:55 INFO - Running setup.py (path:/tmp/pip-C7wBfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:04:55 INFO - Running setup.py (path:/tmp/pip-AOOLgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:04:55 INFO - Running setup.py (path:/tmp/pip-mABIln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:04:55 INFO - Running setup.py (path:/tmp/pip-2KrcL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:04:56 INFO - Running setup.py (path:/tmp/pip-N08FpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:04:56 INFO - Running setup.py (path:/tmp/pip-3TfedY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:04:56 INFO - Running setup.py (path:/tmp/pip-Zo5fKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:04:56 INFO - Running setup.py (path:/tmp/pip-JB22XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:04:56 INFO - Running setup.py (path:/tmp/pip-0pcdFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:56 INFO - Running setup.py (path:/tmp/pip-I2qRxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:04:56 INFO - Running setup.py (path:/tmp/pip-Bs8sBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:04:56 INFO - Running setup.py (path:/tmp/pip-fOUYDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:04:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:04:56 INFO - Running setup.py install for manifestparser 05:04:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:04:56 INFO - Running setup.py install for mozcrash 05:04:56 INFO - Running setup.py install for mozdebug 05:04:56 INFO - Running setup.py install for mozdevice 05:04:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:04:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:04:57 INFO - Running setup.py install for mozfile 05:04:57 INFO - Running setup.py install for mozhttpd 05:04:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:04:57 INFO - Running setup.py install for mozinfo 05:04:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:04:57 INFO - Running setup.py install for mozInstall 05:04:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:04:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:04:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:04:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:04:57 INFO - Running setup.py install for mozleak 05:04:57 INFO - Running setup.py install for mozlog 05:04:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:04:57 INFO - Running setup.py install for moznetwork 05:04:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:04:57 INFO - Running setup.py install for mozprocess 05:04:57 INFO - Running setup.py install for mozprofile 05:04:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:04:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:04:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:04:57 INFO - Running setup.py install for mozrunner 05:04:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:04:58 INFO - Running setup.py install for mozscreenshot 05:04:58 INFO - Running setup.py install for moztest 05:04:58 INFO - Running setup.py install for mozversion 05:04:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:04:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:04:58 INFO - Cleaning up... 05:04:58 INFO - Return code: 0 05:04:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:58 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 0x7ff0e990ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2819790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816930>, '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 0x2817830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817cc0>, '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': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', '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 05:04:58 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 05:04:58 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 05:04:58 INFO - Using env: {'DISPLAY': ':0', 05:04:58 INFO - 'HOME': '/home/cltbld', 05:04:58 INFO - 'LANG': 'en_US.UTF-8', 05:04:58 INFO - 'LANGUAGE': 'en_US:en', 05:04:58 INFO - 'LOGNAME': 'cltbld', 05:04:58 INFO - 'MAIL': '/var/mail/cltbld', 05:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:58 INFO - 'MOZ_NO_REMOTE': '1', 05:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:58 INFO - 'NO_EM_RESTART': '1', 05:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:58 INFO - 'PWD': '/builds/slave/test', 05:04:58 INFO - 'SHELL': '/bin/bash', 05:04:58 INFO - 'SHLVL': '1', 05:04:58 INFO - 'TERM': 'linux', 05:04:58 INFO - 'TMOUT': '86400', 05:04:58 INFO - 'USER': 'cltbld', 05:04:58 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', 05:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:58 INFO - '_': '/tools/buildbot/bin/python'} 05:04:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:04:58 INFO - Running setup.py (path:/tmp/pip-YQgwSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:04:58 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)) 05:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:04:58 INFO - Running setup.py (path:/tmp/pip-AXLx2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:04:58 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)) 05:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:04:58 INFO - Running setup.py (path:/tmp/pip-1SHrhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:04:58 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)) 05:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:04:58 INFO - Running setup.py (path:/tmp/pip-_PZaMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:04:58 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)) 05:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:04:58 INFO - Running setup.py (path:/tmp/pip-2ok4y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:04:59 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)) 05:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:04:59 INFO - Running setup.py (path:/tmp/pip-OOntWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:04:59 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)) 05:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:04:59 INFO - Running setup.py (path:/tmp/pip-RM2YUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:04:59 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)) 05:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:04:59 INFO - Running setup.py (path:/tmp/pip-q9anFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:04:59 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)) 05:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:04:59 INFO - Running setup.py (path:/tmp/pip-5LYzsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:04:59 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)) 05:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:04:59 INFO - Running setup.py (path:/tmp/pip-M5Y0V8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:04:59 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)) 05:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:04:59 INFO - Running setup.py (path:/tmp/pip-fdxlka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:04:59 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)) 05:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:04:59 INFO - Running setup.py (path:/tmp/pip-siIGpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:04:59 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)) 05:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:04:59 INFO - Running setup.py (path:/tmp/pip-7CvV5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:04:59 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)) 05:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:04:59 INFO - Running setup.py (path:/tmp/pip-SrSI6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:04:59 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)) 05:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:59 INFO - Running setup.py (path:/tmp/pip-AIoV6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:59 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)) 05:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:04:59 INFO - Running setup.py (path:/tmp/pip-lsoz6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:04:59 INFO - Running setup.py (path:/tmp/pip-ohX2qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:04:59 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)) 05:04:59 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)) 05:04:59 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)) 05:04:59 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)) 05:04:59 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)) 05:04:59 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)) 05:04:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:04:59 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 05:04:59 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 05:04:59 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 05:04:59 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 05:04:59 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 05:04:59 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 05:05:01 INFO - Downloading blessings-1.6.tar.gz 05:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:05:01 INFO - Installing collected packages: blessings 05:05:01 INFO - Running setup.py install for blessings 05:05:02 INFO - Successfully installed blessings 05:05:02 INFO - Cleaning up... 05:05:02 INFO - Return code: 0 05:05:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:05:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:02 INFO - Reading from file tmpfile_stdout 05:05:02 INFO - Current package versions: 05:05:02 INFO - argparse == 1.2.1 05:05:02 INFO - blessings == 1.6 05:05:02 INFO - blobuploader == 1.2.4 05:05:02 INFO - docopt == 0.6.1 05:05:02 INFO - functools32 == 3.2.3-2 05:05:02 INFO - jsonschema == 2.5.1 05:05:02 INFO - manifestparser == 1.1 05:05:02 INFO - mozInstall == 1.12 05:05:02 INFO - mozcrash == 1.0 05:05:02 INFO - mozdebug == 0.1 05:05:02 INFO - mozdevice == 0.48 05:05:02 INFO - mozfile == 1.2 05:05:02 INFO - mozhttpd == 0.7 05:05:02 INFO - mozinfo == 0.9 05:05:02 INFO - mozleak == 0.1 05:05:02 INFO - mozlog == 3.4 05:05:02 INFO - moznetwork == 0.27 05:05:02 INFO - mozprocess == 0.23 05:05:02 INFO - mozprofile == 0.28 05:05:02 INFO - mozrunner == 6.13 05:05:02 INFO - mozscreenshot == 0.1 05:05:02 INFO - mozsystemmonitor == 0.3 05:05:02 INFO - moztest == 0.7 05:05:02 INFO - mozversion == 1.4 05:05:02 INFO - psutil == 3.1.1 05:05:02 INFO - requests == 1.2.3 05:05:02 INFO - wsgiref == 0.1.2 05:05:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:02 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 0x7ff0e990ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2819790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816930>, '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 0x2817830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817cc0>, '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': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', '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 05:05:02 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 05:05:02 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 05:05:02 INFO - Using env: {'DISPLAY': ':0', 05:05:02 INFO - 'HOME': '/home/cltbld', 05:05:02 INFO - 'LANG': 'en_US.UTF-8', 05:05:02 INFO - 'LANGUAGE': 'en_US:en', 05:05:02 INFO - 'LOGNAME': 'cltbld', 05:05:02 INFO - 'MAIL': '/var/mail/cltbld', 05:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:02 INFO - 'MOZ_NO_REMOTE': '1', 05:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:02 INFO - 'NO_EM_RESTART': '1', 05:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:02 INFO - 'PWD': '/builds/slave/test', 05:05:02 INFO - 'SHELL': '/bin/bash', 05:05:02 INFO - 'SHLVL': '1', 05:05:02 INFO - 'TERM': 'linux', 05:05:02 INFO - 'TMOUT': '86400', 05:05:02 INFO - 'USER': 'cltbld', 05:05:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', 05:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:02 INFO - '_': '/tools/buildbot/bin/python'} 05:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:02 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)) 05:05:02 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)) 05:05:02 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)) 05:05:02 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)) 05:05:02 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)) 05:05:02 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)) 05:05:02 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)) 05:05:02 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)) 05:05:02 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)) 05:05:02 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)) 05:05:02 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)) 05:05:02 INFO - Cleaning up... 05:05:02 INFO - Return code: 0 05:05:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:02 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 0x7ff0e990ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2819790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816930>, '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 0x2817830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817cc0>, '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': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', '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 05:05:02 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 05:05:02 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 05:05:02 INFO - Using env: {'DISPLAY': ':0', 05:05:02 INFO - 'HOME': '/home/cltbld', 05:05:02 INFO - 'LANG': 'en_US.UTF-8', 05:05:02 INFO - 'LANGUAGE': 'en_US:en', 05:05:02 INFO - 'LOGNAME': 'cltbld', 05:05:02 INFO - 'MAIL': '/var/mail/cltbld', 05:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:02 INFO - 'MOZ_NO_REMOTE': '1', 05:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:02 INFO - 'NO_EM_RESTART': '1', 05:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:02 INFO - 'PWD': '/builds/slave/test', 05:05:02 INFO - 'SHELL': '/bin/bash', 05:05:02 INFO - 'SHLVL': '1', 05:05:02 INFO - 'TERM': 'linux', 05:05:02 INFO - 'TMOUT': '86400', 05:05:02 INFO - 'USER': 'cltbld', 05:05:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', 05:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:02 INFO - '_': '/tools/buildbot/bin/python'} 05:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:05:02 INFO - Cleaning up... 05:05:02 INFO - Return code: 0 05:05:02 INFO - Running post-action listener: _resource_record_post_action 05:05:02 INFO - Running post-action listener: _start_resource_monitoring 05:05:02 INFO - Starting resource monitoring. 05:05:02 INFO - [mozharness: 2016-11-09 13:05:02.818832Z] Finished create-virtualenv step (success) 05:05:02 INFO - [mozharness: 2016-11-09 13:05:02.819340Z] Running install step. 05:05:02 INFO - Running pre-action listener: _resource_record_pre_action 05:05:02 INFO - Running main action method: install 05:05:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:03 INFO - Reading from file tmpfile_stdout 05:05:03 INFO - Detecting whether we're running mozinstall >=1.0... 05:05:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:05:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:05:03 INFO - Reading from file tmpfile_stdout 05:05:03 INFO - Output received: 05:05:03 INFO - Usage: mozinstall [options] installer 05:05:03 INFO - Options: 05:05:03 INFO - -h, --help show this help message and exit 05:05:03 INFO - -d DEST, --destination=DEST 05:05:03 INFO - Directory to install application into. [default: 05:05:03 INFO - "/builds/slave/test"] 05:05:03 INFO - --app=APP Application being installed. [default: firefox] 05:05:03 INFO - mkdir: /builds/slave/test/build/application 05:05:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:05:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:05:19 INFO - Reading from file tmpfile_stdout 05:05:19 INFO - Output received: 05:05:19 INFO - /builds/slave/test/build/application/firefox/firefox 05:05:19 INFO - Running post-action listener: _resource_record_post_action 05:05:19 INFO - [mozharness: 2016-11-09 13:05:19.233816Z] Finished install step (success) 05:05:19 INFO - [mozharness: 2016-11-09 13:05:19.234061Z] Running run-tests step. 05:05:19 INFO - Running pre-action listener: _resource_record_pre_action 05:05:19 INFO - Running main action method: run_tests 05:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:05:19 INFO - Python 2.7.3 05:05:19 INFO - Return code: 0 05:05:19 INFO - grabbing minidump binary from tooltool 05:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:19 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 0x2816930>, '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 0x2817830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:05:19 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 05:05:19 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 05:05:19 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 05:05:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:05:19 INFO - Return code: 0 05:05:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:05:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:05:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:05:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:05:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 05:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 05:05:19 INFO - Using env: {'DISPLAY': ':0', 05:05:19 INFO - 'HOME': '/home/cltbld', 05:05:19 INFO - 'LANG': 'en_US.UTF-8', 05:05:19 INFO - 'LANGUAGE': 'en_US:en', 05:05:19 INFO - 'LOGNAME': 'cltbld', 05:05:19 INFO - 'MAIL': '/var/mail/cltbld', 05:05:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:05:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:19 INFO - 'MOZ_NO_REMOTE': '1', 05:05:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:19 INFO - 'NO_EM_RESTART': '1', 05:05:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:19 INFO - 'PWD': '/builds/slave/test', 05:05:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:05:19 INFO - 'SHELL': '/bin/bash', 05:05:19 INFO - 'SHLVL': '1', 05:05:19 INFO - 'TERM': 'linux', 05:05:19 INFO - 'TMOUT': '86400', 05:05:19 INFO - 'USER': 'cltbld', 05:05:19 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468', 05:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:19 INFO - '_': '/tools/buildbot/bin/python'} 05:05:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 05:05:19 INFO - mozversion application_buildid: 20161109022623 05:05:19 INFO - mozversion application_changeset: 533b6efe3528fcb022c857e84bc432b77b5507ef 05:05:19 INFO - mozversion application_display_name: Nightly 05:05:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:05:19 INFO - mozversion application_name: Firefox 05:05:19 INFO - mozversion application_remotingname: firefox 05:05:19 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 05:05:19 INFO - mozversion application_vendor: Mozilla 05:05:19 INFO - mozversion application_version: 52.0a1 05:05:19 INFO - mozversion platform_buildid: 20161109022623 05:05:19 INFO - mozversion platform_changeset: 533b6efe3528fcb022c857e84bc432b77b5507ef 05:05:19 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 05:05:19 INFO - mozversion platform_version: 52.0a1 05:05:19 INFO - using testdate: 1478696719 05:05:19 INFO - actual date: 1478696719 05:05:19 INFO - starting webserver on 'localhost:35524' 05:05:19 INFO - SUITE-START | Running 2 tests 05:05:19 INFO - TEST-START | dromaeo_css 05:05:19 INFO - operating with platform_type : linux_ 05:05:19 INFO - Initialising browser for dromaeo_css test... 05:05:19 INFO - TEST-INFO | started process 18645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphjYULw/profile http://localhost:35524/getInfo.html) 05:05:24 INFO - PROCESS | 18645 | __metrics Screen width/height:1600/1200 05:05:24 INFO - PROCESS | 18645 | colorDepth:24 05:05:24 INFO - PROCESS | 18645 | Browser inner width/height: 1024/697 05:05:24 INFO - PROCESS | 18645 | __metrics 05:05:24 INFO - PROCESS | 18645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:05:24 INFO - PROCESS | 18645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:05:25 INFO - PROCESS | 18645 | console.error: PushService: 05:05:25 INFO - PROCESS | 18645 | stateChangeProcessEnqueue: Error transitioning state 05:05:25 INFO - PROCESS | 18645 | UnknownError 05:05:26 INFO - TEST-INFO | 18645: exit 0 05:05:26 INFO - Browser initialized. 05:05:26 INFO - Running cycle 1/1 for dromaeo_css test... 05:05:26 INFO - TEST-INFO | started process 18725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphjYULw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:38 INFO - PROCESS | 18725 | RSS: Main: 174383104 05:05:38 INFO - PROCESS | 18725 | 05:06:29 INFO - PROCESS | 18725 | 1478696789869 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:08:43 INFO - PROCESS | 18725 | Cycle 1(1): loaded http://localhost:35524/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35524/tests/dromaeo/cssquery-ext.html) 05:08:44 INFO - PROCESS | 18725 | RSS: Main: 314396672 05:08:44 INFO - PROCESS | 18725 | 05:11:47 INFO - PROCESS | 18725 | Cycle 1(1): loaded http://localhost:35524/tests/dromaeo/cssquery-ext.html (next: http://localhost:35524/tests/dromaeo/cssquery-jquery.html) 05:11:48 INFO - PROCESS | 18725 | RSS: Main: 288284672 05:11:48 INFO - PROCESS | 18725 | 05:14:50 INFO - PROCESS | 18725 | Cycle 1(1): loaded http://localhost:35524/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35524/tests/dromaeo/cssquery-mootools.html) 05:14:50 INFO - PROCESS | 18725 | RSS: Main: 246362112 05:14:50 INFO - PROCESS | 18725 | 05:17:53 INFO - PROCESS | 18725 | Cycle 1(1): loaded http://localhost:35524/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35524/tests/dromaeo/cssquery-prototype.html) 05:17:53 INFO - PROCESS | 18725 | RSS: Main: 219959296 05:17:53 INFO - PROCESS | 18725 | 05:20:57 INFO - PROCESS | 18725 | Cycle 1(1): loaded http://localhost:35524/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35524/tests/dromaeo/cssquery-yui.html) 05:20:57 INFO - PROCESS | 18725 | RSS: Main: 222318592 05:20:57 INFO - PROCESS | 18725 | 05:24:00 INFO - PROCESS | 18725 | Cycle 1(1): loaded http://localhost:35524/tests/dromaeo/cssquery-yui.html (next: http://localhost:35524/tests/dromaeo/cssquery-dojo.html) 05:24:00 INFO - PROCESS | 18725 | RSS: Main: 313032704 05:24:00 INFO - PROCESS | 18725 | 05:24:00 INFO - PROCESS | 18725 | __start_tp_report 05:24:00 INFO - PROCESS | 18725 | _x_x_mozilla_page_load 05:24:00 INFO - PROCESS | 18725 | _x_x_mozilla_page_load_details 05:24:00 INFO - PROCESS | 18725 | |i|pagename|runs| 05:24:00 INFO - PROCESS | 18725 | |0;dojo.html;2533.7466253374655;2559.027569523581;2573.06083279603;2577.342777591714;2614.5424550703624;4503.0318481526465;4555.020670555829;4663.090697314025;4686.695364801286;4708;4595.356650068993;4643.373144625474;4651.953480465194;4672.042231342575;4696.107739529495;4269;4298.247806633843;4300.97849510752;4329.328954012133;4388.23205938961;4365.934510982338;4370.97814510927;4402.40567523385;4403.669724770639;4442.022754993913;4177.644900183488;4249.405083288342;4366.519682834917;4376.518582955872;4378.387025816388;4296.076343586113;4306.1172459645695;4307.310830267143;4314.503832059322;4320.805563749639;4282.229198744225;4282.807273672693;4285.785710714452;4290.120525292307;4293.699441039129;4623.0984957933215;4674.345591617176;4677.74272415017;4688.484266730657;4761.26200438929;5010.624203184776;5011.1481048221885;5018.949810501921;5020.523050310215;5022.824201152942;4894.4371397289415;5034.446210916796;5042.193249080129;5051.747412629391;5096.745162741848;4630.259158534618;4660.067986402665;4703.17694403478;4704.50602686713;4707.811687532529;5113.897722045538;5121.795128194831;5125.8718532037;5132.127538318495;5133.8716532087;4893.681910675795;4928.778204980785;4935.087008903292;4938.950610493849;4942.728149951715;4982.402111746614;5007.073691367109;5010.549050585392;5014.473480284518;5016.172331565251;5021.59827213822;5062.4684408137355;5069.898602027939;5071.46749591295;5073.137566613685;4987;4991.276264941564;4997.650164488451;4999.200127979506;5038.370203724535;4001.8999525011527;4131.938020929689;4173.812178451977;4175.561566035583;4196.097838964637;3546.3261980223674;3564.8574057037945;3583.498310236569;3589.892303230855;3611.638836116367;4334.241507736197;4335.609795118455;4339.132173565299;4373.737575745466;4377.474703035656;5011.924821127686;5016.297718319438;5023.2115224378285;5029.698218106925;5062.82280120194;4210.705250632487;4246.532881383046;4278.914421711611;4300.397944287803;4323.1785960668;4472.172648060119;4478.2610869206865;4491.775411229425;4502.842400515966;4514.81940722374;4791.5687588117235;4798.95201047985;4799.208130658472;4802.303665968345;4834.468208497133;4841.612670986242;4886.462489126122;4892.192788189909;5050.39395272555;5060.063888180551;4684.461286952044;4686.5782079613;4691.859244222679;4781.737004464649;4789.018251258553;4926.630502712383;4935.481774413634;4938.678985865908;4943.233798761198;4983.152864013199;4978.47725988766;4998.275250088789;5000.4749501303295;5001.42483614389;5040.773165207501;4655.511171326962;4712.0104777997;4798.832040878552;4821.710697358169;4841.782119804688;4871.634627402888;4875.341828853059;4879.926801098058;4914.680545764514;4916.70499770015;4752.334673145693;4768.713877167381;4797.928031079467;4800.807967681393;4851.223804191312;4729.8108075677965;4782.928256076231;4872.098661747588;4890.559849613552;4933.210686290176;4813.927791083067;4814.855554333376;4836.46798852119;4841.878953026203;4903.77932993009 05:24:00 INFO - PROCESS | 18725 | |1;ext.html;560.2576586023519;572.4990633195954;576.4926864359363;578.9334226563947;597.8535258861577;27286.04498842541;36301.81849090754;37760.62239377609;37820;40710;38539.22921541575;38830.80584597073;38842.22315553687;38858.02854928628;39175;7488.513246638965;7638;7642.770716878475;7642.923570764305;7644.46488745788;7382.593957332371;7583.962080189619;9586.808263834719;9841.704748857546;9860.161886239679;9872.90127098727;9910.603575856958;9922.851157232648;9927.305088643798;9931.50342482873;9301.581428835685;9354.391964522285;9355.672551460666;9356.345055846094;9382.765430864249;9783.217342612574;9852;9854.507274636311;9857.880555680491;9858.457784821832;35074.12314692127;35076.473852892224;35322.29355412903;35393.64606353955;35440.291194175974;2908.200244932639;2917.7082291770867;2940.6324209473814;2969.747571456407;3060.3114299282706;26553.73446265532;27061;27114.457710845672;27673.861630691918;27832.582511262346;3383.5263063171174;3455.4644030175364;3462.4460086386057;3463.445848664227;3485.7385696072643;224880;227734;228605;229032;229516;46487.30269045967;46867.48493862906;46871;46908.7654561725;46921.76539117283;30809.845950770552;31672;31745.365092698015;49610;49637.25544116769;13847;14110.153390796586;14116.22360770147;14125.152490850582;14126;8807.823843523222;10478.476076196159;10502.894971050344;10578;10599.523021464052;14053.71892562143;16351.182440877908;16742.83257167437;16892.746608800877;17244.137793110294;6409.9679501602195;6708.966455167693;6762.323767623198;6845.486588505882;6940.41006514452;763.2482005224849;841.6212704282975;892.2237653241722;944.5230158769778;1008.193445243802;24643.87678061634;26353.47293054128;26689;26851.597226041624;26933.595996060074;869.4522450856047;892.1791951404723;931.7437704631145;945.5555888732284;958.5973890965811;13577.389017494237;13685.24731139777;14106.435742570182;14184.929075354557;14222;349983;352360;353006;353249;353278;44805.327920081225;45220.77389613031;45226.77386613046;45252;45568.54431455709;990.4601991914424;1062.8724553053528;1105.264998775805;1120.4845770945294;1169.6724917023078;24282.15012474555;27621.86189069042;27796.583051254653;28056.29859253535;28366.716332836408;38114.237715244984;38711.61288387193;38737.225255494166;38746.22507549889;38778.22443551169;268368;270130;270681;271076.6446167757;272395;21039.263625773023;21729.06657601267;21787.891060544596;22605.547889042457;22951.540969180856;38116.61883381242;38366;38768.03079923025;39320;39379.409308860966;32986.34027319488;33246.335073298884;33258.83370583132;33260.1684957878;33285;32981.835090824396;33232.501512477815;33414.832925836185;34261.82869085639;34278.65721342755;32423;32473.512897306086;32963.835180823946;33310;33369.49945750767;28406;30115.397692046474;30512.84743576268;30541.236469087562;30628.693713063476;23041.308760737204;23327.41681457977;23634.409139771644;23673.763262367844;23686.52626947417 05:24:00 INFO - PROCESS | 18725 | |2;jquery.html;338.4178716393914;355.1990261959281;361.6618461738274;361.71424574586086;386.10616422980814;12722.68193295167;13265.7346853063;15251.237438128104;15753.527394178165;16805.915970420163;15542.378304867792;15843.683126337495;15972.361105555763;16033.198340083007;16184;4789.305550695164;4797.7361245131415;5011.273365362021;5015.2226404907115;5020.824271150511;4894.926576101344;5009.323741294933;5014.072396606622;5016.347874776274;5017.347744793172;4988.301637770715;4989.550940415362;4993.6254780891395;4994.925076123861;4995.525425084629;4727.338172655831;4803.615710743132;4804.999999999965;4817.542333478314;4826.638002149853;4266.168097221043;4268.231718290706;4268.9146217075795;4269.658427325807;4272.829086836523;19470.902645486825;19573.80426195734;19712.802871971384;19828.70256946147;20271.29050483226;1913.5885784556388;1948.074664534349;2141.0900367343816;2440.3533063738123;2466.2477944227003;12196.512139514409;12436.626901192978;12883.871161288362;13285.535006274831;13423;1652.5785924589272;1658.4444211189266;1691.5686499942435;1693.745938109281;1694.3984885365765;66825;68001.65999169972;68046.65976670134;68258.3174168257;68964.65517672429;9387.436753794795;9435.622575097057;9810.264230182765;9831.213502919749;9884.752881177885;13013.804792928113;13072.542461013818;13083.476660933646;13086.345682716017;13096.476140954446;6568.67156642166;6946.756863509753;7009.404200642901;7065.010898474217;7206.315400036988;6294.842628934313;6372.107904893319;6387.169667943138;6821.658917054127;6840;5826.242588463558;5933.228680271537;5997.760089596454;6010.759569617167;6091.908621370683;1757.5869670627392;1777.2713187593283;1792.9282828686707;1793.1124093573765;1828.5885675723123;647.2588885725818;766.9914063007128;805.5730462854697;857.7819496315248;868.1578868497547;15824.60438489047;16469.34122635105;16515.33938642441;16704.582385440463;17236.396726114526;849.5964416902045;853.4537895746727;856.4090777363599;885.7829831691276;933.178802653674;9558;9592.808143837085;9867.506624668738;9909.554070066864;10021.198304135653;271753;275711;276539;276597;364151;67389.77292598177;78919;80841;82236.1875621815;84145.57927210325;390.4163275902544;411.90526178979;412.8761371588511;414.4839674605136;415.31265755175235;9078.954605226932;9407.294452916196;9451.905480945103;9532.714018579454;9641.228701703707;31646.683533164374;33919.321613567095;34217.828910855285;37679.81160094182;38262.42606360851;46908.53091469042;46972.7651361741;47829.28256076231;48827.26759098545;50330.748346258035;6876.896846547406;7059.223485416703;7226;7440.479166458513;7558.9244107558225;10509.211809114195;10808.18938579594;10832.729181770204;10889.727756806144;11085.27945683528;4602.102589994919;4766.976165119152;7590.696372145273;8667.17661822126;9037.909620903707;9285.117913798178;9287.164155226063;9511.239100872051;9546.42721436716;9608.519574021131;8589.484630921916;8669.739907802776;8775.824483510167;8839.337049721167;9357.532123393667;7078.433725302067;7243.3843123333;7343.118825740945;7401.59291238987;7489.625518724151;8026.518408895485;8655.6970506032;8844.248238899765;8986.370954033417;8990.415622984485 05:24:00 INFO - PROCESS | 18725 | |3;mootools.html;1283.089006805168;1331.420831938107;1338.7456383287174;1588.6028492876787;1588.8570028697416;6360.745570177193;6805.319468053192;6818.386345228922;6820.42026427753;6820.556663816855;5780.248567686195;5986.281646202451;6458.709358078886;6607.603543787376;6659.933400665992;2026.63520566298;2045.856790024699;2047.5597746484502;2052.1586149678633;2052.466358746729;2041.1325186795552;2073.3676228750223;2074.678424844152;2080.9687854682193;2085.165933626546;1742.0766993493405;1796.1917137288272;1955.9706604400944;2003.0986056274662;2008.2569449303705;2006.2075480185317;2032.471557395088;2032.5833204193252;2033.044469099521;2034.0541648133542;1990.7212990181386;2035.196097541463;2035.5928814237063;2037.663785475395;2040.8469364797552;6721.596704197715;6762.898556521656;6762.966185169092;6767.187937447488;6769.627670478122;3991.2017596480528;4128.112455821983;4153.7300075494995;4157.064660451404;4160.084781348099;2631.1185752772844;2734.849583272919;2857.0857325655797;2864.8281103133877;2867.956980645292;840.2443263644051;879.715951918119;899.9370044096916;911.9407238529475;912.0286894457381;8781.473111613324;8788.736337909873;8818.426802257896;8823.55882205887;8830.381873268874;3609.9278014439565;3785.6782173515007;3804.6766024887643;3863.4977452931503;3893.5133108361456;6596.60420374779;7627.084749830056;7632.122305934778;7634.6946122154495;7635.160132385433;3974.125692347679;4152.1280531088205;4158.750474971512;4159.417681524589;4163.562825903297;3903.5510916244993;3907.941380879289;3909.4722212500947;3911.6675082618294;3915;2862.6135471711054;2987.4025194961096;2995.326051638364;3003.6996300369788;3031.9090427287215;959.6305422412421;979.637534112383;990.4305024610877;993.8906720260766;1012.549415510091;607.441154138194;682.7917485167072;723.280336065618;738.9741359052407;780.3055280800093;4220.388043733641;4256.425382573375;4389.209942210369;4423.845165419195;4547.8635640930825;791.1218547412368;826.7809030606894;857.0700789643182;869.6956065377068;888.5601627194451;2686.9731302687114;2911.796174267823;3042.1481985044225;3049.847507624654;3078.061191336664;7815.413843961725;8079.878801817978;8120.675172993014;8122.837543249102;8137.430379873352;7008.299170082951;7329.45029122818;7332.0834895638045;7554.697812087565;8073.798155046171;5789.102689083199;6104.11490333908;6296.150019747367;6369.235691717024;6453.064305675651;4408;4527.932081018853;4664.113818374498;4670.976645116889;4709.411323584552;7464.6267686614365;7472.962635186789;7508.549487030796;7536.7362142324755;7541.283578060075;7534.434917381109;7644.80887977805;7717.6527056281475;7772.727954521564;7822.256885595859;5491.395946445968;5562.638428502134;5574;5618.297712785902;5619.831405057855;6187.535934804818;6259.906101408574;6260.780872669435;6260.812175634556;6262.2172228471445;5738.426157384228;5830.271216097988;5896.380880007538;5953.1070339449425;6015.759369625166;5705.201271822031;5913.526917846476;5974.492168165754;5981.641101533922;6051.062085376773;5173.249878767633;5222.321098257355;5227.320448341691;5279.52484276417;5282.55098316632;3923.2349691809823;3991.5609282978266;4049.3318602430268;4105.774182419996;4204.642605378577;3945.605439456146;3980.024893901013;4018.8593399230886;4039.3537034074407;4060.2285565742413 05:24:00 INFO - PROCESS | 18725 | |4;prototype.html;291.0932445432477;296.16481522107654;300.60020173169687;306.86037852777;307.97074277943585;4732.781708438265;4735.810567577301;4758.214894542396;4759.738214398207;4766.690165139264;4672.39258896343;4676.438827340716;4682.204025315696;4696.506866778982;4706.788194531246;3723.22619648361;3736.626337366255;3737.177820879402;3742.7567208131522;3751.381022131345;3435.312937412515;3763.4757923041075;3778.2431169506176;3783.621637836222;3784.48909397232;3576.159602493412;3650.7809531428197;3651.6348365163403;3659.323025240339;3675.577308609504;3620.71034317254;3623.239119784822;3625.7280703947044;3652.61200743717;3657.3965295726175;2956.63042119735;3036.30165062037;3123.5007196545785;3192.5211218317204;3198.680131986806;4565.748883811389;4572.222722137211;4586.220342541776;4598.931016034762;4620.561046700558;4136.91726165478;4138.379243113527;4144.41978123063;4145.834166633331;4153.7507749535125;4614.17739992701;4626.7223966562115;4764.666473346867;4857.271409288635;4873.732829464329;3463.9480407793903;3479.7546992668904;3483.860645574174;3489.7906125632544;3490.581130264359;5068.847934561933;5082.567981721558;5103.183490641517;5116.769745361467;5134.8202812901745;3398.575178102737;3517.278957813642;3524.242287908112;3532.275883443888;3535.964640353615;3600.6579374959338;3618.6381361863605;3624.9818750906074;3630.2013557017412;3634.818259087035;4106.9116684078745;4126.855560055384;4127.195196936568;4143.7306575072525;4156;4883.4628190898975;4889.364382630235;4890.633202509826;4915.9508404916205;4916.852494425173;1182.0225388176784;1184.1048636084863;1187.958421455245;1195.479966214682;1197.898178654824;814.8451794159091;834.9396266741326;842.6755699055908;844.5608283692445;848.626604294121;4235.957640423557;4246.723962942398;4266.146770645883;4268.530461649216;4276.550962148929;4883.658143929962;4896.4124305083615;4898.926516102261;4907.411110666742;4914.582260507826;4243.257429949746;4248.596383343577;4255.255330317244;4266.573342665709;4285.7000009999;2480.3055144559553;2589.41738108924;2600.752928471792;2623.753716984417;2623.8163328566816;4609.340637370544;4682.508336624674;4692.507286734912;4740.739259340769;4751.691140075884;4991.950080499221;5008.824691135866;5078.415982162025;5079.949200508022;5086.64393492452;4797.7525843281;4811.398575178103;4818.4217893852965;4828.251620998751;4829.830955916596;4867.805287788448;4963.181075122564;4989.276554899592;5044.646874718735;5056;4955.231939049453;4959.652824302264;4978.32792572998;4990.575801056951;5004.122629487986;4804.183288840835;4821.276808478756;4832.589229915356;4836.322914791862;4842.83050093245;3534.7879127252445;3672.5042119313553;3678.6321367863;3706.777593344408;3714.7399682022;5030.3963524377305;5036.899262014813;5066.138756411493;5066.695998240118;5070.678705447937;4924.285978533021;4948.579370753382;4949.455559888482;4956.330895329229;4959.553640172402;4742.644301677457;4899.485554016777;4910.779014944264;4933.58064564516;4952.77712502931;4803.567678908915;4810.350602668595;4810.687305325143;4813.975930120327;4820.276958456119;4942.406911170682;4946.3817022872145;4951.603871690329;4953.578945789648;4961.107000739901;4652.348671185969;4809.2305231162845;4838.758062096811;4849.55681466163;4861.902761944671 05:24:00 INFO - PROCESS | 18725 | |5;yui.html;617.9134921111046;618.4217756397768;621.5307442880625;667.876442858071;681.2710399872137;10898.836517452235;11067.778644427126;11384.146189035835;11644.068474522039;11655.708607284821;11821;12111.515539378437;12115.697107572316;12136.878631213685;12138.575149869755;587.885362354341;713.4898547538496;726.8073960400499;727.5670975769409;729.3399473476512;515.6777014366021;524.3288590604033;524.5855773938584;540.9080456322415;594.4531031451075;755.6523998960457;757.6779868555869;760.8364201696634;762.523422860712;762.6644276518342;607.0954278125605;748.4424104042523;750.0811505905277;750.3097150621414;750.6209364271008;461.8383565751993;544.705858836228;562.7467639562213;564.7402194990309;565.3554947360013;12179.573714919936;12197;12208.938955305255;12222.083343749255;12226.388680565937;11443.25618834773;11544.595939142173;11761.58834440799;11969.962678178006;11989.46047427859;9883;9989.80020399588;9993.250506212064;10151.64469243573;10266.486675666187;3938.1532970411213;3946.7237293389476;3951.9802400988096;3953.189596132786;3953.446517487554;45989;47595.76202118967;47645.76177119127;48724.512754872354;49286.7535662323;9025.50359730208;9050.909490905007;9128.132827381389;9150.40522366044;9442.10300021497;16164.515064548083;16207.756883646754;16239.51281461558;16292;16512.09183494895;5673.496523421297;5752.252207213036;5819.592628516048;5925.140854576062;5961.463468287875;3483.1292176955762;3489.5986961499243;3530.3645343838357;3532.116970757311;3543.3090547343536;2553.7573930476574;2618.4763047390597;2623.396618777692;2626.9474610508064;2638.353603367187;458.8990422107131;461.20902651951394;462.97685115744076;465.46704023892454;466.2679593038964;515.4639175257765;518.6602775182262;545.5526468296039;559.1752165555773;577.7371296060282;6982.162140543066;7132.750353737594;7156.964215178891;7200.099987501562;7246.021787058785;573.3377948469441;585.7861880413618;592.4490224091636;593.5133190783603;597.3727586034646;3340.766146369731;3458.8962331130106;3462.8441720122655;3569.5359603251413;3663.4504824276037;62127;68768.31231687719;70883.64558177177;71371.64314178396;72214;61964;63234.68382658057;63359.6832015837;63409.68295158587;63954.36045639484;35594.28811423809;44570.77714611406;48606;55061.72469137629;55269.44730552643;7267.672954717156;7561;7934.722284720238;7973.6810527580565;8130.552819594743;38750.418743718306;38990.2201955965;39237.80381098076;40562.865095268266;40956.38565421462;29859.31266186054;49062.26406603975;53741.73129134329;53947;54842.451575483734;10911.181661375587;11038.834417483904;11065.5020524075;11076.169287303646;11939.820902686293;12177.208481449032;12393.318367489876;12443.191192572454;12664.264042107416;12867.806982895077;9993.950030249802;10526.315789473965;10606.46967651599;10613.363198208132;10748.731281718019;10920.126389888632;11005.834912476159;11199;11208.327500350006;11592.47833847462;10014.64948726791;10074.647387341407;10288.228382871464;10469.633562825264;10871.075958543612;9026.548672566214;9146.365616953693;9227.677031303872;9284.3036772241;9288.303377246599;8815.515146666994;9125.361224714472;9215.354925155174;9279.86080208811;9328.440293582407 05:24:00 INFO - PROCESS | 18725 | __end_tp_report 05:24:00 INFO - PROCESS | 18725 | __start_cc_report 05:24:00 INFO - PROCESS | 18725 | _x_x_mozilla_cycle_collect,1394 05:24:00 INFO - PROCESS | 18725 | __end_cc_report 05:24:00 INFO - PROCESS | 18725 | __startTimestamp1478697840849__endTimestamp 05:24:00 INFO - PROCESS | 18725 | 05:24:00 INFO - PROCESS | 18725 | ------- Summary: start ------- 05:24:00 INFO - PROCESS | 18725 | Number of tests: 6 05:24:00 INFO - PROCESS | 18725 | 05:24:00 INFO - PROCESS | 18725 | [#0] dojo.html Cycles:165 Average:4618.73 Median:4768.71 stddev:499.77 (10.5%) stddev-sans-first:473.79 05:24:00 INFO - PROCESS | 18725 | Values: 2533.7 2559.0 2573.1 2577.3 2614.5 4503.0 4555.0 4663.1 4686.7 4708.0 4595.4 4643.4 4652.0 4672.0 4696.1 4269.0 4298.2 4301.0 4329.3 4388.2 4365.9 4371.0 4402.4 4403.7 4442.0 4177.6 4249.4 4366.5 4376.5 4378.4 4296.1 4306.1 4307.3 4314.5 4320.8 4282.2 4282.8 4285.8 4290.1 4293.7 4623.1 4674.3 4677.7 4688.5 4761.3 5010.6 5011.1 5018.9 5020.5 5022.8 4894.4 5034.4 5042.2 5051.7 5096.7 4630.3 4660.1 4703.2 4704.5 4707.8 5113.9 5121.8 5125.9 5132.1 5133.9 4893.7 4928.8 4935.1 4939.0 4942.7 4982.4 5007.1 5010.5 5014.5 5016.2 5021.6 5062.5 5069.9 5071.5 5073.1 4987.0 4991.3 4997.7 4999.2 5038.4 4001.9 4131.9 4173.8 4175.6 4196.1 3546.3 3564.9 3583.5 3589.9 3611.6 4334.2 4335.6 4339.1 4373.7 4377.5 5011.9 5016.3 5023.2 5029.7 5062.8 4210.7 4246.5 4278.9 4300.4 4323.2 4472.2 4478.3 4491.8 4502.8 4514.8 4791.6 4799.0 4799.2 4802.3 4834.5 4841.6 4886.5 4892.2 5050.4 5060.1 4684.5 4686.6 4691.9 4781.7 4789.0 4926.6 4935.5 4938.7 4943.2 4983.2 4978.5 4998.3 5000.5 5001.4 5040.8 4655.5 4712.0 4798.8 4821.7 4841.8 4871.6 4875.3 4879.9 4914.7 4916.7 4752.3 4768.7 4797.9 4800.8 4851.2 4729.8 4782.9 4872.1 4890.6 4933.2 4813.9 4814.9 4836.5 4841.9 4903.8 05:24:00 INFO - PROCESS | 18725 | 05:24:00 INFO - PROCESS | 18725 | [#1] ext.html Cycles:180 Average:42827.26 Median:3462.95 stddev:75645.69 (2184.4%) stddev-sans-first:75791.33 05:24:00 INFO - PROCESS | 18725 | Values: 560.3 572.5 576.5 578.9 597.9 27286.0 36301.8 37760.6 37820.0 40710.0 38539.2 38830.8 38842.2 38858.0 39175.0 7488.5 7638.0 7642.8 7642.9 7644.5 7382.6 7584.0 9586.8 9841.7 9860.2 9872.9 9910.6 9922.9 9927.3 9931.5 9301.6 9354.4 9355.7 9356.3 9382.8 9783.2 9852.0 9854.5 9857.9 9858.5 35074.1 35076.5 35322.3 35393.6 35440.3 2908.2 2917.7 2940.6 2969.7 3060.3 26553.7 27061.0 27114.5 27673.9 27832.6 3383.5 3455.5 3462.4 3463.4 3485.7 224880.0 227734.0 228605.0 229032.0 229516.0 46487.3 46867.5 46871.0 46908.8 46921.8 30809.8 31672.0 31745.4 49610.0 49637.3 13847.0 14110.2 14116.2 14125.2 14126.0 8807.8 10478.5 10502.9 10578.0 10599.5 14053.7 16351.2 16742.8 16892.7 17244.1 6410.0 6709.0 6762.3 6845.5 6940.4 763.2 841.6 892.2 944.5 1008.2 24643.9 26353.5 26689.0 26851.6 26933.6 869.5 892.2 931.7 945.6 958.6 13577.4 13685.2 14106.4 14184.9 14222.0 349983.0 352360.0 353006.0 353249.0 353278.0 44805.3 45220.8 45226.8 45252.0 45568.5 990.5 1062.9 1105.3 1120.5 1169.7 24282.2 27621.9 27796.6 28056.3 28366.7 38114.2 38711.6 38737.2 38746.2 38778.2 268368.0 270130.0 270681.0 271076.6 272395.0 21039.3 21729.1 21787.9 22605.5 22951.5 38116.6 38366.0 38768.0 39320.0 39379.4 32986.3 33246.3 33258.8 33260.2 33285.0 32981.8 33232.5 33414.8 34261.8 34278.7 32423.0 32473.5 32963.8 33310.0 33369.5 28406.0 30115.4 30512.8 30541.2 30628.7 23041.3 23327.4 23634.4 23673.8 23686.5 05:24:00 INFO - PROCESS | 18725 | 05:24:00 INFO - PROCESS | 18725 | [#2] jquery.html Cycles:180 Average:20989.41 Median:4988.93 stddev:49629.02 (994.8%) stddev-sans-first:49744.02 05:24:00 INFO - PROCESS | 18725 | Values: 338.4 355.2 361.7 361.7 386.1 12722.7 13265.7 15251.2 15753.5 16805.9 15542.4 15843.7 15972.4 16033.2 16184.0 4789.3 4797.7 5011.3 5015.2 5020.8 4894.9 5009.3 5014.1 5016.3 5017.3 4988.3 4989.6 4993.6 4994.9 4995.5 4727.3 4803.6 4805.0 4817.5 4826.6 4266.2 4268.2 4268.9 4269.7 4272.8 19470.9 19573.8 19712.8 19828.7 20271.3 1913.6 1948.1 2141.1 2440.4 2466.2 12196.5 12436.6 12883.9 13285.5 13423.0 1652.6 1658.4 1691.6 1693.7 1694.4 66825.0 68001.7 68046.7 68258.3 68964.7 9387.4 9435.6 9810.3 9831.2 9884.8 13013.8 13072.5 13083.5 13086.3 13096.5 6568.7 6946.8 7009.4 7065.0 7206.3 6294.8 6372.1 6387.2 6821.7 6840.0 5826.2 5933.2 5997.8 6010.8 6091.9 1757.6 1777.3 1792.9 1793.1 1828.6 647.3 767.0 805.6 857.8 868.2 15824.6 16469.3 16515.3 16704.6 17236.4 849.6 853.5 856.4 885.8 933.2 9558.0 9592.8 9867.5 9909.6 10021.2 271753.0 275711.0 276539.0 276597.0 364151.0 67389.8 78919.0 80841.0 82236.2 84145.6 390.4 411.9 412.9 414.5 415.3 9079.0 9407.3 9451.9 9532.7 9641.2 31646.7 33919.3 34217.8 37679.8 38262.4 46908.5 46972.8 47829.3 48827.3 50330.7 6876.9 7059.2 7226.0 7440.5 7558.9 10509.2 10808.2 10832.7 10889.7 11085.3 4602.1 4767.0 7590.7 8667.2 9037.9 9285.1 9287.2 9511.2 9546.4 9608.5 8589.5 8669.7 8775.8 8839.3 9357.5 7078.4 7243.4 7343.1 7401.6 7489.6 8026.5 8655.7 8844.2 8986.4 8990.4 05:24:00 INFO - PROCESS | 18725 | 05:24:00 INFO - PROCESS | 18725 | [#3] mootools.html Cycles:180 Average:4400.56 Median:5386.97 stddev:2338.04 (43.4%) stddev-sans-first:2332.86 05:24:00 INFO - PROCESS | 18725 | Values: 1283.1 1331.4 1338.7 1588.6 1588.9 6360.7 6805.3 6818.4 6820.4 6820.6 5780.2 5986.3 6458.7 6607.6 6659.9 2026.6 2045.9 2047.6 2052.2 2052.5 2041.1 2073.4 2074.7 2081.0 2085.2 1742.1 1796.2 1956.0 2003.1 2008.3 2006.2 2032.5 2032.6 2033.0 2034.1 1990.7 2035.2 2035.6 2037.7 2040.8 6721.6 6762.9 6763.0 6767.2 6769.6 3991.2 4128.1 4153.7 4157.1 4160.1 2631.1 2734.8 2857.1 2864.8 2868.0 840.2 879.7 899.9 911.9 912.0 8781.5 8788.7 8818.4 8823.6 8830.4 3609.9 3785.7 3804.7 3863.5 3893.5 6596.6 7627.1 7632.1 7634.7 7635.2 3974.1 4152.1 4158.8 4159.4 4163.6 3903.6 3907.9 3909.5 3911.7 3915.0 2862.6 2987.4 2995.3 3003.7 3031.9 959.6 979.6 990.4 993.9 1012.5 607.4 682.8 723.3 739.0 780.3 4220.4 4256.4 4389.2 4423.8 4547.9 791.1 826.8 857.1 869.7 888.6 2687.0 2911.8 3042.1 3049.8 3078.1 7815.4 8079.9 8120.7 8122.8 8137.4 7008.3 7329.5 7332.1 7554.7 8073.8 5789.1 6104.1 6296.2 6369.2 6453.1 4408.0 4527.9 4664.1 4671.0 4709.4 7464.6 7473.0 7508.5 7536.7 7541.3 7534.4 7644.8 7717.7 7772.7 7822.3 5491.4 5562.6 5574.0 5618.3 5619.8 6187.5 6259.9 6260.8 6260.8 6262.2 5738.4 5830.3 5896.4 5953.1 6015.8 5705.2 5913.5 5974.5 5981.6 6051.1 5173.2 5222.3 5227.3 5279.5 5282.6 3923.2 3991.6 4049.3 4105.8 4204.6 3945.6 3980.0 4018.9 4039.4 4060.2 05:24:00 INFO - PROCESS | 18725 | 05:24:00 INFO - PROCESS | 18725 | [#4] prototype.html Cycles:180 Average:4063.32 Median:4679.32 stddev:1185.71 (25.3%) stddev-sans-first:1154.74 05:24:00 INFO - PROCESS | 18725 | Values: 291.1 296.2 300.6 306.9 308.0 4732.8 4735.8 4758.2 4759.7 4766.7 4672.4 4676.4 4682.2 4696.5 4706.8 3723.2 3736.6 3737.2 3742.8 3751.4 3435.3 3763.5 3778.2 3783.6 3784.5 3576.2 3650.8 3651.6 3659.3 3675.6 3620.7 3623.2 3625.7 3652.6 3657.4 2956.6 3036.3 3123.5 3192.5 3198.7 4565.7 4572.2 4586.2 4598.9 4620.6 4136.9 4138.4 4144.4 4145.8 4153.8 4614.2 4626.7 4764.7 4857.3 4873.7 3463.9 3479.8 3483.9 3489.8 3490.6 5068.8 5082.6 5103.2 5116.8 5134.8 3398.6 3517.3 3524.2 3532.3 3536.0 3600.7 3618.6 3625.0 3630.2 3634.8 4106.9 4126.9 4127.2 4143.7 4156.0 4883.5 4889.4 4890.6 4916.0 4916.9 1182.0 1184.1 1188.0 1195.5 1197.9 814.8 834.9 842.7 844.6 848.6 4236.0 4246.7 4266.1 4268.5 4276.6 4883.7 4896.4 4898.9 4907.4 4914.6 4243.3 4248.6 4255.3 4266.6 4285.7 2480.3 2589.4 2600.8 2623.8 2623.8 4609.3 4682.5 4692.5 4740.7 4751.7 4992.0 5008.8 5078.4 5079.9 5086.6 4797.8 4811.4 4818.4 4828.3 4829.8 4867.8 4963.2 4989.3 5044.6 5056.0 4955.2 4959.7 4978.3 4990.6 5004.1 4804.2 4821.3 4832.6 4836.3 4842.8 3534.8 3672.5 3678.6 3706.8 3714.7 5030.4 5036.9 5066.1 5066.7 5070.7 4924.3 4948.6 4949.5 4956.3 4959.6 4742.6 4899.5 4910.8 4933.6 4952.8 4803.6 4810.4 4810.7 4814.0 4820.3 4942.4 4946.4 4951.6 4953.6 4961.1 4652.3 4809.2 4838.8 4849.6 4861.9 05:24:00 INFO - PROCESS | 18725 | 05:24:00 INFO - PROCESS | 18725 | [#5] yui.html Cycles:180 Average:14240.62 Median:49174.51 stddev:18388.95 (37.4%) stddev-sans-first:18412.09 05:24:00 INFO - PROCESS | 18725 | Values: 617.9 618.4 621.5 667.9 681.3 10898.8 11067.8 11384.1 11644.1 11655.7 11821.0 12111.5 12115.7 12136.9 12138.6 587.9 713.5 726.8 727.6 729.3 515.7 524.3 524.6 540.9 594.5 755.7 757.7 760.8 762.5 762.7 607.1 748.4 750.1 750.3 750.6 461.8 544.7 562.7 564.7 565.4 12179.6 12197.0 12208.9 12222.1 12226.4 11443.3 11544.6 11761.6 11970.0 11989.5 9883.0 9989.8 9993.3 10151.6 10266.5 3938.2 3946.7 3952.0 3953.2 3953.4 45989.0 47595.8 47645.8 48724.5 49286.8 9025.5 9050.9 9128.1 9150.4 9442.1 16164.5 16207.8 16239.5 16292.0 16512.1 5673.5 5752.3 5819.6 5925.1 5961.5 3483.1 3489.6 3530.4 3532.1 3543.3 2553.8 2618.5 2623.4 2626.9 2638.4 458.9 461.2 463.0 465.5 466.3 515.5 518.7 545.6 559.2 577.7 6982.2 7132.8 7157.0 7200.1 7246.0 573.3 585.8 592.4 593.5 597.4 3340.8 3458.9 3462.8 3569.5 3663.5 62127.0 68768.3 70883.6 71371.6 72214.0 61964.0 63234.7 63359.7 63409.7 63954.4 35594.3 44570.8 48606.0 55061.7 55269.4 7267.7 7561.0 7934.7 7973.7 8130.6 38750.4 38990.2 39237.8 40562.9 40956.4 29859.3 49062.3 53741.7 53947.0 54842.5 10911.2 11038.8 11065.5 11076.2 11939.8 12177.2 12393.3 12443.2 12664.3 12867.8 9994.0 10526.3 10606.5 10613.4 10748.7 10920.1 11005.8 11199.0 11208.3 11592.5 10014.6 10074.6 10288.2 10469.6 10871.1 9026.5 9146.4 9227.7 9284.3 9288.3 8815.5 9125.4 9215.4 9279.9 9328.4 05:24:00 INFO - PROCESS | 18725 | -------- Summary: end -------- 05:24:00 INFO - PROCESS | 18725 | 05:24:01 INFO - TEST-INFO | 18725: exit 0 05:24:01 INFO - TEST-OK | dromaeo_css | took 1122296ms 05:24:01 INFO - TEST-START | kraken 05:24:01 INFO - operating with platform_type : linux_ 05:24:01 INFO - Initialising browser for kraken test... 05:24:01 INFO - TEST-INFO | started process 19033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf9Lepv/profile http://localhost:35524/getInfo.html) 05:24:06 INFO - PROCESS | 19033 | __metrics Screen width/height:1600/1200 05:24:06 INFO - PROCESS | 19033 | colorDepth:24 05:24:06 INFO - PROCESS | 19033 | Browser inner width/height: 1024/697 05:24:06 INFO - PROCESS | 19033 | __metrics 05:24:06 INFO - PROCESS | 19033 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:24:06 INFO - PROCESS | 19033 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:24:07 INFO - PROCESS | 19033 | console.error: PushService: 05:24:07 INFO - PROCESS | 19033 | stateChangeProcessEnqueue: Error transitioning state 05:24:07 INFO - PROCESS | 19033 | UnknownError 05:24:08 INFO - TEST-INFO | 19033: exit 0 05:24:08 INFO - Browser initialized. 05:24:08 INFO - Running cycle 1/1 for kraken test... 05:24:08 INFO - TEST-INFO | started process 19116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf9Lepv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:20 INFO - PROCESS | 19116 | RSS: Main: 174718976 05:24:20 INFO - PROCESS | 19116 | 05:24:23 INFO - PROCESS | 19116 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35524/tests/kraken/driver.html?testName=audio-beat-detection) 05:24:24 INFO - PROCESS | 19116 | RSS: Main: 231354368 05:24:24 INFO - PROCESS | 19116 | 05:24:27 INFO - PROCESS | 19116 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35524/tests/kraken/driver.html?testName=audio-dft) 05:24:27 INFO - PROCESS | 19116 | RSS: Main: 217747456 05:24:27 INFO - PROCESS | 19116 | 05:24:30 INFO - PROCESS | 19116 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35524/tests/kraken/driver.html?testName=audio-fft) 05:24:31 INFO - PROCESS | 19116 | RSS: Main: 299823104 05:24:31 INFO - PROCESS | 19116 | 05:24:33 INFO - PROCESS | 19116 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35524/tests/kraken/driver.html?testName=audio-oscillator) 05:24:34 INFO - PROCESS | 19116 | RSS: Main: 210845696 05:24:34 INFO - PROCESS | 19116 | 05:24:36 INFO - PROCESS | 19116 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35524/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:24:37 INFO - PROCESS | 19116 | RSS: Main: 213946368 05:24:37 INFO - PROCESS | 19116 | 05:24:40 INFO - PROCESS | 19116 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35524/tests/kraken/driver.html?testName=imaging-darkroom) 05:24:40 INFO - PROCESS | 19116 | RSS: Main: 249716736 05:24:40 INFO - PROCESS | 19116 | 05:24:44 INFO - PROCESS | 19116 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35524/tests/kraken/driver.html?testName=imaging-desaturate) 05:24:45 INFO - PROCESS | 19116 | RSS: Main: 248926208 05:24:45 INFO - PROCESS | 19116 | 05:24:47 INFO - PROCESS | 19116 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35524/tests/kraken/driver.html?testName=json-parse-financial) 05:24:48 INFO - PROCESS | 19116 | RSS: Main: 248479744 05:24:48 INFO - PROCESS | 19116 | 05:24:50 INFO - PROCESS | 19116 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35524/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:24:50 INFO - PROCESS | 19116 | RSS: Main: 210669568 05:24:50 INFO - PROCESS | 19116 | 05:24:52 INFO - PROCESS | 19116 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35524/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:24:53 INFO - PROCESS | 19116 | RSS: Main: 217223168 05:24:53 INFO - PROCESS | 19116 | 05:24:55 INFO - PROCESS | 19116 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35524/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:24:55 INFO - PROCESS | 19116 | RSS: Main: 226099200 05:24:55 INFO - PROCESS | 19116 | 05:24:58 INFO - PROCESS | 19116 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35524/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:24:59 INFO - PROCESS | 19116 | RSS: Main: 235819008 05:24:59 INFO - PROCESS | 19116 | 05:25:02 INFO - PROCESS | 19116 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35524/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:25:03 INFO - PROCESS | 19116 | RSS: Main: 231493632 05:25:03 INFO - PROCESS | 19116 | 05:25:04 INFO - PROCESS | 19116 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35524/tests/kraken/driver.html?testName=ai-astar) 05:25:05 INFO - PROCESS | 19116 | RSS: Main: 282820608 05:25:05 INFO - PROCESS | 19116 | 05:25:05 INFO - PROCESS | 19116 | __start_tp_report 05:25:05 INFO - PROCESS | 19116 | _x_x_mozilla_page_load 05:25:05 INFO - PROCESS | 19116 | _x_x_mozilla_page_load_details 05:25:05 INFO - PROCESS | 19116 | |i|pagename|runs| 05:25:05 INFO - PROCESS | 19116 | |0;ai-astar;109;117;115;116;116;117;116;117;115;117 05:25:05 INFO - PROCESS | 19116 | |1;audio-beat-detection;164;128;130;177;131;128;130;129;168;128 05:25:05 INFO - PROCESS | 19116 | |2;audio-dft;160;160;162;162;161;162;163;161;161;161 05:25:05 INFO - PROCESS | 19116 | |3;audio-fft;76;76;77;112;77;76;76;76;101;77 05:25:05 INFO - PROCESS | 19116 | |4;audio-oscillator;83;84;114;84;85;84;114;83;83;122 05:25:05 INFO - PROCESS | 19116 | |5;imaging-gaussian-blur;116;117;116;117;117;116;117;116;117;117 05:25:05 INFO - PROCESS | 19116 | |6;imaging-darkroom;146;146;147;147;147;146;147;147;147;146 05:25:05 INFO - PROCESS | 19116 | |7;imaging-desaturate;85;85;85;85;85;85;86;85;85;86 05:25:05 INFO - PROCESS | 19116 | |8;json-parse-financial;65;63;64;63;64;64;64;64;65;64 05:25:05 INFO - PROCESS | 19116 | |9;json-stringify-tinderbox;67;67;67;66;68;66;66;66;67;66 05:25:05 INFO - PROCESS | 19116 | |10;stanford-crypto-aes;84;83;83;86;84;85;84;84;83;83 05:25:05 INFO - PROCESS | 19116 | |11;stanford-crypto-ccm;146;142;141;149;142;141;148;139;195;142 05:25:05 INFO - PROCESS | 19116 | |12;stanford-crypto-pbkdf2;181;180;180;181;180;176;177;180;179;182 05:25:05 INFO - PROCESS | 19116 | |13;stanford-crypto-sha256-iterative;68;69;69;69;68;69;71;71;69;70 05:25:05 INFO - PROCESS | 19116 | __end_tp_report 05:25:05 INFO - PROCESS | 19116 | __start_cc_report 05:25:05 INFO - PROCESS | 19116 | _x_x_mozilla_cycle_collect,1987 05:25:05 INFO - PROCESS | 19116 | __end_cc_report 05:25:05 INFO - PROCESS | 19116 | __startTimestamp1478697905154__endTimestamp 05:25:05 INFO - PROCESS | 19116 | 05:25:05 INFO - PROCESS | 19116 | ------- Summary: start ------- 05:25:05 INFO - PROCESS | 19116 | Number of tests: 14 05:25:05 INFO - PROCESS | 19116 | 05:25:05 INFO - PROCESS | 19116 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.50 stddev:2.42 (2.1%) stddev-sans-first:0.83 05:25:05 INFO - PROCESS | 19116 | Values: 109.0 117.0 115.0 116.0 116.0 117.0 116.0 117.0 115.0 117.0 05:25:05 INFO - PROCESS | 19116 | 05:25:05 INFO - PROCESS | 19116 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:130.50 stddev:19.85 (15.2%) stddev-sans-first:19.28 05:25:05 INFO - PROCESS | 19116 | Values: 164.0 128.0 130.0 177.0 131.0 128.0 130.0 129.0 168.0 128.0 05:25:05 INFO - PROCESS | 19116 | 05:25:05 INFO - PROCESS | 19116 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 05:25:05 INFO - PROCESS | 19116 | Values: 160.0 160.0 162.0 162.0 161.0 162.0 163.0 161.0 161.0 161.0 05:25:05 INFO - PROCESS | 19116 | 05:25:05 INFO - PROCESS | 19116 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:12.97 (17.1%) stddev-sans-first:13.55 05:25:05 INFO - PROCESS | 19116 | Values: 76.0 76.0 77.0 112.0 77.0 76.0 76.0 76.0 101.0 77.0 05:25:05 INFO - PROCESS | 19116 | 05:25:05 INFO - PROCESS | 19116 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:83.50 stddev:16.08 (19.3%) stddev-sans-first:16.59 05:25:05 INFO - PROCESS | 19116 | Values: 83.0 84.0 114.0 84.0 85.0 84.0 114.0 83.0 83.0 122.0 05:25:05 INFO - PROCESS | 19116 | 05:25:05 INFO - PROCESS | 19116 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:25:05 INFO - PROCESS | 19116 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 05:25:05 INFO - PROCESS | 19116 | 05:25:05 INFO - PROCESS | 19116 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:25:05 INFO - PROCESS | 19116 | Values: 146.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 05:25:05 INFO - PROCESS | 19116 | 05:25:05 INFO - PROCESS | 19116 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 05:25:05 INFO - PROCESS | 19116 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 86.0 85.0 85.0 86.0 05:25:05 INFO - PROCESS | 19116 | 05:25:05 INFO - PROCESS | 19116 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 05:25:05 INFO - PROCESS | 19116 | Values: 65.0 63.0 64.0 63.0 64.0 64.0 64.0 64.0 65.0 64.0 05:25:05 INFO - PROCESS | 19116 | 05:25:05 INFO - PROCESS | 19116 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 05:25:05 INFO - PROCESS | 19116 | Values: 67.0 67.0 67.0 66.0 68.0 66.0 66.0 66.0 67.0 66.0 05:25:05 INFO - PROCESS | 19116 | 05:25:05 INFO - PROCESS | 19116 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 05:25:05 INFO - PROCESS | 19116 | Values: 84.0 83.0 83.0 86.0 84.0 85.0 84.0 84.0 83.0 83.0 05:25:05 INFO - PROCESS | 19116 | 05:25:05 INFO - PROCESS | 19116 | [#11] stanford-crypto-ccm Cycles:10 Average:148.50 Median:144.00 stddev:16.66 (11.6%) stddev-sans-first:17.65 05:25:05 INFO - PROCESS | 19116 | Values: 146.0 142.0 141.0 149.0 142.0 141.0 148.0 139.0 195.0 142.0 05:25:05 INFO - PROCESS | 19116 | 05:25:05 INFO - PROCESS | 19116 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:180.00 stddev:1.84 (1.0%) stddev-sans-first:1.88 05:25:05 INFO - PROCESS | 19116 | Values: 181.0 180.0 180.0 181.0 180.0 176.0 177.0 180.0 179.0 182.0 05:25:05 INFO - PROCESS | 19116 | 05:25:05 INFO - PROCESS | 19116 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.06 (1.5%) stddev-sans-first:1.01 05:25:05 INFO - PROCESS | 19116 | Values: 68.0 69.0 69.0 69.0 68.0 69.0 71.0 71.0 69.0 70.0 05:25:05 INFO - PROCESS | 19116 | -------- Summary: end -------- 05:25:05 INFO - PROCESS | 19116 | 05:25:06 INFO - TEST-INFO | 19116: exit 0 05:25:06 INFO - TEST-OK | kraken | took 64930ms 05:25:06 INFO - SUITE-END | took 1187s 05:25:06 INFO - Completed test suite (00:19:47) 05:25:06 INFO - javascript benchmark 05:25:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2533.7466253374655, 2559.027569523581, 2573.06083279603, 2577.342777591714, 2614.5424550703624, 4503.0318481526465, 4555.020670555829, 4663.090697314025, 4686.695364801286, 4708.0, 4595.356650068993, 4643.373144625474, 4651.953480465194, 4672.042231342575, 4696.107739529495, 4269.0, 4298.247806633843, 4300.97849510752, 4329.328954012133, 4388.23205938961, 4365.934510982338, 4370.97814510927, 4402.40567523385, 4403.669724770639, 4442.022754993913, 4177.644900183488, 4249.405083288342, 4366.519682834917, 4376.518582955872, 4378.387025816388, 4296.076343586113, 4306.1172459645695, 4307.310830267143, 4314.503832059322, 4320.805563749639, 4282.229198744225, 4282.807273672693, 4285.785710714452, 4290.120525292307, 4293.699441039129, 4623.0984957933215, 4674.345591617176, 4677.74272415017, 4688.484266730657, 4761.26200438929, 5010.624203184776, 5011.1481048221885, 5018.949810501921, 5020.523050310215, 5022.824201152942, 4894.4371397289415, 5034.446210916796, 5042.193249080129, 5051.747412629391, 5096.745162741848, 4630.259158534618, 4660.067986402665, 4703.17694403478, 4704.50602686713, 4707.811687532529, 5113.897722045538, 5121.795128194831, 5125.8718532037, 5132.127538318495, 5133.8716532087, 4893.681910675795, 4928.778204980785, 4935.087008903292, 4938.950610493849, 4942.728149951715, 4982.402111746614, 5007.073691367109, 5010.549050585392, 5014.473480284518, 5016.172331565251, 5021.59827213822, 5062.4684408137355, 5069.898602027939, 5071.46749591295, 5073.137566613685, 4987.0, 4991.276264941564, 4997.650164488451, 4999.200127979506, 5038.370203724535, 4001.8999525011527, 4131.938020929689, 4173.812178451977, 4175.561566035583, 4196.097838964637, 3546.3261980223674, 3564.8574057037945, 3583.498310236569, 3589.892303230855, 3611.638836116367, 4334.241507736197, 4335.609795118455, 4339.132173565299, 4373.737575745466, 4377.474703035656, 5011.924821127686, 5016.297718319438, 5023.2115224378285, 5029.698218106925, 5062.82280120194, 4210.705250632487, 4246.532881383046, 4278.914421711611, 4300.397944287803, 4323.1785960668, 4472.172648060119, 4478.2610869206865, 4491.775411229425, 4502.842400515966, 4514.81940722374, 4791.5687588117235, 4798.95201047985, 4799.208130658472, 4802.303665968345, 4834.468208497133, 4841.612670986242, 4886.462489126122, 4892.192788189909, 5050.39395272555, 5060.063888180551, 4684.461286952044, 4686.5782079613, 4691.859244222679, 4781.737004464649, 4789.018251258553, 4926.630502712383, 4935.481774413634, 4938.678985865908, 4943.233798761198, 4983.152864013199, 4978.47725988766, 4998.275250088789, 5000.4749501303295, 5001.42483614389, 5040.773165207501, 4655.511171326962, 4712.0104777997, 4798.832040878552, 4821.710697358169, 4841.782119804688, 4871.634627402888, 4875.341828853059, 4879.926801098058, 4914.680545764514, 4916.70499770015, 4752.334673145693, 4768.713877167381, 4797.928031079467, 4800.807967681393, 4851.223804191312, 4729.8108075677965, 4782.928256076231, 4872.098661747588, 4890.559849613552, 4933.210686290176, 4813.927791083067, 4814.855554333376, 4836.46798852119, 4841.878953026203, 4903.77932993009], "value": 4585.532174803821, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.2576586023519, 572.4990633195954, 576.4926864359363, 578.9334226563947, 597.8535258861577, 27286.04498842541, 36301.81849090754, 37760.62239377609, 37820.0, 40710.0, 38539.22921541575, 38830.80584597073, 38842.22315553687, 38858.02854928628, 39175.0, 7488.513246638965, 7638.0, 7642.770716878475, 7642.923570764305, 7644.46488745788, 7382.593957332371, 7583.962080189619, 9586.808263834719, 9841.704748857546, 9860.161886239679, 9872.90127098727, 9910.603575856958, 9922.851157232648, 9927.305088643798, 9931.50342482873, 9301.581428835685, 9354.391964522285, 9355.672551460666, 9356.345055846094, 9382.765430864249, 9783.217342612574, 9852.0, 9854.507274636311, 9857.880555680491, 9858.457784821832, 35074.12314692127, 35076.473852892224, 35322.29355412903, 35393.64606353955, 35440.291194175974, 2908.200244932639, 2917.7082291770867, 2940.6324209473814, 2969.747571456407, 3060.3114299282706, 26553.73446265532, 27061.0, 27114.457710845672, 27673.861630691918, 27832.582511262346, 3383.5263063171174, 3455.4644030175364, 3462.4460086386057, 3463.445848664227, 3485.7385696072643, 224880.0, 227734.0, 228605.0, 229032.0, 229516.0, 46487.30269045967, 46867.48493862906, 46871.0, 46908.7654561725, 46921.76539117283, 30809.845950770552, 31672.0, 31745.365092698015, 49610.0, 49637.25544116769, 13847.0, 14110.153390796586, 14116.22360770147, 14125.152490850582, 14126.0, 8807.823843523222, 10478.476076196159, 10502.894971050344, 10578.0, 10599.523021464052, 14053.71892562143, 16351.182440877908, 16742.83257167437, 16892.746608800877, 17244.137793110294, 6409.9679501602195, 6708.966455167693, 6762.323767623198, 6845.486588505882, 6940.41006514452, 763.2482005224849, 841.6212704282975, 892.2237653241722, 944.5230158769778, 1008.193445243802, 24643.87678061634, 26353.47293054128, 26689.0, 26851.597226041624, 26933.595996060074, 869.4522450856047, 892.1791951404723, 931.7437704631145, 945.5555888732284, 958.5973890965811, 13577.389017494237, 13685.24731139777, 14106.435742570182, 14184.929075354557, 14222.0, 349983.0, 352360.0, 353006.0, 353249.0, 353278.0, 44805.327920081225, 45220.77389613031, 45226.77386613046, 45252.0, 45568.54431455709, 990.4601991914424, 1062.8724553053528, 1105.264998775805, 1120.4845770945294, 1169.6724917023078, 24282.15012474555, 27621.86189069042, 27796.583051254653, 28056.29859253535, 28366.716332836408, 38114.237715244984, 38711.61288387193, 38737.225255494166, 38746.22507549889, 38778.22443551169, 268368.0, 270130.0, 270681.0, 271076.6446167757, 272395.0, 21039.263625773023, 21729.06657601267, 21787.891060544596, 22605.547889042457, 22951.540969180856, 38116.61883381242, 38366.0, 38768.03079923025, 39320.0, 39379.409308860966, 32986.34027319488, 33246.335073298884, 33258.83370583132, 33260.1684957878, 33285.0, 32981.835090824396, 33232.501512477815, 33414.832925836185, 34261.82869085639, 34278.65721342755, 32423.0, 32473.512897306086, 32963.835180823946, 33310.0, 33369.49945750767, 28406.0, 30115.397692046474, 30512.84743576268, 30541.236469087562, 30628.693713063476, 23041.308760737204, 23327.41681457977, 23634.409139771644, 23673.763262367844, 23686.52626947417], "value": 16699.011553570625, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.4178716393914, 355.1990261959281, 361.6618461738274, 361.71424574586086, 386.10616422980814, 12722.68193295167, 13265.7346853063, 15251.237438128104, 15753.527394178165, 16805.915970420163, 15542.378304867792, 15843.683126337495, 15972.361105555763, 16033.198340083007, 16184.0, 4789.305550695164, 4797.7361245131415, 5011.273365362021, 5015.2226404907115, 5020.824271150511, 4894.926576101344, 5009.323741294933, 5014.072396606622, 5016.347874776274, 5017.347744793172, 4988.301637770715, 4989.550940415362, 4993.6254780891395, 4994.925076123861, 4995.525425084629, 4727.338172655831, 4803.615710743132, 4804.999999999965, 4817.542333478314, 4826.638002149853, 4266.168097221043, 4268.231718290706, 4268.9146217075795, 4269.658427325807, 4272.829086836523, 19470.902645486825, 19573.80426195734, 19712.802871971384, 19828.70256946147, 20271.29050483226, 1913.5885784556388, 1948.074664534349, 2141.0900367343816, 2440.3533063738123, 2466.2477944227003, 12196.512139514409, 12436.626901192978, 12883.871161288362, 13285.535006274831, 13423.0, 1652.5785924589272, 1658.4444211189266, 1691.5686499942435, 1693.745938109281, 1694.3984885365765, 66825.0, 68001.65999169972, 68046.65976670134, 68258.3174168257, 68964.65517672429, 9387.436753794795, 9435.622575097057, 9810.264230182765, 9831.213502919749, 9884.752881177885, 13013.804792928113, 13072.542461013818, 13083.476660933646, 13086.345682716017, 13096.476140954446, 6568.67156642166, 6946.756863509753, 7009.404200642901, 7065.010898474217, 7206.315400036988, 6294.842628934313, 6372.107904893319, 6387.169667943138, 6821.658917054127, 6840.0, 5826.242588463558, 5933.228680271537, 5997.760089596454, 6010.759569617167, 6091.908621370683, 1757.5869670627392, 1777.2713187593283, 1792.9282828686707, 1793.1124093573765, 1828.5885675723123, 647.2588885725818, 766.9914063007128, 805.5730462854697, 857.7819496315248, 868.1578868497547, 15824.60438489047, 16469.34122635105, 16515.33938642441, 16704.582385440463, 17236.396726114526, 849.5964416902045, 853.4537895746727, 856.4090777363599, 885.7829831691276, 933.178802653674, 9558.0, 9592.808143837085, 9867.506624668738, 9909.554070066864, 10021.198304135653, 271753.0, 275711.0, 276539.0, 276597.0, 364151.0, 67389.77292598177, 78919.0, 80841.0, 82236.1875621815, 84145.57927210325, 390.4163275902544, 411.90526178979, 412.8761371588511, 414.4839674605136, 415.31265755175235, 9078.954605226932, 9407.294452916196, 9451.905480945103, 9532.714018579454, 9641.228701703707, 31646.683533164374, 33919.321613567095, 34217.828910855285, 37679.81160094182, 38262.42606360851, 46908.53091469042, 46972.7651361741, 47829.28256076231, 48827.26759098545, 50330.748346258035, 6876.896846547406, 7059.223485416703, 7226.0, 7440.479166458513, 7558.9244107558225, 10509.211809114195, 10808.18938579594, 10832.729181770204, 10889.727756806144, 11085.27945683528, 4602.102589994919, 4766.976165119152, 7590.696372145273, 8667.17661822126, 9037.909620903707, 9285.117913798178, 9287.164155226063, 9511.239100872051, 9546.42721436716, 9608.519574021131, 8589.484630921916, 8669.739907802776, 8775.824483510167, 8839.337049721167, 9357.532123393667, 7078.433725302067, 7243.3843123333, 7343.118825740945, 7401.59291238987, 7489.625518724151, 8026.518408895485, 8655.6970506032, 8844.248238899765, 8986.370954033417, 8990.415622984485], "value": 7551.050768406923, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.089006805168, 1331.420831938107, 1338.7456383287174, 1588.6028492876787, 1588.8570028697416, 6360.745570177193, 6805.319468053192, 6818.386345228922, 6820.42026427753, 6820.556663816855, 5780.248567686195, 5986.281646202451, 6458.709358078886, 6607.603543787376, 6659.933400665992, 2026.63520566298, 2045.856790024699, 2047.5597746484502, 2052.1586149678633, 2052.466358746729, 2041.1325186795552, 2073.3676228750223, 2074.678424844152, 2080.9687854682193, 2085.165933626546, 1742.0766993493405, 1796.1917137288272, 1955.9706604400944, 2003.0986056274662, 2008.2569449303705, 2006.2075480185317, 2032.471557395088, 2032.5833204193252, 2033.044469099521, 2034.0541648133542, 1990.7212990181386, 2035.196097541463, 2035.5928814237063, 2037.663785475395, 2040.8469364797552, 6721.596704197715, 6762.898556521656, 6762.966185169092, 6767.187937447488, 6769.627670478122, 3991.2017596480528, 4128.112455821983, 4153.7300075494995, 4157.064660451404, 4160.084781348099, 2631.1185752772844, 2734.849583272919, 2857.0857325655797, 2864.8281103133877, 2867.956980645292, 840.2443263644051, 879.715951918119, 899.9370044096916, 911.9407238529475, 912.0286894457381, 8781.473111613324, 8788.736337909873, 8818.426802257896, 8823.55882205887, 8830.381873268874, 3609.9278014439565, 3785.6782173515007, 3804.6766024887643, 3863.4977452931503, 3893.5133108361456, 6596.60420374779, 7627.084749830056, 7632.122305934778, 7634.6946122154495, 7635.160132385433, 3974.125692347679, 4152.1280531088205, 4158.750474971512, 4159.417681524589, 4163.562825903297, 3903.5510916244993, 3907.941380879289, 3909.4722212500947, 3911.6675082618294, 3915.0, 2862.6135471711054, 2987.4025194961096, 2995.326051638364, 3003.6996300369788, 3031.9090427287215, 959.6305422412421, 979.637534112383, 990.4305024610877, 993.8906720260766, 1012.549415510091, 607.441154138194, 682.7917485167072, 723.280336065618, 738.9741359052407, 780.3055280800093, 4220.388043733641, 4256.425382573375, 4389.209942210369, 4423.845165419195, 4547.8635640930825, 791.1218547412368, 826.7809030606894, 857.0700789643182, 869.6956065377068, 888.5601627194451, 2686.9731302687114, 2911.796174267823, 3042.1481985044225, 3049.847507624654, 3078.061191336664, 7815.413843961725, 8079.878801817978, 8120.675172993014, 8122.837543249102, 8137.430379873352, 7008.299170082951, 7329.45029122818, 7332.0834895638045, 7554.697812087565, 8073.798155046171, 5789.102689083199, 6104.11490333908, 6296.150019747367, 6369.235691717024, 6453.064305675651, 4408.0, 4527.932081018853, 4664.113818374498, 4670.976645116889, 4709.411323584552, 7464.6267686614365, 7472.962635186789, 7508.549487030796, 7536.7362142324755, 7541.283578060075, 7534.434917381109, 7644.80887977805, 7717.6527056281475, 7772.727954521564, 7822.256885595859, 5491.395946445968, 5562.638428502134, 5574.0, 5618.297712785902, 5619.831405057855, 6187.535934804818, 6259.906101408574, 6260.780872669435, 6260.812175634556, 6262.2172228471445, 5738.426157384228, 5830.271216097988, 5896.380880007538, 5953.1070339449425, 6015.759369625166, 5705.201271822031, 5913.526917846476, 5974.492168165754, 5981.641101533922, 6051.062085376773, 5173.249878767633, 5222.321098257355, 5227.320448341691, 5279.52484276417, 5282.55098316632, 3923.2349691809823, 3991.5609282978266, 4049.3318602430268, 4105.774182419996, 4204.642605378577, 3945.605439456146, 3980.024893901013, 4018.8593399230886, 4039.3537034074407, 4060.2285565742413], "value": 3618.832757654304, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.0932445432477, 296.16481522107654, 300.60020173169687, 306.86037852777, 307.97074277943585, 4732.781708438265, 4735.810567577301, 4758.214894542396, 4759.738214398207, 4766.690165139264, 4672.39258896343, 4676.438827340716, 4682.204025315696, 4696.506866778982, 4706.788194531246, 3723.22619648361, 3736.626337366255, 3737.177820879402, 3742.7567208131522, 3751.381022131345, 3435.312937412515, 3763.4757923041075, 3778.2431169506176, 3783.621637836222, 3784.48909397232, 3576.159602493412, 3650.7809531428197, 3651.6348365163403, 3659.323025240339, 3675.577308609504, 3620.71034317254, 3623.239119784822, 3625.7280703947044, 3652.61200743717, 3657.3965295726175, 2956.63042119735, 3036.30165062037, 3123.5007196545785, 3192.5211218317204, 3198.680131986806, 4565.748883811389, 4572.222722137211, 4586.220342541776, 4598.931016034762, 4620.561046700558, 4136.91726165478, 4138.379243113527, 4144.41978123063, 4145.834166633331, 4153.7507749535125, 4614.17739992701, 4626.7223966562115, 4764.666473346867, 4857.271409288635, 4873.732829464329, 3463.9480407793903, 3479.7546992668904, 3483.860645574174, 3489.7906125632544, 3490.581130264359, 5068.847934561933, 5082.567981721558, 5103.183490641517, 5116.769745361467, 5134.8202812901745, 3398.575178102737, 3517.278957813642, 3524.242287908112, 3532.275883443888, 3535.964640353615, 3600.6579374959338, 3618.6381361863605, 3624.9818750906074, 3630.2013557017412, 3634.818259087035, 4106.9116684078745, 4126.855560055384, 4127.195196936568, 4143.7306575072525, 4156.0, 4883.4628190898975, 4889.364382630235, 4890.633202509826, 4915.9508404916205, 4916.852494425173, 1182.0225388176784, 1184.1048636084863, 1187.958421455245, 1195.479966214682, 1197.898178654824, 814.8451794159091, 834.9396266741326, 842.6755699055908, 844.5608283692445, 848.626604294121, 4235.957640423557, 4246.723962942398, 4266.146770645883, 4268.530461649216, 4276.550962148929, 4883.658143929962, 4896.4124305083615, 4898.926516102261, 4907.411110666742, 4914.582260507826, 4243.257429949746, 4248.596383343577, 4255.255330317244, 4266.573342665709, 4285.7000009999, 2480.3055144559553, 2589.41738108924, 2600.752928471792, 2623.753716984417, 2623.8163328566816, 4609.340637370544, 4682.508336624674, 4692.507286734912, 4740.739259340769, 4751.691140075884, 4991.950080499221, 5008.824691135866, 5078.415982162025, 5079.949200508022, 5086.64393492452, 4797.7525843281, 4811.398575178103, 4818.4217893852965, 4828.251620998751, 4829.830955916596, 4867.805287788448, 4963.181075122564, 4989.276554899592, 5044.646874718735, 5056.0, 4955.231939049453, 4959.652824302264, 4978.32792572998, 4990.575801056951, 5004.122629487986, 4804.183288840835, 4821.276808478756, 4832.589229915356, 4836.322914791862, 4842.83050093245, 3534.7879127252445, 3672.5042119313553, 3678.6321367863, 3706.777593344408, 3714.7399682022, 5030.3963524377305, 5036.899262014813, 5066.138756411493, 5066.695998240118, 5070.678705447937, 4924.285978533021, 4948.579370753382, 4949.455559888482, 4956.330895329229, 4959.553640172402, 4742.644301677457, 4899.485554016777, 4910.779014944264, 4933.58064564516, 4952.77712502931, 4803.567678908915, 4810.350602668595, 4810.687305325143, 4813.975930120327, 4820.276958456119, 4942.406911170682, 4946.3817022872145, 4951.603871690329, 4953.578945789648, 4961.107000739901, 4652.348671185969, 4809.2305231162845, 4838.758062096811, 4849.55681466163, 4861.902761944671], "value": 3687.324708474192, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.9134921111046, 618.4217756397768, 621.5307442880625, 667.876442858071, 681.2710399872137, 10898.836517452235, 11067.778644427126, 11384.146189035835, 11644.068474522039, 11655.708607284821, 11821.0, 12111.515539378437, 12115.697107572316, 12136.878631213685, 12138.575149869755, 587.885362354341, 713.4898547538496, 726.8073960400499, 727.5670975769409, 729.3399473476512, 515.6777014366021, 524.3288590604033, 524.5855773938584, 540.9080456322415, 594.4531031451075, 755.6523998960457, 757.6779868555869, 760.8364201696634, 762.523422860712, 762.6644276518342, 607.0954278125605, 748.4424104042523, 750.0811505905277, 750.3097150621414, 750.6209364271008, 461.8383565751993, 544.705858836228, 562.7467639562213, 564.7402194990309, 565.3554947360013, 12179.573714919936, 12197.0, 12208.938955305255, 12222.083343749255, 12226.388680565937, 11443.25618834773, 11544.595939142173, 11761.58834440799, 11969.962678178006, 11989.46047427859, 9883.0, 9989.80020399588, 9993.250506212064, 10151.64469243573, 10266.486675666187, 3938.1532970411213, 3946.7237293389476, 3951.9802400988096, 3953.189596132786, 3953.446517487554, 45989.0, 47595.76202118967, 47645.76177119127, 48724.512754872354, 49286.7535662323, 9025.50359730208, 9050.909490905007, 9128.132827381389, 9150.40522366044, 9442.10300021497, 16164.515064548083, 16207.756883646754, 16239.51281461558, 16292.0, 16512.09183494895, 5673.496523421297, 5752.252207213036, 5819.592628516048, 5925.140854576062, 5961.463468287875, 3483.1292176955762, 3489.5986961499243, 3530.3645343838357, 3532.116970757311, 3543.3090547343536, 2553.7573930476574, 2618.4763047390597, 2623.396618777692, 2626.9474610508064, 2638.353603367187, 458.8990422107131, 461.20902651951394, 462.97685115744076, 465.46704023892454, 466.2679593038964, 515.4639175257765, 518.6602775182262, 545.5526468296039, 559.1752165555773, 577.7371296060282, 6982.162140543066, 7132.750353737594, 7156.964215178891, 7200.099987501562, 7246.021787058785, 573.3377948469441, 585.7861880413618, 592.4490224091636, 593.5133190783603, 597.3727586034646, 3340.766146369731, 3458.8962331130106, 3462.8441720122655, 3569.5359603251413, 3663.4504824276037, 62127.0, 68768.31231687719, 70883.64558177177, 71371.64314178396, 72214.0, 61964.0, 63234.68382658057, 63359.6832015837, 63409.68295158587, 63954.36045639484, 35594.28811423809, 44570.77714611406, 48606.0, 55061.72469137629, 55269.44730552643, 7267.672954717156, 7561.0, 7934.722284720238, 7973.6810527580565, 8130.552819594743, 38750.418743718306, 38990.2201955965, 39237.80381098076, 40562.865095268266, 40956.38565421462, 29859.31266186054, 49062.26406603975, 53741.73129134329, 53947.0, 54842.451575483734, 10911.181661375587, 11038.834417483904, 11065.5020524075, 11076.169287303646, 11939.820902686293, 12177.208481449032, 12393.318367489876, 12443.191192572454, 12664.264042107416, 12867.806982895077, 9993.950030249802, 10526.315789473965, 10606.46967651599, 10613.363198208132, 10748.731281718019, 10920.126389888632, 11005.834912476159, 11199.0, 11208.327500350006, 11592.47833847462, 10014.64948726791, 10074.647387341407, 10288.228382871464, 10469.633562825264, 10871.075958543612, 9026.548672566214, 9146.365616953693, 9227.677031303872, 9284.3036772241, 9288.303377246599, 8815.515146666994, 9125.361224714472, 9215.354925155174, 9279.86080208811, 9328.440293582407], "value": 5824.461459186854, "unit": "score"}], "name": "dromaeo_css", "value": 5962.744339378078, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 117.0, 115.0, 116.0, 116.0, 117.0, 116.0, 117.0, 115.0, 117.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 128.0, 130.0, 177.0, 131.0, 128.0, 130.0, 129.0, 168.0, 128.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 162.0, 161.0, 162.0, 163.0, 161.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 112.0, 77.0, 76.0, 76.0, 76.0, 101.0, 77.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 114.0, 84.0, 85.0, 84.0, 114.0, 83.0, 83.0, 122.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 85.0, 85.0, 86.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 68.0, 66.0, 66.0, 66.0, 67.0, 66.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 86.0, 84.0, 85.0, 84.0, 84.0, 83.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 142.0, 141.0, 149.0, 142.0, 141.0, 148.0, 139.0, 195.0, 142.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 180.0, 180.0, 181.0, 180.0, 176.0, 177.0, 180.0, 179.0, 182.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 69.0, 68.0, 69.0, 71.0, 71.0, 69.0, 70.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1554.4, "alertThreshold": 2.0}]} 05:25:06 INFO - Return code: 0 05:25:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:25:06 INFO - # TBPL SUCCESS # 05:25:06 INFO - Running post-action listener: _resource_record_post_action 05:25:06 INFO - [mozharness: 2016-11-09 13:25:06.973990Z] Finished run-tests step (success) 05:25:06 INFO - Running post-run listener: _resource_record_post_run 05:25:07 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391073792; Read time: 12; Write time: 390344 05:25:07 INFO - TinderboxPrint: CPU usage
13.0% 05:25:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:25:07 INFO - TinderboxPrint: I/O write bytes / time
391,073,792 / 390,344 05:25:07 INFO - TinderboxPrint: CPU idle
8,352.6 (86.9%) 05:25:07 INFO - TinderboxPrint: CPU user
1,202.9 (12.5%) 05:25:07 INFO - TinderboxPrint: Swap in / out
0 / 0 05:25:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99377152; Read time: 0; Write time: 115748 05:25:07 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291696640; Read time: 0; Write time: 274596 05:25:07 INFO - Running post-run listener: _upload_blobber_files 05:25:07 INFO - Blob upload gear active. 05:25:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:25:07 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 05:25:07 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:25:07 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:25:08 INFO - (blobuploader) - INFO - Open directory for files ... 05:25:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:25:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:25:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:08 INFO - (blobuploader) - INFO - Done attempting. 05:25:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:25:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:25:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:12 INFO - (blobuploader) - INFO - Done attempting. 05:25:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:25:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:25:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:13 INFO - (blobuploader) - INFO - Done attempting. 05:25:13 INFO - (blobuploader) - INFO - Iteration through files over. 05:25:13 INFO - Return code: 0 05:25:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:25:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:25:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/2a41e2fd9e9333f9b70ce160ea49dc486dd1b583ffcb26c2e8504faf0b6a56f8dfa73eed0708105b73d392cb1154ab93b059cceb5d77e965674debbc601142d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/121543352f2d0c9df8c36452d9f885fcc4260e9797ea707395ad856ab4ff9c4729ffea18608f6906c4854faf13449c9fde1c07311bd2976af8a9d03860338818", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/24065185086b31a4dff8b2ed38f2b8b242efc9a7aa9c6fc9178e649e3c7fe9e190bec8179842474b1135693a50a5502ed3f45f114cf382fc9ff2be9fe1cd38c1"} 05:25:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:25:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:25:13 INFO - Contents: 05:25:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/2a41e2fd9e9333f9b70ce160ea49dc486dd1b583ffcb26c2e8504faf0b6a56f8dfa73eed0708105b73d392cb1154ab93b059cceb5d77e965674debbc601142d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/121543352f2d0c9df8c36452d9f885fcc4260e9797ea707395ad856ab4ff9c4729ffea18608f6906c4854faf13449c9fde1c07311bd2976af8a9d03860338818", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/24065185086b31a4dff8b2ed38f2b8b242efc9a7aa9c6fc9178e649e3c7fe9e190bec8179842474b1135693a50a5502ed3f45f114cf382fc9ff2be9fe1cd38c1"} 05:25:13 INFO - Running post-run listener: copy_logs_to_upload_dir 05:25:13 INFO - Copying logs to upload dir... 05:25:13 INFO - mkdir: /builds/slave/test/build/upload/logs 05:25:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.721540 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-09 05:25:13.202146) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 05:25:13.205599) ========= 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=920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/2a41e2fd9e9333f9b70ce160ea49dc486dd1b583ffcb26c2e8504faf0b6a56f8dfa73eed0708105b73d392cb1154ab93b059cceb5d77e965674debbc601142d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/121543352f2d0c9df8c36452d9f885fcc4260e9797ea707395ad856ab4ff9c4729ffea18608f6906c4854faf13449c9fde1c07311bd2976af8a9d03860338818", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/24065185086b31a4dff8b2ed38f2b8b242efc9a7aa9c6fc9178e649e3c7fe9e190bec8179842474b1135693a50a5502ed3f45f114cf382fc9ff2be9fe1cd38c1"} build_url:https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/R7_l69pWRgmE7b8NuOlp0Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/2a41e2fd9e9333f9b70ce160ea49dc486dd1b583ffcb26c2e8504faf0b6a56f8dfa73eed0708105b73d392cb1154ab93b059cceb5d77e965674debbc601142d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/121543352f2d0c9df8c36452d9f885fcc4260e9797ea707395ad856ab4ff9c4729ffea18608f6906c4854faf13449c9fde1c07311bd2976af8a9d03860338818", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/24065185086b31a4dff8b2ed38f2b8b242efc9a7aa9c6fc9178e649e3c7fe9e190bec8179842474b1135693a50a5502ed3f45f114cf382fc9ff2be9fe1cd38c1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 05:25:13.231728) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 05:25:13.232086) ========= 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=920470bf432669ad7e3a5387000001ca-1478696663.810811-1922556468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 05:25:13.313941) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-09 05:25:13.314317) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-09 05:25:13.314618) ========= ========= Total master_lag: 0.17 =========