builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1476123718.69 results: success (0) buildid: 20161010100123 builduid: 25304dc797f04ef2b7e1ba581889ee9e revision: ec2da84091f9ec100e6a16b9e56ecca95404e479 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 11:21:58.689436) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 11:21:58.689831) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 11:21:58.690108) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 11:21:58.708662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 11:21:58.708962) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-10 11:22:00-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.8M=0s 2016-10-10 11:22:00 (37.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132038 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 11:21:58.854353) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 11:21:58.854627) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021015 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 11:21:58.903813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 11:21:58.904321) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev ec2da84091f9ec100e6a16b9e56ecca95404e479 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev ec2da84091f9ec100e6a16b9e56ecca95404e479 --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=74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-10 11:22:00,474 truncating revision to first 12 chars 2016-10-10 11:22:00,474 Setting DEBUG logging. 2016-10-10 11:22:00,474 attempt 1/10 2016-10-10 11:22:00,474 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/ec2da84091f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 11:22:00,774 unpacking tar archive at: larch-ec2da84091f9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648485 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 11:21:59.566482) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 11:21:59.566785) ========= script_repo_revision: ec2da84091f9ec100e6a16b9e56ecca95404e479 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 11:21:59.567189) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 11:21:59.567454) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 11:21:59.583760) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-10 11:21:59.584042) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 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', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] 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=74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:22:01 INFO - MultiFileLogger online at 20161010 11:22:01 in /builds/slave/test 11:22:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 11:22:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:22:01 INFO - {'append_to_log': False, 11:22:01 INFO - 'base_work_dir': '/builds/slave/test', 11:22:01 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 11:22:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:22:01 INFO - 'branch': 'Larch-Non-PGO', 11:22:01 INFO - 'buildbot_json_path': 'buildprops.json', 11:22:01 INFO - 'config_files': ('talos/linux_config.py',), 11:22:01 INFO - 'default_actions': ('clobber', 11:22:01 INFO - 'read-buildbot-config', 11:22:01 INFO - 'download-and-extract', 11:22:01 INFO - 'populate-webroot', 11:22:01 INFO - 'create-virtualenv', 11:22:01 INFO - 'install', 11:22:01 INFO - 'run-tests'), 11:22:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:22:01 INFO - 'download_minidump_stackwalk': True, 11:22:01 INFO - 'download_symbols': 'ondemand', 11:22:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:22:01 INFO - 'tooltool.py': '/tools/tooltool.py', 11:22:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:22:01 INFO - '/tools/misc-python/virtualenv.py')}, 11:22:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:22:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:22:01 INFO - 'installer_path': 'installer.exe', 11:22:01 INFO - 'log_level': 'info', 11:22:01 INFO - 'log_name': 'talos', 11:22:01 INFO - 'log_to_console': True, 11:22:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:22:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:22:01 INFO - 'opt_config_files': (), 11:22:01 INFO - 'pip_index': False, 11:22:01 INFO - 'sps_profile': False, 11:22:01 INFO - 'sps_profile_interval': 0, 11:22:01 INFO - 'suite': 'dromaeojs', 11:22:01 INFO - 'system_bits': '32', 11:22:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:22:01 INFO - 'title': 'talos-linux64-ix-042', 11:22:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:22:01 INFO - 'use_talos_json': True, 11:22:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:22:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:22:01 INFO - 'work_dir': 'build'} 11:22:01 INFO - [mozharness: 2016-10-10 18:22:01.260262Z] Running clobber step. 11:22:01 INFO - Running pre-action listener: _resource_record_pre_action 11:22:01 INFO - Running main action method: clobber 11:22:01 INFO - rmtree: /builds/slave/test/build 11:22:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:22:01 INFO - Running post-action listener: _resource_record_post_action 11:22:01 INFO - [mozharness: 2016-10-10 18:22:01.733775Z] Finished clobber step (success) 11:22:01 INFO - [mozharness: 2016-10-10 18:22:01.733877Z] Running read-buildbot-config step. 11:22:01 INFO - Running pre-action listener: _resource_record_pre_action 11:22:01 INFO - Running main action method: read_buildbot_config 11:22:01 INFO - Using buildbot properties: 11:22:01 INFO - { 11:22:01 INFO - "project": "", 11:22:01 INFO - "product": "firefox", 11:22:01 INFO - "script_repo_revision": "production", 11:22:01 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 11:22:01 INFO - "repository": "", 11:22:01 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 11:22:01 INFO - "buildid": "20161010100123", 11:22:01 INFO - "pgo_build": "False", 11:22:01 INFO - "basedir": "/builds/slave/test", 11:22:01 INFO - "buildnumber": 1, 11:22:01 INFO - "slavename": "talos-linux64-ix-042", 11:22:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:22:01 INFO - "platform": "ubuntu64_hw", 11:22:01 INFO - "scheduler": "tests-larch-linux64-talos", 11:22:01 INFO - "branch": "larch", 11:22:01 INFO - "repo_path": "projects/larch", 11:22:01 INFO - "revision": "ec2da84091f9ec100e6a16b9e56ecca95404e479", 11:22:01 INFO - "stage_platform": "linux64", 11:22:01 INFO - "builduid": "25304dc797f04ef2b7e1ba581889ee9e", 11:22:01 INFO - "slavebuilddir": "test" 11:22:01 INFO - } 11:22:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 11:22:01 INFO - Running post-action listener: _resource_record_post_action 11:22:01 INFO - [mozharness: 2016-10-10 18:22:01.736313Z] Finished read-buildbot-config step (success) 11:22:01 INFO - [mozharness: 2016-10-10 18:22:01.736401Z] Running download-and-extract step. 11:22:01 INFO - Running pre-action listener: _resource_record_pre_action 11:22:01 INFO - Running main action method: download_and_extract 11:22:01 INFO - mkdir: /builds/slave/test/build/tests 11:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:01 INFO - trying https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:22:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/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 11:22:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/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 11:22:02 INFO - Downloaded 1361 bytes. 11:22:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:22:02 INFO - Using the following test package requirements: 11:22:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:22:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:22:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:22:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:02 INFO - u'jsshell-linux-x86_64.zip'], 11:22:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:22:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:22:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:22:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:22:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:22:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:22:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:22:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:22:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:22:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:22:02 INFO - Http code: 200 11:22:02 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 11:22:02 INFO - x-amz-cf-id: izbMM_0eHy4czjRBySi7eJPVtReX_eRLrGMcYCMp--S7RVaS9j8_cg== 11:22:02 INFO - x-amz-version-id: mNjKxhUGZCZIW2DP4mxZgSGqCCHDE75N 11:22:03 INFO - Expected file size: 20420581 11:22:03 INFO - Obtained file size: 20420581 11:22:07 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 11:22:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:22:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:22:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:22:07 INFO - Http code: 200 11:22:07 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 11:22:07 INFO - x-amz-cf-id: z3Wwxabi_Slm40lZjxgr3G6I43Sry-Fjvuu2kuKEQBlKfNQXz61Kxw== 11:22:07 INFO - x-amz-version-id: mNjKxhUGZCZIW2DP4mxZgSGqCCHDE75N 11:22:08 INFO - Expected file size: 20420581 11:22:08 INFO - Obtained file size: 20420581 11:22:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 11:22:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:22:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:22:13 INFO - Http code: 200 11:22:13 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 11:22:13 INFO - x-amz-cf-id: LecxQXOmZtTGPat5_OtgUowFg5JsbbZbQf2lZS43hDzDY_uznP_rFw== 11:22:13 INFO - x-amz-version-id: dsWJmj3MB4PcgSzDWaVIvLtxoJzaHPRe 11:22:13 INFO - Expected file size: 14408522 11:22:13 INFO - Obtained file size: 14408522 11:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:13 INFO - trying https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:22:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/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 11:22:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/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 11:22:15 INFO - Downloaded 55808443 bytes. 11:22:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:22:15 INFO - mkdir: /builds/slave/test/properties 11:22:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:22:15 INFO - Writing to file /builds/slave/test/properties/build_url 11:22:15 INFO - Contents: 11:22:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:22:16 INFO - Running post-action listener: _resource_record_post_action 11:22:16 INFO - Running post-action listener: set_extra_try_arguments 11:22:16 INFO - [mozharness: 2016-10-10 18:22:16.182705Z] Finished download-and-extract step (success) 11:22:16 INFO - [mozharness: 2016-10-10 18:22:16.182930Z] Running populate-webroot step. 11:22:16 INFO - Running pre-action listener: _resource_record_pre_action 11:22:16 INFO - Running main action method: populate_webroot 11:22:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:22:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:22:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:22:16 INFO - '--tppagecycles', 11:22:16 INFO - '7'], 11:22:16 INFO - 'tests': ['tsvgm']}}, 11:22:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:22:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:22:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:22:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:22:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:22:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:22:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'talos_options': ['--disable-e10s'], 11:22:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'talos_options': ['--disable-e10s'], 11:22:16 INFO - 'tests': ['damp', 'tps']}, 11:22:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'tests': ['damp', 'tps']}, 11:22:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:22:16 INFO - 'tests': ['dromaeo_dom']}, 11:22:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:22:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:22:16 INFO - 'tests': ['basic_compositor_video']}, 11:22:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:22:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:22:16 INFO - 'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore', 11:22:16 INFO - 'tabpaint']}, 11:22:16 INFO - 'other-e10s': {'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore', 11:22:16 INFO - 'tabpaint']}, 11:22:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore', 11:22:16 INFO - 'tabpaint']}, 11:22:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore', 11:22:16 INFO - 'tabpaint']}, 11:22:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:22:16 INFO - 'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore', 11:22:16 INFO - 'tabpaint']}, 11:22:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:22:16 INFO - 'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore', 11:22:16 INFO - 'tabpaint']}, 11:22:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:22:16 INFO - 'tests': ['tsvgx', 11:22:16 INFO - 'tsvgr_opacity', 11:22:16 INFO - 'tart', 11:22:16 INFO - 'tscrollx', 11:22:16 INFO - 'cart']}, 11:22:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:22:16 INFO - 'tsvgr_opacity', 11:22:16 INFO - 'tart', 11:22:16 INFO - 'tscrollx', 11:22:16 INFO - 'cart']}, 11:22:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'talos_options': ['--disable-e10s'], 11:22:16 INFO - 'tests': ['tp5o']}, 11:22:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'tests': ['tp5o']}, 11:22:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'talos_options': ['--disable-e10s', 11:22:16 INFO - '--xperf_path', 11:22:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:16 INFO - 'tests': ['tp5n']}, 11:22:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'talos_options': ['--xperf_path', 11:22:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:16 INFO - 'tests': ['tp5n']}}, 11:22:16 INFO - 'talos.zip': {'path': '', 11:22:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:22:16 INFO - Running post-action listener: _resource_record_post_action 11:22:16 INFO - [mozharness: 2016-10-10 18:22:16.204453Z] Finished populate-webroot step (success) 11:22:16 INFO - [mozharness: 2016-10-10 18:22:16.204540Z] Running create-virtualenv step. 11:22:16 INFO - Running pre-action listener: _resource_record_pre_action 11:22:16 INFO - Running main action method: create_virtualenv 11:22:16 INFO - Creating virtualenv /builds/slave/test/build/venv 11:22:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:22:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:22:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:22:16 INFO - Using real prefix '/usr' 11:22:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:22:16 INFO - Installing distribute.............................................................................................................................................................................................done. 11:22:18 INFO - Installing pip.................done. 11:22:18 INFO - Return code: 0 11:22:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:22:18 INFO - Reading from file tmpfile_stdout 11:22:18 INFO - Output received: 11:22:19 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:22:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:19 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 0x7f4b55e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1839ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1836f60>, '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 0x1837d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18381d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:22:19 INFO - Using env: {'DISPLAY': ':0', 11:22:19 INFO - 'HOME': '/home/cltbld', 11:22:19 INFO - 'LANG': 'en_US.UTF-8', 11:22:19 INFO - 'LANGUAGE': 'en_US:en', 11:22:19 INFO - 'LOGNAME': 'cltbld', 11:22:19 INFO - 'MAIL': '/var/mail/cltbld', 11:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:19 INFO - 'MOZ_NO_REMOTE': '1', 11:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:19 INFO - 'NO_EM_RESTART': '1', 11:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:19 INFO - 'PWD': '/builds/slave/test', 11:22:19 INFO - 'SHELL': '/bin/bash', 11:22:19 INFO - 'SHLVL': '1', 11:22:19 INFO - 'TERM': 'linux', 11:22:19 INFO - 'TMOUT': '86400', 11:22:19 INFO - 'USER': 'cltbld', 11:22:19 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 11:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:19 INFO - '_': '/tools/buildbot/bin/python'} 11:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:22:19 INFO - Cleaning up... 11:22:19 INFO - Return code: 0 11:22:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:19 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 0x7f4b55e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1839ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1836f60>, '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 0x1837d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18381d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:22:19 INFO - Using env: {'DISPLAY': ':0', 11:22:19 INFO - 'HOME': '/home/cltbld', 11:22:19 INFO - 'LANG': 'en_US.UTF-8', 11:22:19 INFO - 'LANGUAGE': 'en_US:en', 11:22:19 INFO - 'LOGNAME': 'cltbld', 11:22:19 INFO - 'MAIL': '/var/mail/cltbld', 11:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:19 INFO - 'MOZ_NO_REMOTE': '1', 11:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:19 INFO - 'NO_EM_RESTART': '1', 11:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:19 INFO - 'PWD': '/builds/slave/test', 11:22:19 INFO - 'SHELL': '/bin/bash', 11:22:19 INFO - 'SHLVL': '1', 11:22:19 INFO - 'TERM': 'linux', 11:22:19 INFO - 'TMOUT': '86400', 11:22:19 INFO - 'USER': 'cltbld', 11:22:19 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 11:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:19 INFO - '_': '/tools/buildbot/bin/python'} 11:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:19 INFO - Downloading/unpacking psutil>=3.1.1 11:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:22:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:22 INFO - Installing collected packages: psutil 11:22:22 INFO - Running setup.py install for psutil 11:22:22 INFO - building 'psutil._psutil_linux' extension 11:22:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:22:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:22:22 INFO - building 'psutil._psutil_posix' extension 11:22:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:22:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:22:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:22 INFO - Successfully installed psutil 11:22:22 INFO - Cleaning up... 11:22:22 INFO - Return code: 0 11:22:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:22 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 0x7f4b55e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1839ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1836f60>, '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 0x1837d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18381d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:22:22 INFO - Using env: {'DISPLAY': ':0', 11:22:22 INFO - 'HOME': '/home/cltbld', 11:22:22 INFO - 'LANG': 'en_US.UTF-8', 11:22:22 INFO - 'LANGUAGE': 'en_US:en', 11:22:22 INFO - 'LOGNAME': 'cltbld', 11:22:22 INFO - 'MAIL': '/var/mail/cltbld', 11:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:22 INFO - 'MOZ_NO_REMOTE': '1', 11:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:22 INFO - 'NO_EM_RESTART': '1', 11:22:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:22 INFO - 'PWD': '/builds/slave/test', 11:22:22 INFO - 'SHELL': '/bin/bash', 11:22:22 INFO - 'SHLVL': '1', 11:22:22 INFO - 'TERM': 'linux', 11:22:22 INFO - 'TMOUT': '86400', 11:22:22 INFO - 'USER': 'cltbld', 11:22:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 11:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:22 INFO - '_': '/tools/buildbot/bin/python'} 11:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:22:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:22:24 INFO - Installing collected packages: mozsystemmonitor 11:22:24 INFO - Running setup.py install for mozsystemmonitor 11:22:24 INFO - Successfully installed mozsystemmonitor 11:22:24 INFO - Cleaning up... 11:22:24 INFO - Return code: 0 11:22:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:24 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 0x7f4b55e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1839ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1836f60>, '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 0x1837d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18381d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:22:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:22:24 INFO - Using env: {'DISPLAY': ':0', 11:22:24 INFO - 'HOME': '/home/cltbld', 11:22:24 INFO - 'LANG': 'en_US.UTF-8', 11:22:24 INFO - 'LANGUAGE': 'en_US:en', 11:22:24 INFO - 'LOGNAME': 'cltbld', 11:22:24 INFO - 'MAIL': '/var/mail/cltbld', 11:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:24 INFO - 'MOZ_NO_REMOTE': '1', 11:22:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:24 INFO - 'NO_EM_RESTART': '1', 11:22:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:24 INFO - 'PWD': '/builds/slave/test', 11:22:24 INFO - 'SHELL': '/bin/bash', 11:22:24 INFO - 'SHLVL': '1', 11:22:24 INFO - 'TERM': 'linux', 11:22:24 INFO - 'TMOUT': '86400', 11:22:24 INFO - 'USER': 'cltbld', 11:22:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 11:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:24 INFO - '_': '/tools/buildbot/bin/python'} 11:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:25 INFO - Downloading/unpacking jsonschema==2.5.1 11:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:22:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:27 INFO - Downloading functools32-3.2.3-2.tar.gz 11:22:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:22:27 INFO - warning: no files found matching '*.txt' 11:22:27 INFO - no previously-included directories found matching 'build' 11:22:27 INFO - no previously-included directories found matching 'dist' 11:22:27 INFO - no previously-included directories found matching '.git*' 11:22:27 INFO - Installing collected packages: jsonschema, functools32 11:22:27 INFO - Running setup.py install for functools32 11:22:27 INFO - warning: no files found matching '*.txt' 11:22:27 INFO - no previously-included directories found matching 'build' 11:22:27 INFO - no previously-included directories found matching 'dist' 11:22:27 INFO - no previously-included directories found matching '.git*' 11:22:27 INFO - Successfully installed jsonschema functools32 11:22:27 INFO - Cleaning up... 11:22:27 INFO - Return code: 0 11:22:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:27 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 0x7f4b55e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1839ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1836f60>, '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 0x1837d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18381d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:22:27 INFO - Using env: {'DISPLAY': ':0', 11:22:27 INFO - 'HOME': '/home/cltbld', 11:22:27 INFO - 'LANG': 'en_US.UTF-8', 11:22:27 INFO - 'LANGUAGE': 'en_US:en', 11:22:27 INFO - 'LOGNAME': 'cltbld', 11:22:27 INFO - 'MAIL': '/var/mail/cltbld', 11:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:27 INFO - 'MOZ_NO_REMOTE': '1', 11:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:27 INFO - 'NO_EM_RESTART': '1', 11:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:27 INFO - 'PWD': '/builds/slave/test', 11:22:27 INFO - 'SHELL': '/bin/bash', 11:22:27 INFO - 'SHLVL': '1', 11:22:27 INFO - 'TERM': 'linux', 11:22:27 INFO - 'TMOUT': '86400', 11:22:27 INFO - 'USER': 'cltbld', 11:22:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 11:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:27 INFO - '_': '/tools/buildbot/bin/python'} 11:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:22:27 INFO - Cleaning up... 11:22:27 INFO - Return code: 0 11:22:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:27 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 0x7f4b55e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1839ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1836f60>, '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 0x1837d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18381d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:22:27 INFO - Using env: {'DISPLAY': ':0', 11:22:27 INFO - 'HOME': '/home/cltbld', 11:22:27 INFO - 'LANG': 'en_US.UTF-8', 11:22:27 INFO - 'LANGUAGE': 'en_US:en', 11:22:27 INFO - 'LOGNAME': 'cltbld', 11:22:27 INFO - 'MAIL': '/var/mail/cltbld', 11:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:27 INFO - 'MOZ_NO_REMOTE': '1', 11:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:27 INFO - 'NO_EM_RESTART': '1', 11:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:27 INFO - 'PWD': '/builds/slave/test', 11:22:27 INFO - 'SHELL': '/bin/bash', 11:22:27 INFO - 'SHLVL': '1', 11:22:27 INFO - 'TERM': 'linux', 11:22:27 INFO - 'TMOUT': '86400', 11:22:27 INFO - 'USER': 'cltbld', 11:22:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 11:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:27 INFO - '_': '/tools/buildbot/bin/python'} 11:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:27 INFO - Downloading/unpacking blobuploader==1.2.4 11:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:29 INFO - Downloading blobuploader-1.2.4.tar.gz 11:22:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:22:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:22:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:30 INFO - Downloading docopt-0.6.1.tar.gz 11:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:22:30 INFO - Installing collected packages: blobuploader, requests, docopt 11:22:30 INFO - Running setup.py install for blobuploader 11:22:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:22:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:22:30 INFO - Running setup.py install for requests 11:22:31 INFO - Running setup.py install for docopt 11:22:31 INFO - Successfully installed blobuploader requests docopt 11:22:31 INFO - Cleaning up... 11:22:31 INFO - Return code: 0 11:22:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:31 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 0x7f4b55e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1839ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1836f60>, '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 0x1837d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18381d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:22:31 INFO - Using env: {'DISPLAY': ':0', 11:22:31 INFO - 'HOME': '/home/cltbld', 11:22:31 INFO - 'LANG': 'en_US.UTF-8', 11:22:31 INFO - 'LANGUAGE': 'en_US:en', 11:22:31 INFO - 'LOGNAME': 'cltbld', 11:22:31 INFO - 'MAIL': '/var/mail/cltbld', 11:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:31 INFO - 'MOZ_NO_REMOTE': '1', 11:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:31 INFO - 'NO_EM_RESTART': '1', 11:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:31 INFO - 'PWD': '/builds/slave/test', 11:22:31 INFO - 'SHELL': '/bin/bash', 11:22:31 INFO - 'SHLVL': '1', 11:22:31 INFO - 'TERM': 'linux', 11:22:31 INFO - 'TMOUT': '86400', 11:22:31 INFO - 'USER': 'cltbld', 11:22:31 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 11:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:31 INFO - '_': '/tools/buildbot/bin/python'} 11:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:31 INFO - Running setup.py (path:/tmp/pip-NVHdkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:31 INFO - Running setup.py (path:/tmp/pip-RFrNE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:31 INFO - Running setup.py (path:/tmp/pip-GNuRv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:31 INFO - Running setup.py (path:/tmp/pip-tamEOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:31 INFO - Running setup.py (path:/tmp/pip-iLYkOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:31 INFO - Running setup.py (path:/tmp/pip-gNGJ0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:31 INFO - Running setup.py (path:/tmp/pip-xCcOyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:31 INFO - Running setup.py (path:/tmp/pip-OjRpfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:32 INFO - Running setup.py (path:/tmp/pip-8if4vF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:32 INFO - Running setup.py (path:/tmp/pip-hqX1eG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:32 INFO - Running setup.py (path:/tmp/pip-oyii98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:32 INFO - Running setup.py (path:/tmp/pip-vfSz3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:32 INFO - Running setup.py (path:/tmp/pip-L1mwR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:32 INFO - Running setup.py (path:/tmp/pip-aUUNCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:32 INFO - Running setup.py (path:/tmp/pip-kUbiF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:32 INFO - Running setup.py (path:/tmp/pip-PSaMIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:32 INFO - Running setup.py (path:/tmp/pip-3pF6gJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:22:32 INFO - Running setup.py install for manifestparser 11:22:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:22:32 INFO - Running setup.py install for mozcrash 11:22:32 INFO - Running setup.py install for mozdebug 11:22:33 INFO - Running setup.py install for mozdevice 11:22:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:22:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:22:33 INFO - Running setup.py install for mozfile 11:22:33 INFO - Running setup.py install for mozhttpd 11:22:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:22:33 INFO - Running setup.py install for mozinfo 11:22:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:22:33 INFO - Running setup.py install for mozInstall 11:22:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:22:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:22:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:22:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:22:33 INFO - Running setup.py install for mozleak 11:22:33 INFO - Running setup.py install for mozlog 11:22:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:22:33 INFO - Running setup.py install for moznetwork 11:22:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:22:33 INFO - Running setup.py install for mozprocess 11:22:33 INFO - Running setup.py install for mozprofile 11:22:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:22:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:22:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:22:34 INFO - Running setup.py install for mozrunner 11:22:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:22:34 INFO - Running setup.py install for mozscreenshot 11:22:34 INFO - Running setup.py install for moztest 11:22:34 INFO - Running setup.py install for mozversion 11:22:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:22:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:22:34 INFO - Cleaning up... 11:22:34 INFO - Return code: 0 11:22:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:34 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 0x7f4b55e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1839ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1836f60>, '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 0x1837d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18381d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:22:34 INFO - Using env: {'DISPLAY': ':0', 11:22:34 INFO - 'HOME': '/home/cltbld', 11:22:34 INFO - 'LANG': 'en_US.UTF-8', 11:22:34 INFO - 'LANGUAGE': 'en_US:en', 11:22:34 INFO - 'LOGNAME': 'cltbld', 11:22:34 INFO - 'MAIL': '/var/mail/cltbld', 11:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:34 INFO - 'MOZ_NO_REMOTE': '1', 11:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:34 INFO - 'NO_EM_RESTART': '1', 11:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:34 INFO - 'PWD': '/builds/slave/test', 11:22:34 INFO - 'SHELL': '/bin/bash', 11:22:34 INFO - 'SHLVL': '1', 11:22:34 INFO - 'TERM': 'linux', 11:22:34 INFO - 'TMOUT': '86400', 11:22:34 INFO - 'USER': 'cltbld', 11:22:34 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 11:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:34 INFO - '_': '/tools/buildbot/bin/python'} 11:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:34 INFO - Running setup.py (path:/tmp/pip-CfCdK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:34 INFO - Running setup.py (path:/tmp/pip-AQcmfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:34 INFO - Running setup.py (path:/tmp/pip-gAtn9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:34 INFO - Running setup.py (path:/tmp/pip-ZeP4NR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:35 INFO - Running setup.py (path:/tmp/pip-YJVgXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:35 INFO - Running setup.py (path:/tmp/pip-hP07cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:35 INFO - Running setup.py (path:/tmp/pip-Y6rT11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:35 INFO - Running setup.py (path:/tmp/pip-LtNL9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:35 INFO - Running setup.py (path:/tmp/pip-Awad9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:35 INFO - Running setup.py (path:/tmp/pip-cFUa6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:35 INFO - Running setup.py (path:/tmp/pip-d0qoR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:35 INFO - Running setup.py (path:/tmp/pip-fHj3wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:35 INFO - Running setup.py (path:/tmp/pip-i3kf5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:35 INFO - Running setup.py (path:/tmp/pip-uV4ndx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:35 INFO - Running setup.py (path:/tmp/pip-JiNUvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:35 INFO - Running setup.py (path:/tmp/pip-ZakFtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:35 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)) 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:35 INFO - Running setup.py (path:/tmp/pip-xdfZN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:37 INFO - Downloading blessings-1.6.tar.gz 11:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:22:37 INFO - Installing collected packages: blessings 11:22:37 INFO - Running setup.py install for blessings 11:22:38 INFO - Successfully installed blessings 11:22:38 INFO - Cleaning up... 11:22:38 INFO - Return code: 0 11:22:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:22:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:38 INFO - Reading from file tmpfile_stdout 11:22:38 INFO - Current package versions: 11:22:38 INFO - argparse == 1.2.1 11:22:38 INFO - blessings == 1.6 11:22:38 INFO - blobuploader == 1.2.4 11:22:38 INFO - docopt == 0.6.1 11:22:38 INFO - functools32 == 3.2.3-2 11:22:38 INFO - jsonschema == 2.5.1 11:22:38 INFO - manifestparser == 1.1 11:22:38 INFO - mozInstall == 1.12 11:22:38 INFO - mozcrash == 0.17 11:22:38 INFO - mozdebug == 0.1 11:22:38 INFO - mozdevice == 0.48 11:22:38 INFO - mozfile == 1.2 11:22:38 INFO - mozhttpd == 0.7 11:22:38 INFO - mozinfo == 0.9 11:22:38 INFO - mozleak == 0.1 11:22:38 INFO - mozlog == 3.4 11:22:38 INFO - moznetwork == 0.27 11:22:38 INFO - mozprocess == 0.23 11:22:38 INFO - mozprofile == 0.28 11:22:38 INFO - mozrunner == 6.12 11:22:38 INFO - mozscreenshot == 0.1 11:22:38 INFO - mozsystemmonitor == 0.3 11:22:38 INFO - moztest == 0.7 11:22:38 INFO - mozversion == 1.4 11:22:38 INFO - psutil == 3.1.1 11:22:38 INFO - requests == 1.2.3 11:22:38 INFO - wsgiref == 0.1.2 11:22:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:38 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 0x7f4b55e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1839ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1836f60>, '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 0x1837d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18381d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:22:38 INFO - Using env: {'DISPLAY': ':0', 11:22:38 INFO - 'HOME': '/home/cltbld', 11:22:38 INFO - 'LANG': 'en_US.UTF-8', 11:22:38 INFO - 'LANGUAGE': 'en_US:en', 11:22:38 INFO - 'LOGNAME': 'cltbld', 11:22:38 INFO - 'MAIL': '/var/mail/cltbld', 11:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:38 INFO - 'MOZ_NO_REMOTE': '1', 11:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:38 INFO - 'NO_EM_RESTART': '1', 11:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:38 INFO - 'PWD': '/builds/slave/test', 11:22:38 INFO - 'SHELL': '/bin/bash', 11:22:38 INFO - 'SHLVL': '1', 11:22:38 INFO - 'TERM': 'linux', 11:22:38 INFO - 'TMOUT': '86400', 11:22:38 INFO - 'USER': 'cltbld', 11:22:38 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 11:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:38 INFO - '_': '/tools/buildbot/bin/python'} 11:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:22:38 INFO - Cleaning up... 11:22:38 INFO - Return code: 0 11:22:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:38 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 0x7f4b55e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1839ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1836f60>, '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 0x1837d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18381d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:22:38 INFO - Using env: {'DISPLAY': ':0', 11:22:38 INFO - 'HOME': '/home/cltbld', 11:22:38 INFO - 'LANG': 'en_US.UTF-8', 11:22:38 INFO - 'LANGUAGE': 'en_US:en', 11:22:38 INFO - 'LOGNAME': 'cltbld', 11:22:38 INFO - 'MAIL': '/var/mail/cltbld', 11:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:38 INFO - 'MOZ_NO_REMOTE': '1', 11:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:38 INFO - 'NO_EM_RESTART': '1', 11:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:38 INFO - 'PWD': '/builds/slave/test', 11:22:38 INFO - 'SHELL': '/bin/bash', 11:22:38 INFO - 'SHLVL': '1', 11:22:38 INFO - 'TERM': 'linux', 11:22:38 INFO - 'TMOUT': '86400', 11:22:38 INFO - 'USER': 'cltbld', 11:22:38 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 11:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:38 INFO - '_': '/tools/buildbot/bin/python'} 11:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:22:38 INFO - Cleaning up... 11:22:38 INFO - Return code: 0 11:22:38 INFO - Running post-action listener: _resource_record_post_action 11:22:38 INFO - Running post-action listener: _start_resource_monitoring 11:22:38 INFO - Starting resource monitoring. 11:22:38 INFO - [mozharness: 2016-10-10 18:22:38.877337Z] Finished create-virtualenv step (success) 11:22:38 INFO - [mozharness: 2016-10-10 18:22:38.877850Z] Running install step. 11:22:38 INFO - Running pre-action listener: _resource_record_pre_action 11:22:38 INFO - Running main action method: install 11:22:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:39 INFO - Reading from file tmpfile_stdout 11:22:39 INFO - Detecting whether we're running mozinstall >=1.0... 11:22:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:22:39 INFO - Reading from file tmpfile_stdout 11:22:39 INFO - Output received: 11:22:39 INFO - Usage: mozinstall [options] installer 11:22:39 INFO - Options: 11:22:39 INFO - -h, --help show this help message and exit 11:22:39 INFO - -d DEST, --destination=DEST 11:22:39 INFO - Directory to install application into. [default: 11:22:39 INFO - "/builds/slave/test"] 11:22:39 INFO - --app=APP Application being installed. [default: firefox] 11:22:39 INFO - mkdir: /builds/slave/test/build/application 11:22:39 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'] 11:22:39 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 11:22:55 INFO - Reading from file tmpfile_stdout 11:22:55 INFO - Output received: 11:22:55 INFO - /builds/slave/test/build/application/firefox/firefox 11:22:55 INFO - Running post-action listener: _resource_record_post_action 11:22:55 INFO - [mozharness: 2016-10-10 18:22:55.344981Z] Finished install step (success) 11:22:55 INFO - [mozharness: 2016-10-10 18:22:55.345224Z] Running run-tests step. 11:22:55 INFO - Running pre-action listener: _resource_record_pre_action 11:22:55 INFO - Running main action method: run_tests 11:22:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:22:55 INFO - Python 2.7.3 11:22:55 INFO - Return code: 0 11:22:55 INFO - grabbing minidump binary from tooltool 11:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:55 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 0x1836f60>, '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 0x1837d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18381d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:22:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:22:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:22:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:22:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:22:55 INFO - Return code: 0 11:22:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:22:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:22:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:22:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:22:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:22:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:22:55 INFO - Using env: {'DISPLAY': ':0', 11:22:55 INFO - 'HOME': '/home/cltbld', 11:22:55 INFO - 'LANG': 'en_US.UTF-8', 11:22:55 INFO - 'LANGUAGE': 'en_US:en', 11:22:55 INFO - 'LOGNAME': 'cltbld', 11:22:55 INFO - 'MAIL': '/var/mail/cltbld', 11:22:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:22:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:55 INFO - 'MOZ_NO_REMOTE': '1', 11:22:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:55 INFO - 'NO_EM_RESTART': '1', 11:22:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:55 INFO - 'PWD': '/builds/slave/test', 11:22:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:22:55 INFO - 'SHELL': '/bin/bash', 11:22:55 INFO - 'SHLVL': '1', 11:22:55 INFO - 'TERM': 'linux', 11:22:55 INFO - 'TMOUT': '86400', 11:22:55 INFO - 'USER': 'cltbld', 11:22:55 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315', 11:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:55 INFO - '_': '/tools/buildbot/bin/python'} 11:22:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:22:55 INFO - mozversion application_buildid: 20161010100123 11:22:55 INFO - mozversion application_changeset: ec2da84091f9ec100e6a16b9e56ecca95404e479 11:22:55 INFO - mozversion application_display_name: Nightly 11:22:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:22:55 INFO - mozversion application_name: Firefox 11:22:55 INFO - mozversion application_remotingname: firefox 11:22:55 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 11:22:55 INFO - mozversion application_vendor: Mozilla 11:22:55 INFO - mozversion application_version: 52.0a1 11:22:55 INFO - mozversion platform_buildid: 20161010100123 11:22:55 INFO - mozversion platform_changeset: ec2da84091f9ec100e6a16b9e56ecca95404e479 11:22:55 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 11:22:55 INFO - mozversion platform_version: 52.0a1 11:22:55 INFO - using testdate: 1476123775 11:22:55 INFO - actual date: 1476123775 11:22:55 INFO - starting webserver on 'localhost:39737' 11:22:55 INFO - SUITE-START | Running 2 tests 11:22:55 INFO - TEST-START | dromaeo_css 11:22:55 INFO - operating with platform_type : linux_ 11:22:55 INFO - Initialising browser for dromaeo_css test... 11:22:55 INFO - TEST-INFO | started process 15734 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph43t4D/profile http://localhost:39737/getInfo.html) 11:23:00 INFO - PROCESS | 15734 | __metrics Screen width/height:1600/1200 11:23:00 INFO - PROCESS | 15734 | colorDepth:24 11:23:00 INFO - PROCESS | 15734 | Browser inner width/height: 1024/697 11:23:00 INFO - PROCESS | 15734 | __metrics 11:23:00 INFO - PROCESS | 15734 | 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" 11:23:00 INFO - PROCESS | 15734 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:23:01 INFO - PROCESS | 15734 | console.error: PushService: 11:23:01 INFO - PROCESS | 15734 | stateChangeProcessEnqueue: Error transitioning state 11:23:01 INFO - PROCESS | 15734 | UnknownError 11:23:02 INFO - TEST-INFO | 15734: exit 0 11:23:02 INFO - Browser initialized. 11:23:02 INFO - Running cycle 1/1 for dromaeo_css test... 11:23:02 INFO - TEST-INFO | started process 15818 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph43t4D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:23:14 INFO - PROCESS | 15818 | RSS: Main: 177692672 11:23:14 INFO - PROCESS | 15818 | 11:24:06 INFO - PROCESS | 15818 | 1476123846257 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] 11:26:19 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:39737/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39737/tests/dromaeo/cssquery-ext.html) 11:26:21 INFO - PROCESS | 15818 | RSS: Main: 341553152 11:26:21 INFO - PROCESS | 15818 | 11:29:24 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:39737/tests/dromaeo/cssquery-ext.html (next: http://localhost:39737/tests/dromaeo/cssquery-jquery.html) 11:29:24 INFO - PROCESS | 15818 | RSS: Main: 283189248 11:29:24 INFO - PROCESS | 15818 | 11:32:27 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:39737/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39737/tests/dromaeo/cssquery-mootools.html) 11:32:27 INFO - PROCESS | 15818 | RSS: Main: 222076928 11:32:27 INFO - PROCESS | 15818 | 11:35:30 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:39737/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39737/tests/dromaeo/cssquery-prototype.html) 11:35:30 INFO - PROCESS | 15818 | RSS: Main: 223068160 11:35:30 INFO - PROCESS | 15818 | 11:38:33 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:39737/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39737/tests/dromaeo/cssquery-yui.html) 11:38:34 INFO - PROCESS | 15818 | RSS: Main: 221409280 11:38:34 INFO - PROCESS | 15818 | 11:41:37 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:39737/tests/dromaeo/cssquery-yui.html (next: http://localhost:39737/tests/dromaeo/cssquery-dojo.html) 11:41:37 INFO - PROCESS | 15818 | RSS: Main: 314548224 11:41:37 INFO - PROCESS | 15818 | 11:41:37 INFO - PROCESS | 15818 | __start_tp_report 11:41:37 INFO - PROCESS | 15818 | _x_x_mozilla_page_load 11:41:37 INFO - PROCESS | 15818 | _x_x_mozilla_page_load_details 11:41:37 INFO - PROCESS | 15818 | |i|pagename|runs| 11:41:37 INFO - PROCESS | 15818 | |0;dojo.html;2538.238528441467;2538.606515990022;2583.80621453391;2588.4693637804253;2599.220233929822;4462.040661257829;4551.6358691304695;4576.359309696637;4588.724676519407;4591.219492686243;4555.476120246164;4572.337011133392;4578.038611891507;4599.471060828006;4612.769361531927;4173.165366926612;4199.3281075028;4211.894702632428;4218.346156345771;4282.721623094504;4298.677599180059;4336.414584031147;4340;4362.520122786491;4379.956200437987;4177.12280421112;4216.135692183095;4217.493900731932;4267.4025636410925;4350.108227813291;4168.874933751992;4180.602842729936;4199.076203235283;4201.2017716633745;4262.12626411588;4134.235166494178;4143.109231515208;4151.045259590281;4188.874333769992;4190.266703326936;4483.730976141442;4511.481179664348;4540.909181816345;4543.5002149763495;4586.334981427708;4794.424669039703;4799.0401919616215;4816.325714399987;4837.129316722989;4842.15262329091;4839.05638400512;4840.975795121037;4841.540053694928;4909.288153217799;4916.311716359713;4526.841560545365;4537.546245375502;4537.568930951587;4543.522930092358;4588.197065513522;4868.659193856396;4902.068606964665;4912.410510738734;4953.455119936804;4957.182064959241;4737.739424331626;4774.40319960005;4777.355057067251;4778.928316075262;4780.259059845729;4848.248521479177;4851.95148048515;4852.56326930578;4855.514448555187;4859.222524396079;4774.9522504775205;4806.927896081562;4817.181079216542;4818.469968303484;4831.154547954094;4810.39870016248;4810.749205206672;4817.2774083887;4817.494163112893;4820.807167713322;4170.52039015511;4196.622303992594;4213.726107802983;4226.387173859773;4266.914661706748;3640.927181456356;3653.707703383723;3675.1547144156993;3687.483752274684;3752.549694036733;4199.97900010498;4208.789560521962;4209.221294060609;4249.978750106292;4263.16868210696;4828.66199366048;4874.390701162355;4882.023595280887;4910.116179087727;4924.4583095859425;4167.562405947332;4167.708260421802;4193.161367726406;4216.135692183157;4217.599328063829;4383.07955329378;4396.846110386121;4399.978000109979;4404.53752355998;4442.333649952533;4480.663950203682;4524.208263553799;4535.546445355438;4552.817887284604;4613.192691278946;4868.318435419115;4882.780274887709;4887.853364399074;4933.777979990838;4949.505049495022;4568.703034302893;4572.542745725401;4579.885502862455;4580.038191979722;4637.513061128533;4772.785224664829;4807;4808.975955120202;4819.759012049313;4866.343043689057;4928.112939670894;4938.061768264019;4939.580135688363;4940.333055037524;4944.035912997075;4756.667033307635;4768.904621907473;4781.904361912672;4803.831865884677;4810.831620893252;4766.261229509431;4808.9519104808505;4814.662973591815;4874.805007799649;4876.268559715929;4692.694974826762;4731.077439899186;4733.763311834464;4736.502667219892;4790.688605240648;4632.606228470618;4745.098431298043;4825.3485779419325;4835.081334546425;4898.583620392164;4700.365450664117;4704.788284527136;4738.31294462308;4739.52604739537;4803.975980120077 11:41:37 INFO - PROCESS | 15818 | |1;ext.html;566.6713306282356;575.5338176077378;578.118369486533;579.9739011744471;580.3326174898866;28840.423191536156;30207.24481887954;30237;30245.395092098144;30255.69744302556;30483.695163048364;30977.845110774415;31077.82455228135;38193.7083774973;38617.61382386175;7557.50876193047;7696.846063078735;7698.576578288192;7699.692012319529;7699.845023246502;7509.286617771303;7579.81050473737;7640.465167438281;7674.731384401547;7679.040119985002;7166.068411106548;7326.450516211279;7656.846863062736;7690.730824421146;9827.508624568778;9788.38491648877;9890.109890109852;9904.059114384121;9906.55420506079;9915;9769.90230097704;9964;9984.051515106054;9989.350692205056;9992.750181245454;37782.055448613726;38093;38103.237935241414;38121.61878381208;38126.80936595327;2780.2215379693716;2815.831050136978;2897.1887871396043;2940.794144409892;3373.96626033739;28091;28176.15471535857;28182.225095737842;28263.57604635932;29294.707052929625;3296.1594793327786;3338.4992251162275;3357.697807197364;3379.509971054208;3420.264643101745;179902;179985.10007450142;180194;180213;180833;53838.73080634572;54153.729231353595;54157;54197;54213;32868;33926;56518.434815651315;56784.14823777647;56800;15007.774883376758;15583.454579089905;15600.765988510182;15607.453739119077;15609.531714048597;11293.43532823372;11475.483603237873;11494.885051149382;11496.597619083459;11509;18033.655624768697;18084.90957545204;18262.452126436227;18288.268469261082;18314.358997435025;5503.834884953458;6759.222689390783;6785.355391237923;6926.272741362185;7005.710688430305;766.9194734552792;795.383577727266;836.2807985132781;881.7531091294447;981.5389056737147;24959.251222463354;26102;26459.73540264573;26474.735252647613;27232.727672723417;897.0760117079419;919.3702313914989;934.1965909317981;982.3074732313702;1021.8313978193515;13434.529791457253;13887.930560347335;13972.371243294076;14255.78616320756;14284.928575357264;397689;412293;412394;413350;413993;50012.49987500079;50649.74675126601;50697.74651126721;50707.74646126746;50731.74634126806;1082.7726177502814;1109.0960866893456;1160.8548931383577;1190.2263528706237;1208.1603285716342;26451.60322595124;29261.294047660504;29571.704282956896;30121.69878301189;30143.698563014088;42303;42800.1439971205;42982.57017429911;42991.9063354543;43006;323745;327585;328092;328180;328668;37217;38351.80824095861;38499.615003849605;38680.80659596684;41907.37138942979;41035.7948210257;41153.588464114975;41198.79400602978;41434.820647419074;42739.358909617;35906.8204658975;36435.720785129466;36480.45279320866;36639;36828.631713682524;36045;36339.81830090833;36366;36418.27163456663;36520.81739591285;33658.66341336555;34233.828830856684;34270.828645856614;34359.65640343565;34931.301373972885;30587.2353191172;32660.34679306448;32747.34505309928;32779.67220327766;33086.83456582702;24207.75792242055;24295.49355366634;24625.539223518077;24683.62974555419;25026.499470010134 11:41:37 INFO - PROCESS | 15818 | |2;jquery.html;329.2739509381813;345.70096866210736;351.3640311037024;353.44156233151625;373.49391574416666;12027.51889924403;15590.532284031484;16456.588585285375;16601;17825.7326140108;16807;16941.745873811873;17334.826651733478;17527.12364381782;17674.38139665112;4877.317175595419;5106.4382917879;5113.514216149479;5201.895962080756;5452.2094296327;3450.0857272822723;5512.862178445531;5536.972315138419;5551.944480555183;5554.527865131448;3604.3512167809786;5163.7418129093585;5448.891022179554;5466.1527463243065;5553.805616803413;5265.947340526623;5369.516743493065;5529.944700553004;5537.667739935597;5538.335399752055;5221.216817477371;5228.085085110129;5235.293235413246;5235.973820130913;5236.895262094775;12346.876531234753;12430.943369813576;12581.685457863627;14756.335964881499;19860.205591776456;1817.1277786662345;1832.890026598395;1942.2522328903333;2053.188990348804;2200.570888676709;8784.209421152127;9130.908690913138;9367.484788336638;9655.131038206526;9717.61129554817;1528.2664321125922;1581.636223668551;1605.5343950254412;1618.3283937166061;1623.1397359399537;64214.67892660507;67194.3280567193;68726.31273687299;69668.6516567414;69899.30100698979;9899.65351212704;10119.544620492095;10310.845337319946;10351.585936562453;10372;13729.382177802023;13755.79366309506;13816.171029738249;13838.100523465942;13843.584692459242;7332.816679583053;7355.374793142642;7412.629368531552;7467.887981680171;7577.810554736066;6945.51381403307;7036.331548502884;7115.181754098241;7262.273772622695;7321.78034658961;4256.2764330063965;4324.632406245504;4350.195213885441;4453.376527286183;4483.461984561874;1776.786785585738;1804.4316040447218;1839.5677015901254;1840.153529376475;1841.3279153109286;787.0633945604826;796.9242921922408;801.3509057663312;842.3682238321259;913.8583519554479;16075.678486430439;16160.191990400433;16823.32706691743;18016.819831801775;18169.36407225741;801.7755028592004;829.4940086547201;829.668132746894;831.6465502161557;887.9600417981206;9024.593893274818;9149.77125571866;9743.366681165702;9806.65676701312;10061.245406594535;388145;388863;389970;391148;402369;79753.82830974512;81566.59216703879;82336;83971.5801420989;84911.57544212363;925.1488630459993;927.7309580221795;936.7470782888582;943.1605870775015;946.6450081219542;14853.851461485247;15192.772108418603;15404.46084387041;15422.922885385502;15677.216139193222;35216.295674085864;37253.81373093117;37389.25221495609;37644.81177594094;37781.05547361338;49369.25946110883;49391;49935;50616.49383506118;52471.47528524818;6518.902216466851;6877.518573699993;6900.378965893094;7246.094238220223;7826.5129625371;9233.538323083952;11371.43142842871;11593.434886290243;11599.304041757521;11920.165588408729;9785.853212201964;10045.547950342107;10160.23798215122;10431.634892778717;10552.630657926935;10017.799644007226;10041.949790251001;10189.490525473844;10284.382937023802;10315.638952636622;9911.702648920544;10320;10358.741031474274;10380.948095259475;10422.583096676351;7146.499745017799;7155;7170.89243661356;7290.125184977836;7475.738349157753;8757.43076700038;10155.187584993035;10201.74495637615;10206.846897296695;10615 11:41:37 INFO - PROCESS | 15818 | |3;mootools.html;1230.9569165079224;1339.3102552185624;1375.807386965825;1442.8052212951247;1681.1090122235212;6286.9056964145575;7266.927330726691;7513.985611942386;7517;7522.96238518808;7351.4118870490365;7422.443316751238;7425.962870185655;7428.442866784999;7430.479866409353;1956.1490751523097;1979.6535606268917;1983.1769815526538;1984.0575726529855;1986.3445063129204;1943.2032866524728;1985.076939223261;1989.7413336266266;1990.3332383651493;1993.1827950540282;1956.4032969944162;1973.1712680674152;1977.6736838421643;1986.4835142862887;1986.920523179071;1912.225548652798;1913.5598812273115;1917.0989634871587;1918.9040547972545;1919.7696276446845;1856.9721454178198;1860.3581764291298;1862.3761040051463;1917.4247725682378;1936.1480948382807;6929.930700692979;7270.781876543712;7324.121105467378;7370.5577665339715;7390.815229619248;4219.746815191098;4387.495438024636;4390.253656878338;4392.604665580113;4393.51671316155;2548.6431899533895;2666.7466590673853;2703.2701170683804;2704.7024827268983;2705.9323516912236;815.2744057788573;817.65249768848;830.0495932157706;831.1522247307772;841.4530555139147;9792.412455252708;9825.754356141153;9832.115109640166;9892.95053524735;9919.454430006346;3624.836882340301;3658.8719394821055;3748.3815170496564;3779.168582911755;3827.1197624545953;7931.167227441151;7936;7936.127026027132;7939.801504962422;7946.483478573874;4341.739495630272;4346.174226896879;4354.303311470149;4355.586219309161;4358.585934336296;3519.1729943463265;3634;3920.5883382244456;4062.0251139726843;4068.450759147477;3122.968770312313;3180.189051791778;3255.983720081432;3278.885239016623;3285.244393789442;974.6296407365156;975.1564896364594;977.2719324103589;987.1066684650403;994.145035269682;792.4136139257024;799.9840003199903;812.3217113710118;812.695239285268;829.655692887445;4721.693089949143;4798.088363210979;4818.349522814376;4823.782929768169;5097.057044446715;358.4211498430069;367.1958411079727;369.7799809113573;372.71114885963055;372.93287208302223;3206.3266713989856;3443.345764304824;3455.0844026333043;3492.633273506296;3507.9123021924147;8246.752597422086;8912.108789121035;8965.058668839809;8974.14745599167;8978.82042359149;8893.021767605558;8903.065178156201;8918.331125165638;8918.643254269757;8925.419847709878;6645.202575690948;6799.490038247052;6809.795706128824;6826.317368263134;6826.761063362758;4936.2102063669645;4937.259411088366;4950.603951683928;4952.083864485082;4964.106460837084;8117.391195660231;8148;8233.83532329338;8288.33693304522;8337.666493340199;8310.750677479686;8356.415050946618;8380.958095209486;8431.789205269917;8542.74371768848;5459.39946605881;6031.728572214173;6109.877802443837;6141.815745527641;6147.723352449061;6227.065940108839;6589.439897608757;6910.343517365842;6932;7089.751858684921;6161.260648722182;6193.009118541012;6201.348858369986;6231.781887633911;6357.268914074941;6084.087386891824;6124.0163174116415;6127.050307202391;6149.7847575334645;6269.153664255449;5823.650580965155;5902.557308201988;5956.166136740946;5956.344802071855;5958.553108516792;4165.958340416557;4213.220554197484;4292.098659281586;4324.718893271927;4433.024734558392;4221.831126754895;4222.809973551259;4233.259179643612;4291.67812414064;4386.38590597323 11:41:37 INFO - PROCESS | 15818 | |4;prototype.html;280.0841249115393;283.21549308415683;286.77918003137586;291.9051308324795;292.7146032618199;4483.305087711402;4708.223143181375;4708.764561771911;4710.199266124759;4725.889415987244;4625.838095666652;4662.720236785795;4666.580007799297;4668.6731928765;4672.859814205579;3429;3564.6473327603785;3647.4528820676846;3657.4330978698276;3659.1035196376924;3553.9466907996402;3659.652333028358;3665.8533658653755;3669.4495825626236;3676.8161591920298;3611.368010598148;3618.764780289286;3620.294042661682;3621.8591143789754;3625.2205775758207;3427.5544179256785;3536.7701099428455;3633.94549081764;3634.0382588190673;3649.233660931208;3099.1714888215834;3155.374981884331;3164.4145833020734;3167.7465802735724;3181.141091905196;4559.247724125516;4559.270516717343;4568.977155114203;4572.977135114304;4573.839915602938;4109.301418758818;4136.503619565641;4142.2868021446;4151.3150330195485;4151.875443736662;4603.608693261077;4847.636427267969;4867.148249056401;4868.663041739985;4891.339669144655;3458.890077052996;3464.2725027744204;3465.480177973299;3479.8782042628386;3482.2165012872156;5089.6691715038405;5114.232865070232;5118.155504341779;5134.358205224347;5135.563477104488;3358.3115461330367;3519.6128425873135;3520.3663340598428;3528.047427194643;3528.4354503279865;3571.928561428757;3577.284543091392;3577.481265216529;3602.6397360264286;3604.4052731299566;4102.630763231324;4107.609777071173;4121.711480196417;4124.175164967019;4140.441040459499;4946.975265123651;4949.356583644103;4953.43035550909;4969;4974.602031837444;1200.3518100225954;1240.4356018011783;1244.2161438293997;1245.420879291134;1253.2417887178126;773.3658400111967;788.9132195458495;806.3549160671439;808.9160524896666;809.5345176523523;3878.8836334909997;3882.6311500407414;4127.936031984008;4208.473940757405;4262.637675797592;4950.4059512858685;4968.701877887338;4972.801087956514;5051.444341122474;5086.72023038729;4343.978280108642;4353.368761529624;4363.585459381354;4366.978165109218;4380.978095109568;2607.9869600652255;2654.137405343271;2666.306760242312;2677.7857771378244;2699.3656490724666;4757.833475828329;4769.8569042928075;4776.617870570346;4780.832670856504;4783;5189.169732842803;5196;5204.4535323791215;5210.739463026834;5211.530962213419;4578.748168850745;4746.976265118652;4764;4783.832565860178;4823.155947709137;5006.424261210008;5012.448630650552;5035.748212589429;5041.6470847040355;5045.646804723634;4929.950700492949;4950.9257361140335;4952.935118949299;4985.775640096132;5005.4744251853035;4596.218642830794;4751.976240118777;4766.475687674422;4780.067886762048;4786.712797232177;3472.2361080562237;3487.0584942064993;3493.3537295600395;3494.633063528395;3495.8601655933476;5012.248162775467;5024.271480635361;5043.2939388486375;5062.746862656926;5095.344013195652;4756.91115372324;4817.759112044314;4887.36464259644;4891.070696567641;4892.730899800546;4893.168161412497;4897.167481528078;4899.755012249445;4906.362172917497;4957.429895562056;4828.782704778364;4840.588549973291;4880;4882.389701287339;4903.583195428429;4816.590589799906;4903.688248419038;4964.4539100698175;4967.900641987212;4968.329275547755;4618.584327410549;4632.5135860734135;4740.956989462451;4772.832950846704;4777.617790576676 11:41:37 INFO - PROCESS | 15818 | |5;yui.html;601.0743455079179;609.1785561172095;653.5915053091818;667.2193533565728;680.9455243580514;12220.572279970203;12820.93589532051;12822.80765788514;12828.743425131503;12829.294388808636;12361.134720569542;12632.747345053116;12877.871221287784;12906.677333066678;13007.73984520309;748.648135376375;764.6100488750749;765.7932358263265;766.7967988483057;767.8541077195315;610.7251736718472;636.9012803015517;753.6194221917924;778.0624347661084;785.5208322923013;816.0941355095839;816.942814003017;818.6316157729016;818.8894499242615;819.573821612761;812.5977641067709;813.8535063688533;814.071957967917;814.2264848393991;814.6782021101691;472.46375363961806;488.14087206516433;566.5071387892518;585.4350551717613;599.194083957077;12316.81524777129;12325.753484930252;12346.382680865921;12348.197367171106;12354.62936111909;11734;12213.938930305381;12333.013358931265;12404.689882752913;12634.620961371174;11167.664970050912;11199.944000280027;11512.827307590393;11616.767664646744;11636.76726465466;3970.3250447424007;3980.86066987654;4018.477597912282;4053.97973010136;4054.6350828425584;61413.385866141216;61724.69137654328;61748.0737788938;62176;62506.0624090639;9093.4998575079;9265.44407335562;9989;10110.949445252727;10120.366489011294;19377.321793737152;19777.30779422742;19814.50463738418;19869.105890234972;20129;6467.353264673589;6501.187351581052;6663.06717059612;6699.330066993359;6877.071595334666;3387.3902697514686;3518.0677120563073;3624.3657359961903;3657.3416784978426;3732.5894151643297;2838.7161283871446;2924.3712601790294;2949.601803756508;2960.541116126961;2965.599644048069;509.5465036117858;513.3608657221782;522.7699812082672;530.1173546045791;538.7037129578716;578.3522454850511;611.810338794975;618.4063299232697;619.9318075011745;637.0285314894822;7237.598635949019;7786.532808031537;7955.005624296963;8404.747857564284;8455.239028487465;483.6179418259606;552.1607157121233;567.3730527766759;583.1486030395586;584.9678267695233;3903.4730311408166;3904.882853514399;3920.3727403615853;3921.509811273591;4033.2941735196223;48796.5120348792;57589.97810703142;67573.32426675769;106931;107420;56198.7190064047;68065.65967170133;69251;69578;87664.6850297246;51887.74056129695;68872;70908;72186.63906680538;72545;7958.84082318362;8047.315978141689;8080.515169089874;8155.225253600898;8479.448835825651;30704.385912282076;33488.83255583706;40226;41162.176756464105;41936.3709544351;56050;61463.692681536304;62483.37516624776;65659.34340656723;65713.34286657264;10313.587456501957;10498.95010498944;11100.833487497855;11223.887761122285;11346.773064538498;12426.502939882303;12720.74558508843;13027.413766380725;13257.801132983206;13423;11474.254173478697;11478.356383244163;11490;12006.965174129353;12127.332996685267;11976.700582485508;12144.453499592717;12342.50629974827;12417.441215145522;12612.747745045232;11201.943990280322;11346.716332091764;11471.082313415074;11952.76094478123;12030.218035827644;10122.190224782147;10490.324967133332;10758.623448179276;10925.672229833117;11354.602588909349;10180.338278012201;10253.436061016417;10293;10300.175985921258;10327.32872363294 11:41:37 INFO - PROCESS | 15818 | __end_tp_report 11:41:37 INFO - PROCESS | 15818 | __start_cc_report 11:41:37 INFO - PROCESS | 15818 | _x_x_mozilla_cycle_collect,1769 11:41:37 INFO - PROCESS | 15818 | __end_cc_report 11:41:37 INFO - PROCESS | 15818 | __startTimestamp1476124897413__endTimestamp 11:41:37 INFO - PROCESS | 15818 | 11:41:37 INFO - PROCESS | 15818 | ------- Summary: start ------- 11:41:37 INFO - PROCESS | 15818 | Number of tests: 6 11:41:37 INFO - PROCESS | 15818 | 11:41:37 INFO - PROCESS | 15818 | [#0] dojo.html Cycles:165 Average:4517.49 Median:4612.77 stddev:457.65 (9.9%) stddev-sans-first:431.92 11:41:37 INFO - PROCESS | 15818 | Values: 2538.2 2538.6 2583.8 2588.5 2599.2 4462.0 4551.6 4576.4 4588.7 4591.2 4555.5 4572.3 4578.0 4599.5 4612.8 4173.2 4199.3 4211.9 4218.3 4282.7 4298.7 4336.4 4340.0 4362.5 4380.0 4177.1 4216.1 4217.5 4267.4 4350.1 4168.9 4180.6 4199.1 4201.2 4262.1 4134.2 4143.1 4151.0 4188.9 4190.3 4483.7 4511.5 4540.9 4543.5 4586.3 4794.4 4799.0 4816.3 4837.1 4842.2 4839.1 4841.0 4841.5 4909.3 4916.3 4526.8 4537.5 4537.6 4543.5 4588.2 4868.7 4902.1 4912.4 4953.5 4957.2 4737.7 4774.4 4777.4 4778.9 4780.3 4848.2 4852.0 4852.6 4855.5 4859.2 4775.0 4806.9 4817.2 4818.5 4831.2 4810.4 4810.7 4817.3 4817.5 4820.8 4170.5 4196.6 4213.7 4226.4 4266.9 3640.9 3653.7 3675.2 3687.5 3752.5 4200.0 4208.8 4209.2 4250.0 4263.2 4828.7 4874.4 4882.0 4910.1 4924.5 4167.6 4167.7 4193.2 4216.1 4217.6 4383.1 4396.8 4400.0 4404.5 4442.3 4480.7 4524.2 4535.5 4552.8 4613.2 4868.3 4882.8 4887.9 4933.8 4949.5 4568.7 4572.5 4579.9 4580.0 4637.5 4772.8 4807.0 4809.0 4819.8 4866.3 4928.1 4938.1 4939.6 4940.3 4944.0 4756.7 4768.9 4781.9 4803.8 4810.8 4766.3 4809.0 4814.7 4874.8 4876.3 4692.7 4731.1 4733.8 4736.5 4790.7 4632.6 4745.1 4825.3 4835.1 4898.6 4700.4 4704.8 4738.3 4739.5 4804.0 11:41:37 INFO - PROCESS | 15818 | 11:41:37 INFO - PROCESS | 15818 | [#1] ext.html Cycles:180 Average:46138.29 Median:36427.00 stddev:84668.80 (232.4%) stddev-sans-first:84837.19 11:41:37 INFO - PROCESS | 15818 | Values: 566.7 575.5 578.1 580.0 580.3 28840.4 30207.2 30237.0 30245.4 30255.7 30483.7 30977.8 31077.8 38193.7 38617.6 7557.5 7696.8 7698.6 7699.7 7699.8 7509.3 7579.8 7640.5 7674.7 7679.0 7166.1 7326.5 7656.8 7690.7 9827.5 9788.4 9890.1 9904.1 9906.6 9915.0 9769.9 9964.0 9984.1 9989.4 9992.8 37782.1 38093.0 38103.2 38121.6 38126.8 2780.2 2815.8 2897.2 2940.8 3374.0 28091.0 28176.2 28182.2 28263.6 29294.7 3296.2 3338.5 3357.7 3379.5 3420.3 179902.0 179985.1 180194.0 180213.0 180833.0 53838.7 54153.7 54157.0 54197.0 54213.0 32868.0 33926.0 56518.4 56784.1 56800.0 15007.8 15583.5 15600.8 15607.5 15609.5 11293.4 11475.5 11494.9 11496.6 11509.0 18033.7 18084.9 18262.5 18288.3 18314.4 5503.8 6759.2 6785.4 6926.3 7005.7 766.9 795.4 836.3 881.8 981.5 24959.3 26102.0 26459.7 26474.7 27232.7 897.1 919.4 934.2 982.3 1021.8 13434.5 13887.9 13972.4 14255.8 14284.9 397689.0 412293.0 412394.0 413350.0 413993.0 50012.5 50649.7 50697.7 50707.7 50731.7 1082.8 1109.1 1160.9 1190.2 1208.2 26451.6 29261.3 29571.7 30121.7 30143.7 42303.0 42800.1 42982.6 42991.9 43006.0 323745.0 327585.0 328092.0 328180.0 328668.0 37217.0 38351.8 38499.6 38680.8 41907.4 41035.8 41153.6 41198.8 41434.8 42739.4 35906.8 36435.7 36480.5 36639.0 36828.6 36045.0 36339.8 36366.0 36418.3 36520.8 33658.7 34233.8 34270.8 34359.7 34931.3 30587.2 32660.3 32747.3 32779.7 33086.8 24207.8 24295.5 24625.5 24683.6 25026.5 11:41:37 INFO - PROCESS | 15818 | 11:41:37 INFO - PROCESS | 15818 | [#2] jquery.html Cycles:180 Average:24220.41 Median:4401.79 stddev:64874.40 (1473.8%) stddev-sans-first:65031.59 11:41:37 INFO - PROCESS | 15818 | Values: 329.3 345.7 351.4 353.4 373.5 12027.5 15590.5 16456.6 16601.0 17825.7 16807.0 16941.7 17334.8 17527.1 17674.4 4877.3 5106.4 5113.5 5201.9 5452.2 3450.1 5512.9 5537.0 5551.9 5554.5 3604.4 5163.7 5448.9 5466.2 5553.8 5265.9 5369.5 5529.9 5537.7 5538.3 5221.2 5228.1 5235.3 5236.0 5236.9 12346.9 12430.9 12581.7 14756.3 19860.2 1817.1 1832.9 1942.3 2053.2 2200.6 8784.2 9130.9 9367.5 9655.1 9717.6 1528.3 1581.6 1605.5 1618.3 1623.1 64214.7 67194.3 68726.3 69668.7 69899.3 9899.7 10119.5 10310.8 10351.6 10372.0 13729.4 13755.8 13816.2 13838.1 13843.6 7332.8 7355.4 7412.6 7467.9 7577.8 6945.5 7036.3 7115.2 7262.3 7321.8 4256.3 4324.6 4350.2 4453.4 4483.5 1776.8 1804.4 1839.6 1840.2 1841.3 787.1 796.9 801.4 842.4 913.9 16075.7 16160.2 16823.3 18016.8 18169.4 801.8 829.5 829.7 831.6 888.0 9024.6 9149.8 9743.4 9806.7 10061.2 388145.0 388863.0 389970.0 391148.0 402369.0 79753.8 81566.6 82336.0 83971.6 84911.6 925.1 927.7 936.7 943.2 946.6 14853.9 15192.8 15404.5 15422.9 15677.2 35216.3 37253.8 37389.3 37644.8 37781.1 49369.3 49391.0 49935.0 50616.5 52471.5 6518.9 6877.5 6900.4 7246.1 7826.5 9233.5 11371.4 11593.4 11599.3 11920.2 9785.9 10045.5 10160.2 10431.6 10552.6 10017.8 10041.9 10189.5 10284.4 10315.6 9911.7 10320.0 10358.7 10380.9 10422.6 7146.5 7155.0 7170.9 7290.1 7475.7 8757.4 10155.2 10201.7 10206.8 10615.0 11:41:37 INFO - PROCESS | 15818 | 11:41:37 INFO - PROCESS | 15818 | [#3] mootools.html Cycles:180 Average:4720.25 Median:5641.53 stddev:2677.17 (47.5%) stddev-sans-first:2671.83 11:41:37 INFO - PROCESS | 15818 | Values: 1231.0 1339.3 1375.8 1442.8 1681.1 6286.9 7266.9 7514.0 7517.0 7523.0 7351.4 7422.4 7426.0 7428.4 7430.5 1956.1 1979.7 1983.2 1984.1 1986.3 1943.2 1985.1 1989.7 1990.3 1993.2 1956.4 1973.2 1977.7 1986.5 1986.9 1912.2 1913.6 1917.1 1918.9 1919.8 1857.0 1860.4 1862.4 1917.4 1936.1 6929.9 7270.8 7324.1 7370.6 7390.8 4219.7 4387.5 4390.3 4392.6 4393.5 2548.6 2666.7 2703.3 2704.7 2705.9 815.3 817.7 830.0 831.2 841.5 9792.4 9825.8 9832.1 9893.0 9919.5 3624.8 3658.9 3748.4 3779.2 3827.1 7931.2 7936.0 7936.1 7939.8 7946.5 4341.7 4346.2 4354.3 4355.6 4358.6 3519.2 3634.0 3920.6 4062.0 4068.5 3123.0 3180.2 3256.0 3278.9 3285.2 974.6 975.2 977.3 987.1 994.1 792.4 800.0 812.3 812.7 829.7 4721.7 4798.1 4818.3 4823.8 5097.1 358.4 367.2 369.8 372.7 372.9 3206.3 3443.3 3455.1 3492.6 3507.9 8246.8 8912.1 8965.1 8974.1 8978.8 8893.0 8903.1 8918.3 8918.6 8925.4 6645.2 6799.5 6809.8 6826.3 6826.8 4936.2 4937.3 4950.6 4952.1 4964.1 8117.4 8148.0 8233.8 8288.3 8337.7 8310.8 8356.4 8381.0 8431.8 8542.7 5459.4 6031.7 6109.9 6141.8 6147.7 6227.1 6589.4 6910.3 6932.0 7089.8 6161.3 6193.0 6201.3 6231.8 6357.3 6084.1 6124.0 6127.1 6149.8 6269.2 5823.7 5902.6 5956.2 5956.3 5958.6 4166.0 4213.2 4292.1 4324.7 4433.0 4221.8 4222.8 4233.3 4291.7 4386.4 11:41:37 INFO - PROCESS | 15818 | 11:41:37 INFO - PROCESS | 15818 | [#4] prototype.html Cycles:180 Average:4051.13 Median:4629.18 stddev:1192.15 (25.8%) stddev-sans-first:1161.41 11:41:37 INFO - PROCESS | 15818 | Values: 280.1 283.2 286.8 291.9 292.7 4483.3 4708.2 4708.8 4710.2 4725.9 4625.8 4662.7 4666.6 4668.7 4672.9 3429.0 3564.6 3647.5 3657.4 3659.1 3553.9 3659.7 3665.9 3669.4 3676.8 3611.4 3618.8 3620.3 3621.9 3625.2 3427.6 3536.8 3633.9 3634.0 3649.2 3099.2 3155.4 3164.4 3167.7 3181.1 4559.2 4559.3 4569.0 4573.0 4573.8 4109.3 4136.5 4142.3 4151.3 4151.9 4603.6 4847.6 4867.1 4868.7 4891.3 3458.9 3464.3 3465.5 3479.9 3482.2 5089.7 5114.2 5118.2 5134.4 5135.6 3358.3 3519.6 3520.4 3528.0 3528.4 3571.9 3577.3 3577.5 3602.6 3604.4 4102.6 4107.6 4121.7 4124.2 4140.4 4947.0 4949.4 4953.4 4969.0 4974.6 1200.4 1240.4 1244.2 1245.4 1253.2 773.4 788.9 806.4 808.9 809.5 3878.9 3882.6 4127.9 4208.5 4262.6 4950.4 4968.7 4972.8 5051.4 5086.7 4344.0 4353.4 4363.6 4367.0 4381.0 2608.0 2654.1 2666.3 2677.8 2699.4 4757.8 4769.9 4776.6 4780.8 4783.0 5189.2 5196.0 5204.5 5210.7 5211.5 4578.7 4747.0 4764.0 4783.8 4823.2 5006.4 5012.4 5035.7 5041.6 5045.6 4930.0 4950.9 4952.9 4985.8 5005.5 4596.2 4752.0 4766.5 4780.1 4786.7 3472.2 3487.1 3493.4 3494.6 3495.9 5012.2 5024.3 5043.3 5062.7 5095.3 4756.9 4817.8 4887.4 4891.1 4892.7 4893.2 4897.2 4899.8 4906.4 4957.4 4828.8 4840.6 4880.0 4882.4 4903.6 4816.6 4903.7 4964.5 4967.9 4968.3 4618.6 4632.5 4741.0 4772.8 4777.6 11:41:37 INFO - PROCESS | 15818 | 11:41:37 INFO - PROCESS | 15818 | [#5] yui.html Cycles:180 Average:16429.70 Median:4054.31 stddev:22483.87 (554.6%) stddev-sans-first:22515.52 11:41:37 INFO - PROCESS | 15818 | Values: 601.1 609.2 653.6 667.2 680.9 12220.6 12820.9 12822.8 12828.7 12829.3 12361.1 12632.7 12877.9 12906.7 13007.7 748.6 764.6 765.8 766.8 767.9 610.7 636.9 753.6 778.1 785.5 816.1 816.9 818.6 818.9 819.6 812.6 813.9 814.1 814.2 814.7 472.5 488.1 566.5 585.4 599.2 12316.8 12325.8 12346.4 12348.2 12354.6 11734.0 12213.9 12333.0 12404.7 12634.6 11167.7 11199.9 11512.8 11616.8 11636.8 3970.3 3980.9 4018.5 4054.0 4054.6 61413.4 61724.7 61748.1 62176.0 62506.1 9093.5 9265.4 9989.0 10110.9 10120.4 19377.3 19777.3 19814.5 19869.1 20129.0 6467.4 6501.2 6663.1 6699.3 6877.1 3387.4 3518.1 3624.4 3657.3 3732.6 2838.7 2924.4 2949.6 2960.5 2965.6 509.5 513.4 522.8 530.1 538.7 578.4 611.8 618.4 619.9 637.0 7237.6 7786.5 7955.0 8404.7 8455.2 483.6 552.2 567.4 583.1 585.0 3903.5 3904.9 3920.4 3921.5 4033.3 48796.5 57590.0 67573.3 106931.0 107420.0 56198.7 68065.7 69251.0 69578.0 87664.7 51887.7 68872.0 70908.0 72186.6 72545.0 7958.8 8047.3 8080.5 8155.2 8479.4 30704.4 33488.8 40226.0 41162.2 41936.4 56050.0 61463.7 62483.4 65659.3 65713.3 10313.6 10499.0 11100.8 11223.9 11346.8 12426.5 12720.7 13027.4 13257.8 13423.0 11474.3 11478.4 11490.0 12007.0 12127.3 11976.7 12144.5 12342.5 12417.4 12612.7 11201.9 11346.7 11471.1 11952.8 12030.2 10122.2 10490.3 10758.6 10925.7 11354.6 10180.3 10253.4 10293.0 10300.2 10327.3 11:41:37 INFO - PROCESS | 15818 | -------- Summary: end -------- 11:41:37 INFO - PROCESS | 15818 | 11:41:38 INFO - TEST-INFO | 15818: exit 0 11:41:38 INFO - TEST-OK | dromaeo_css | took 1122822ms 11:41:38 INFO - TEST-START | kraken 11:41:38 INFO - operating with platform_type : linux_ 11:41:38 INFO - Initialising browser for kraken test... 11:41:38 INFO - TEST-INFO | started process 16124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn_DolT/profile http://localhost:39737/getInfo.html) 11:41:43 INFO - PROCESS | 16124 | __metrics Screen width/height:1600/1200 11:41:43 INFO - PROCESS | 16124 | colorDepth:24 11:41:43 INFO - PROCESS | 16124 | Browser inner width/height: 1024/697 11:41:43 INFO - PROCESS | 16124 | __metrics 11:41:43 INFO - PROCESS | 16124 | 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" 11:41:43 INFO - PROCESS | 16124 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:41:44 INFO - PROCESS | 16124 | console.error: PushService: 11:41:44 INFO - PROCESS | 16124 | stateChangeProcessEnqueue: Error transitioning state 11:41:44 INFO - PROCESS | 16124 | UnknownError 11:41:44 INFO - TEST-INFO | 16124: exit 0 11:41:44 INFO - Browser initialized. 11:41:44 INFO - Running cycle 1/1 for kraken test... 11:41:44 INFO - TEST-INFO | started process 16205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn_DolT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:41:57 INFO - PROCESS | 16205 | RSS: Main: 177377280 11:41:57 INFO - PROCESS | 16205 | 11:42:00 INFO - PROCESS | 16205 | Cycle 1(1): loaded http://localhost:39737/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39737/tests/kraken/driver.html?testName=audio-beat-detection) 11:42:01 INFO - PROCESS | 16205 | RSS: Main: 240144384 11:42:01 INFO - PROCESS | 16205 | 11:42:03 INFO - PROCESS | 16205 | Cycle 1(1): loaded http://localhost:39737/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39737/tests/kraken/driver.html?testName=audio-dft) 11:42:04 INFO - PROCESS | 16205 | RSS: Main: 220508160 11:42:04 INFO - PROCESS | 16205 | 11:42:07 INFO - PROCESS | 16205 | Cycle 1(1): loaded http://localhost:39737/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39737/tests/kraken/driver.html?testName=audio-fft) 11:42:08 INFO - PROCESS | 16205 | RSS: Main: 302694400 11:42:08 INFO - PROCESS | 16205 | 11:42:10 INFO - PROCESS | 16205 | Cycle 1(1): loaded http://localhost:39737/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39737/tests/kraken/driver.html?testName=audio-oscillator) 11:42:11 INFO - PROCESS | 16205 | RSS: Main: 213352448 11:42:11 INFO - PROCESS | 16205 | 11:42:13 INFO - PROCESS | 16205 | Cycle 1(1): loaded http://localhost:39737/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39737/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:42:13 INFO - PROCESS | 16205 | RSS: Main: 216150016 11:42:13 INFO - PROCESS | 16205 | 11:42:17 INFO - PROCESS | 16205 | Cycle 1(1): loaded http://localhost:39737/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39737/tests/kraken/driver.html?testName=imaging-darkroom) 11:42:17 INFO - PROCESS | 16205 | RSS: Main: 252153856 11:42:17 INFO - PROCESS | 16205 | 11:42:21 INFO - PROCESS | 16205 | Cycle 1(1): loaded http://localhost:39737/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39737/tests/kraken/driver.html?testName=imaging-desaturate) 11:42:21 INFO - PROCESS | 16205 | RSS: Main: 246231040 11:42:21 INFO - PROCESS | 16205 | 11:42:24 INFO - PROCESS | 16205 | Cycle 1(1): loaded http://localhost:39737/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39737/tests/kraken/driver.html?testName=json-parse-financial) 11:42:25 INFO - PROCESS | 16205 | RSS: Main: 248983552 11:42:25 INFO - PROCESS | 16205 | 11:42:27 INFO - PROCESS | 16205 | Cycle 1(1): loaded http://localhost:39737/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39737/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:42:27 INFO - PROCESS | 16205 | RSS: Main: 212643840 11:42:27 INFO - PROCESS | 16205 | 11:42:29 INFO - PROCESS | 16205 | Cycle 1(1): loaded http://localhost:39737/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39737/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:42:30 INFO - PROCESS | 16205 | RSS: Main: 219799552 11:42:30 INFO - PROCESS | 16205 | 11:42:32 INFO - PROCESS | 16205 | Cycle 1(1): loaded http://localhost:39737/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39737/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:42:33 INFO - PROCESS | 16205 | RSS: Main: 229494784 11:42:33 INFO - PROCESS | 16205 | 11:42:35 INFO - PROCESS | 16205 | Cycle 1(1): loaded http://localhost:39737/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:42:36 INFO - PROCESS | 16205 | RSS: Main: 238039040 11:42:36 INFO - PROCESS | 16205 | 11:42:39 INFO - PROCESS | 16205 | Cycle 1(1): loaded http://localhost:39737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:42:40 INFO - PROCESS | 16205 | RSS: Main: 234962944 11:42:40 INFO - PROCESS | 16205 | 11:42:42 INFO - PROCESS | 16205 | Cycle 1(1): loaded http://localhost:39737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39737/tests/kraken/driver.html?testName=ai-astar) 11:42:42 INFO - PROCESS | 16205 | RSS: Main: 285380608 11:42:42 INFO - PROCESS | 16205 | 11:42:42 INFO - PROCESS | 16205 | __start_tp_report 11:42:42 INFO - PROCESS | 16205 | _x_x_mozilla_page_load 11:42:42 INFO - PROCESS | 16205 | _x_x_mozilla_page_load_details 11:42:42 INFO - PROCESS | 16205 | |i|pagename|runs| 11:42:42 INFO - PROCESS | 16205 | |0;ai-astar;114;118;115;116;117;115;116;117;115;115 11:42:42 INFO - PROCESS | 16205 | |1;audio-beat-detection;151;129;134;165;130;128;130;134;163;130 11:42:42 INFO - PROCESS | 16205 | |2;audio-dft;161;160;160;163;161;162;161;162;160;161 11:42:42 INFO - PROCESS | 16205 | |3;audio-fft;76;77;77;117;76;79;77;77;103;76 11:42:42 INFO - PROCESS | 16205 | |4;audio-oscillator;84;83;130;84;83;83;110;83;84;115 11:42:42 INFO - PROCESS | 16205 | |5;imaging-gaussian-blur;118;118;118;117;117;117;117;118;117;117 11:42:42 INFO - PROCESS | 16205 | |6;imaging-darkroom;147;147;146;146;147;147;146;146;147;146 11:42:42 INFO - PROCESS | 16205 | |7;imaging-desaturate;95;94;94;95;95;94;95;95;95;94 11:42:42 INFO - PROCESS | 16205 | |8;json-parse-financial;65;65;66;73;63;71;65;68;65;65 11:42:42 INFO - PROCESS | 16205 | |9;json-stringify-tinderbox;65;66;65;65;65;65;66;71;66;66 11:42:42 INFO - PROCESS | 16205 | |10;stanford-crypto-aes;90;82;86;84;88;83;82;88;85;82 11:42:42 INFO - PROCESS | 16205 | |11;stanford-crypto-ccm;146;139;138;138;143;146;139;145;181;138 11:42:42 INFO - PROCESS | 16205 | |12;stanford-crypto-pbkdf2;180;179;177;185;180;175;176;174;179;173 11:42:42 INFO - PROCESS | 16205 | |13;stanford-crypto-sha256-iterative;71;75;69;70;69;68;68;69;69;68 11:42:42 INFO - PROCESS | 16205 | __end_tp_report 11:42:42 INFO - PROCESS | 16205 | __start_cc_report 11:42:42 INFO - PROCESS | 16205 | _x_x_mozilla_cycle_collect,1941 11:42:42 INFO - PROCESS | 16205 | __end_cc_report 11:42:42 INFO - PROCESS | 16205 | __startTimestamp1476124962318__endTimestamp 11:42:42 INFO - PROCESS | 16205 | 11:42:42 INFO - PROCESS | 16205 | ------- Summary: start ------- 11:42:42 INFO - PROCESS | 16205 | Number of tests: 14 11:42:42 INFO - PROCESS | 16205 | 11:42:42 INFO - PROCESS | 16205 | [#0] ai-astar Cycles:10 Average:115.80 Median:116.00 stddev:1.23 (1.1%) stddev-sans-first:1.12 11:42:42 INFO - PROCESS | 16205 | Values: 114.0 118.0 115.0 116.0 117.0 115.0 116.0 117.0 115.0 115.0 11:42:42 INFO - PROCESS | 16205 | 11:42:42 INFO - PROCESS | 16205 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:134.00 stddev:14.56 (10.9%) stddev-sans-first:14.83 11:42:42 INFO - PROCESS | 16205 | Values: 151.0 129.0 134.0 165.0 130.0 128.0 130.0 134.0 163.0 130.0 11:42:42 INFO - PROCESS | 16205 | 11:42:42 INFO - PROCESS | 16205 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 11:42:42 INFO - PROCESS | 16205 | Values: 161.0 160.0 160.0 163.0 161.0 162.0 161.0 162.0 160.0 161.0 11:42:42 INFO - PROCESS | 16205 | 11:42:42 INFO - PROCESS | 16205 | [#3] audio-fft Cycles:10 Average:83.50 Median:77.00 stddev:14.38 (18.7%) stddev-sans-first:14.99 11:42:42 INFO - PROCESS | 16205 | Values: 76.0 77.0 77.0 117.0 76.0 79.0 77.0 77.0 103.0 76.0 11:42:42 INFO - PROCESS | 16205 | 11:42:42 INFO - PROCESS | 16205 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:83.00 stddev:17.57 (21.2%) stddev-sans-first:18.26 11:42:42 INFO - PROCESS | 16205 | Values: 84.0 83.0 130.0 84.0 83.0 83.0 110.0 83.0 84.0 115.0 11:42:42 INFO - PROCESS | 16205 | 11:42:42 INFO - PROCESS | 16205 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:42:42 INFO - PROCESS | 16205 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 11:42:42 INFO - PROCESS | 16205 | 11:42:42 INFO - PROCESS | 16205 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:42:42 INFO - PROCESS | 16205 | Values: 147.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 11:42:42 INFO - PROCESS | 16205 | 11:42:42 INFO - PROCESS | 16205 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:42:42 INFO - PROCESS | 16205 | Values: 95.0 94.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 11:42:42 INFO - PROCESS | 16205 | 11:42:42 INFO - PROCESS | 16205 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:65.50 stddev:3.13 (4.8%) stddev-sans-first:3.27 11:42:42 INFO - PROCESS | 16205 | Values: 65.0 65.0 66.0 73.0 63.0 71.0 65.0 68.0 65.0 65.0 11:42:42 INFO - PROCESS | 16205 | 11:42:42 INFO - PROCESS | 16205 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:1.83 (2.8%) stddev-sans-first:1.90 11:42:42 INFO - PROCESS | 16205 | Values: 65.0 66.0 65.0 65.0 65.0 65.0 66.0 71.0 66.0 66.0 11:42:42 INFO - PROCESS | 16205 | 11:42:42 INFO - PROCESS | 16205 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.50 stddev:2.91 (3.4%) stddev-sans-first:2.46 11:42:42 INFO - PROCESS | 16205 | Values: 90.0 82.0 86.0 84.0 88.0 83.0 82.0 88.0 85.0 82.0 11:42:42 INFO - PROCESS | 16205 | 11:42:42 INFO - PROCESS | 16205 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:144.00 stddev:13.00 (9.0%) stddev-sans-first:13.78 11:42:42 INFO - PROCESS | 16205 | Values: 146.0 139.0 138.0 138.0 143.0 146.0 139.0 145.0 181.0 138.0 11:42:42 INFO - PROCESS | 16205 | 11:42:42 INFO - PROCESS | 16205 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.80 Median:179.00 stddev:3.55 (2.0%) stddev-sans-first:3.68 11:42:42 INFO - PROCESS | 16205 | Values: 180.0 179.0 177.0 185.0 180.0 175.0 176.0 174.0 179.0 173.0 11:42:42 INFO - PROCESS | 16205 | 11:42:42 INFO - PROCESS | 16205 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.00 stddev:2.12 (3.1%) stddev-sans-first:2.19 11:42:42 INFO - PROCESS | 16205 | Values: 71.0 75.0 69.0 70.0 69.0 68.0 68.0 69.0 69.0 68.0 11:42:42 INFO - PROCESS | 16205 | -------- Summary: end -------- 11:42:42 INFO - PROCESS | 16205 | 11:42:43 INFO - TEST-INFO | 16205: exit 0 11:42:43 INFO - TEST-OK | kraken | took 65198ms 11:42:43 INFO - SUITE-END | took 1188s 11:42:43 INFO - Completed test suite (00:19:48) 11:42:43 INFO - javascript benchmark 11:42:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2538.238528441467, 2538.606515990022, 2583.80621453391, 2588.4693637804253, 2599.220233929822, 4462.040661257829, 4551.6358691304695, 4576.359309696637, 4588.724676519407, 4591.219492686243, 4555.476120246164, 4572.337011133392, 4578.038611891507, 4599.471060828006, 4612.769361531927, 4173.165366926612, 4199.3281075028, 4211.894702632428, 4218.346156345771, 4282.721623094504, 4298.677599180059, 4336.414584031147, 4340.0, 4362.520122786491, 4379.956200437987, 4177.12280421112, 4216.135692183095, 4217.493900731932, 4267.4025636410925, 4350.108227813291, 4168.874933751992, 4180.602842729936, 4199.076203235283, 4201.2017716633745, 4262.12626411588, 4134.235166494178, 4143.109231515208, 4151.045259590281, 4188.874333769992, 4190.266703326936, 4483.730976141442, 4511.481179664348, 4540.909181816345, 4543.5002149763495, 4586.334981427708, 4794.424669039703, 4799.0401919616215, 4816.325714399987, 4837.129316722989, 4842.15262329091, 4839.05638400512, 4840.975795121037, 4841.540053694928, 4909.288153217799, 4916.311716359713, 4526.841560545365, 4537.546245375502, 4537.568930951587, 4543.522930092358, 4588.197065513522, 4868.659193856396, 4902.068606964665, 4912.410510738734, 4953.455119936804, 4957.182064959241, 4737.739424331626, 4774.40319960005, 4777.355057067251, 4778.928316075262, 4780.259059845729, 4848.248521479177, 4851.95148048515, 4852.56326930578, 4855.514448555187, 4859.222524396079, 4774.9522504775205, 4806.927896081562, 4817.181079216542, 4818.469968303484, 4831.154547954094, 4810.39870016248, 4810.749205206672, 4817.2774083887, 4817.494163112893, 4820.807167713322, 4170.52039015511, 4196.622303992594, 4213.726107802983, 4226.387173859773, 4266.914661706748, 3640.927181456356, 3653.707703383723, 3675.1547144156993, 3687.483752274684, 3752.549694036733, 4199.97900010498, 4208.789560521962, 4209.221294060609, 4249.978750106292, 4263.16868210696, 4828.66199366048, 4874.390701162355, 4882.023595280887, 4910.116179087727, 4924.4583095859425, 4167.562405947332, 4167.708260421802, 4193.161367726406, 4216.135692183157, 4217.599328063829, 4383.07955329378, 4396.846110386121, 4399.978000109979, 4404.53752355998, 4442.333649952533, 4480.663950203682, 4524.208263553799, 4535.546445355438, 4552.817887284604, 4613.192691278946, 4868.318435419115, 4882.780274887709, 4887.853364399074, 4933.777979990838, 4949.505049495022, 4568.703034302893, 4572.542745725401, 4579.885502862455, 4580.038191979722, 4637.513061128533, 4772.785224664829, 4807.0, 4808.975955120202, 4819.759012049313, 4866.343043689057, 4928.112939670894, 4938.061768264019, 4939.580135688363, 4940.333055037524, 4944.035912997075, 4756.667033307635, 4768.904621907473, 4781.904361912672, 4803.831865884677, 4810.831620893252, 4766.261229509431, 4808.9519104808505, 4814.662973591815, 4874.805007799649, 4876.268559715929, 4692.694974826762, 4731.077439899186, 4733.763311834464, 4736.502667219892, 4790.688605240648, 4632.606228470618, 4745.098431298043, 4825.3485779419325, 4835.081334546425, 4898.583620392164, 4700.365450664117, 4704.788284527136, 4738.31294462308, 4739.52604739537, 4803.975980120077], "value": 4488.996203518725, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.6713306282356, 575.5338176077378, 578.118369486533, 579.9739011744471, 580.3326174898866, 28840.423191536156, 30207.24481887954, 30237.0, 30245.395092098144, 30255.69744302556, 30483.695163048364, 30977.845110774415, 31077.82455228135, 38193.7083774973, 38617.61382386175, 7557.50876193047, 7696.846063078735, 7698.576578288192, 7699.692012319529, 7699.845023246502, 7509.286617771303, 7579.81050473737, 7640.465167438281, 7674.731384401547, 7679.040119985002, 7166.068411106548, 7326.450516211279, 7656.846863062736, 7690.730824421146, 9827.508624568778, 9788.38491648877, 9890.109890109852, 9904.059114384121, 9906.55420506079, 9915.0, 9769.90230097704, 9964.0, 9984.051515106054, 9989.350692205056, 9992.750181245454, 37782.055448613726, 38093.0, 38103.237935241414, 38121.61878381208, 38126.80936595327, 2780.2215379693716, 2815.831050136978, 2897.1887871396043, 2940.794144409892, 3373.96626033739, 28091.0, 28176.15471535857, 28182.225095737842, 28263.57604635932, 29294.707052929625, 3296.1594793327786, 3338.4992251162275, 3357.697807197364, 3379.509971054208, 3420.264643101745, 179902.0, 179985.10007450142, 180194.0, 180213.0, 180833.0, 53838.73080634572, 54153.729231353595, 54157.0, 54197.0, 54213.0, 32868.0, 33926.0, 56518.434815651315, 56784.14823777647, 56800.0, 15007.774883376758, 15583.454579089905, 15600.765988510182, 15607.453739119077, 15609.531714048597, 11293.43532823372, 11475.483603237873, 11494.885051149382, 11496.597619083459, 11509.0, 18033.655624768697, 18084.90957545204, 18262.452126436227, 18288.268469261082, 18314.358997435025, 5503.834884953458, 6759.222689390783, 6785.355391237923, 6926.272741362185, 7005.710688430305, 766.9194734552792, 795.383577727266, 836.2807985132781, 881.7531091294447, 981.5389056737147, 24959.251222463354, 26102.0, 26459.73540264573, 26474.735252647613, 27232.727672723417, 897.0760117079419, 919.3702313914989, 934.1965909317981, 982.3074732313702, 1021.8313978193515, 13434.529791457253, 13887.930560347335, 13972.371243294076, 14255.78616320756, 14284.928575357264, 397689.0, 412293.0, 412394.0, 413350.0, 413993.0, 50012.49987500079, 50649.74675126601, 50697.74651126721, 50707.74646126746, 50731.74634126806, 1082.7726177502814, 1109.0960866893456, 1160.8548931383577, 1190.2263528706237, 1208.1603285716342, 26451.60322595124, 29261.294047660504, 29571.704282956896, 30121.69878301189, 30143.698563014088, 42303.0, 42800.1439971205, 42982.57017429911, 42991.9063354543, 43006.0, 323745.0, 327585.0, 328092.0, 328180.0, 328668.0, 37217.0, 38351.80824095861, 38499.615003849605, 38680.80659596684, 41907.37138942979, 41035.7948210257, 41153.588464114975, 41198.79400602978, 41434.820647419074, 42739.358909617, 35906.8204658975, 36435.720785129466, 36480.45279320866, 36639.0, 36828.631713682524, 36045.0, 36339.81830090833, 36366.0, 36418.27163456663, 36520.81739591285, 33658.66341336555, 34233.828830856684, 34270.828645856614, 34359.65640343565, 34931.301373972885, 30587.2353191172, 32660.34679306448, 32747.34505309928, 32779.67220327766, 33086.83456582702, 24207.75792242055, 24295.49355366634, 24625.539223518077, 24683.62974555419, 25026.499470010134], "value": 17420.762314510546, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.2739509381813, 345.70096866210736, 351.3640311037024, 353.44156233151625, 373.49391574416666, 12027.51889924403, 15590.532284031484, 16456.588585285375, 16601.0, 17825.7326140108, 16807.0, 16941.745873811873, 17334.826651733478, 17527.12364381782, 17674.38139665112, 4877.317175595419, 5106.4382917879, 5113.514216149479, 5201.895962080756, 5452.2094296327, 3450.0857272822723, 5512.862178445531, 5536.972315138419, 5551.944480555183, 5554.527865131448, 3604.3512167809786, 5163.7418129093585, 5448.891022179554, 5466.1527463243065, 5553.805616803413, 5265.947340526623, 5369.516743493065, 5529.944700553004, 5537.667739935597, 5538.335399752055, 5221.216817477371, 5228.085085110129, 5235.293235413246, 5235.973820130913, 5236.895262094775, 12346.876531234753, 12430.943369813576, 12581.685457863627, 14756.335964881499, 19860.205591776456, 1817.1277786662345, 1832.890026598395, 1942.2522328903333, 2053.188990348804, 2200.570888676709, 8784.209421152127, 9130.908690913138, 9367.484788336638, 9655.131038206526, 9717.61129554817, 1528.2664321125922, 1581.636223668551, 1605.5343950254412, 1618.3283937166061, 1623.1397359399537, 64214.67892660507, 67194.3280567193, 68726.31273687299, 69668.6516567414, 69899.30100698979, 9899.65351212704, 10119.544620492095, 10310.845337319946, 10351.585936562453, 10372.0, 13729.382177802023, 13755.79366309506, 13816.171029738249, 13838.100523465942, 13843.584692459242, 7332.816679583053, 7355.374793142642, 7412.629368531552, 7467.887981680171, 7577.810554736066, 6945.51381403307, 7036.331548502884, 7115.181754098241, 7262.273772622695, 7321.78034658961, 4256.2764330063965, 4324.632406245504, 4350.195213885441, 4453.376527286183, 4483.461984561874, 1776.786785585738, 1804.4316040447218, 1839.5677015901254, 1840.153529376475, 1841.3279153109286, 787.0633945604826, 796.9242921922408, 801.3509057663312, 842.3682238321259, 913.8583519554479, 16075.678486430439, 16160.191990400433, 16823.32706691743, 18016.819831801775, 18169.36407225741, 801.7755028592004, 829.4940086547201, 829.668132746894, 831.6465502161557, 887.9600417981206, 9024.593893274818, 9149.77125571866, 9743.366681165702, 9806.65676701312, 10061.245406594535, 388145.0, 388863.0, 389970.0, 391148.0, 402369.0, 79753.82830974512, 81566.59216703879, 82336.0, 83971.5801420989, 84911.57544212363, 925.1488630459993, 927.7309580221795, 936.7470782888582, 943.1605870775015, 946.6450081219542, 14853.851461485247, 15192.772108418603, 15404.46084387041, 15422.922885385502, 15677.216139193222, 35216.295674085864, 37253.81373093117, 37389.25221495609, 37644.81177594094, 37781.05547361338, 49369.25946110883, 49391.0, 49935.0, 50616.49383506118, 52471.47528524818, 6518.902216466851, 6877.518573699993, 6900.378965893094, 7246.094238220223, 7826.5129625371, 9233.538323083952, 11371.43142842871, 11593.434886290243, 11599.304041757521, 11920.165588408729, 9785.853212201964, 10045.547950342107, 10160.23798215122, 10431.634892778717, 10552.630657926935, 10017.799644007226, 10041.949790251001, 10189.490525473844, 10284.382937023802, 10315.638952636622, 9911.702648920544, 10320.0, 10358.741031474274, 10380.948095259475, 10422.583096676351, 7146.499745017799, 7155.0, 7170.89243661356, 7290.125184977836, 7475.738349157753, 8757.43076700038, 10155.187584993035, 10201.74495637615, 10206.846897296695, 10615.0], "value": 8026.959627489497, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.9569165079224, 1339.3102552185624, 1375.807386965825, 1442.8052212951247, 1681.1090122235212, 6286.9056964145575, 7266.927330726691, 7513.985611942386, 7517.0, 7522.96238518808, 7351.4118870490365, 7422.443316751238, 7425.962870185655, 7428.442866784999, 7430.479866409353, 1956.1490751523097, 1979.6535606268917, 1983.1769815526538, 1984.0575726529855, 1986.3445063129204, 1943.2032866524728, 1985.076939223261, 1989.7413336266266, 1990.3332383651493, 1993.1827950540282, 1956.4032969944162, 1973.1712680674152, 1977.6736838421643, 1986.4835142862887, 1986.920523179071, 1912.225548652798, 1913.5598812273115, 1917.0989634871587, 1918.9040547972545, 1919.7696276446845, 1856.9721454178198, 1860.3581764291298, 1862.3761040051463, 1917.4247725682378, 1936.1480948382807, 6929.930700692979, 7270.781876543712, 7324.121105467378, 7370.5577665339715, 7390.815229619248, 4219.746815191098, 4387.495438024636, 4390.253656878338, 4392.604665580113, 4393.51671316155, 2548.6431899533895, 2666.7466590673853, 2703.2701170683804, 2704.7024827268983, 2705.9323516912236, 815.2744057788573, 817.65249768848, 830.0495932157706, 831.1522247307772, 841.4530555139147, 9792.412455252708, 9825.754356141153, 9832.115109640166, 9892.95053524735, 9919.454430006346, 3624.836882340301, 3658.8719394821055, 3748.3815170496564, 3779.168582911755, 3827.1197624545953, 7931.167227441151, 7936.0, 7936.127026027132, 7939.801504962422, 7946.483478573874, 4341.739495630272, 4346.174226896879, 4354.303311470149, 4355.586219309161, 4358.585934336296, 3519.1729943463265, 3634.0, 3920.5883382244456, 4062.0251139726843, 4068.450759147477, 3122.968770312313, 3180.189051791778, 3255.983720081432, 3278.885239016623, 3285.244393789442, 974.6296407365156, 975.1564896364594, 977.2719324103589, 987.1066684650403, 994.145035269682, 792.4136139257024, 799.9840003199903, 812.3217113710118, 812.695239285268, 829.655692887445, 4721.693089949143, 4798.088363210979, 4818.349522814376, 4823.782929768169, 5097.057044446715, 358.4211498430069, 367.1958411079727, 369.7799809113573, 372.71114885963055, 372.93287208302223, 3206.3266713989856, 3443.345764304824, 3455.0844026333043, 3492.633273506296, 3507.9123021924147, 8246.752597422086, 8912.108789121035, 8965.058668839809, 8974.14745599167, 8978.82042359149, 8893.021767605558, 8903.065178156201, 8918.331125165638, 8918.643254269757, 8925.419847709878, 6645.202575690948, 6799.490038247052, 6809.795706128824, 6826.317368263134, 6826.761063362758, 4936.2102063669645, 4937.259411088366, 4950.603951683928, 4952.083864485082, 4964.106460837084, 8117.391195660231, 8148.0, 8233.83532329338, 8288.33693304522, 8337.666493340199, 8310.750677479686, 8356.415050946618, 8380.958095209486, 8431.789205269917, 8542.74371768848, 5459.39946605881, 6031.728572214173, 6109.877802443837, 6141.815745527641, 6147.723352449061, 6227.065940108839, 6589.439897608757, 6910.343517365842, 6932.0, 7089.751858684921, 6161.260648722182, 6193.009118541012, 6201.348858369986, 6231.781887633911, 6357.268914074941, 6084.087386891824, 6124.0163174116415, 6127.050307202391, 6149.7847575334645, 6269.153664255449, 5823.650580965155, 5902.557308201988, 5956.166136740946, 5956.344802071855, 5958.553108516792, 4165.958340416557, 4213.220554197484, 4292.098659281586, 4324.718893271927, 4433.024734558392, 4221.831126754895, 4222.809973551259, 4233.259179643612, 4291.67812414064, 4386.38590597323], "value": 3719.7400216492383, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.0841249115393, 283.21549308415683, 286.77918003137586, 291.9051308324795, 292.7146032618199, 4483.305087711402, 4708.223143181375, 4708.764561771911, 4710.199266124759, 4725.889415987244, 4625.838095666652, 4662.720236785795, 4666.580007799297, 4668.6731928765, 4672.859814205579, 3429.0, 3564.6473327603785, 3647.4528820676846, 3657.4330978698276, 3659.1035196376924, 3553.9466907996402, 3659.652333028358, 3665.8533658653755, 3669.4495825626236, 3676.8161591920298, 3611.368010598148, 3618.764780289286, 3620.294042661682, 3621.8591143789754, 3625.2205775758207, 3427.5544179256785, 3536.7701099428455, 3633.94549081764, 3634.0382588190673, 3649.233660931208, 3099.1714888215834, 3155.374981884331, 3164.4145833020734, 3167.7465802735724, 3181.141091905196, 4559.247724125516, 4559.270516717343, 4568.977155114203, 4572.977135114304, 4573.839915602938, 4109.301418758818, 4136.503619565641, 4142.2868021446, 4151.3150330195485, 4151.875443736662, 4603.608693261077, 4847.636427267969, 4867.148249056401, 4868.663041739985, 4891.339669144655, 3458.890077052996, 3464.2725027744204, 3465.480177973299, 3479.8782042628386, 3482.2165012872156, 5089.6691715038405, 5114.232865070232, 5118.155504341779, 5134.358205224347, 5135.563477104488, 3358.3115461330367, 3519.6128425873135, 3520.3663340598428, 3528.047427194643, 3528.4354503279865, 3571.928561428757, 3577.284543091392, 3577.481265216529, 3602.6397360264286, 3604.4052731299566, 4102.630763231324, 4107.609777071173, 4121.711480196417, 4124.175164967019, 4140.441040459499, 4946.975265123651, 4949.356583644103, 4953.43035550909, 4969.0, 4974.602031837444, 1200.3518100225954, 1240.4356018011783, 1244.2161438293997, 1245.420879291134, 1253.2417887178126, 773.3658400111967, 788.9132195458495, 806.3549160671439, 808.9160524896666, 809.5345176523523, 3878.8836334909997, 3882.6311500407414, 4127.936031984008, 4208.473940757405, 4262.637675797592, 4950.4059512858685, 4968.701877887338, 4972.801087956514, 5051.444341122474, 5086.72023038729, 4343.978280108642, 4353.368761529624, 4363.585459381354, 4366.978165109218, 4380.978095109568, 2607.9869600652255, 2654.137405343271, 2666.306760242312, 2677.7857771378244, 2699.3656490724666, 4757.833475828329, 4769.8569042928075, 4776.617870570346, 4780.832670856504, 4783.0, 5189.169732842803, 5196.0, 5204.4535323791215, 5210.739463026834, 5211.530962213419, 4578.748168850745, 4746.976265118652, 4764.0, 4783.832565860178, 4823.155947709137, 5006.424261210008, 5012.448630650552, 5035.748212589429, 5041.6470847040355, 5045.646804723634, 4929.950700492949, 4950.9257361140335, 4952.935118949299, 4985.775640096132, 5005.4744251853035, 4596.218642830794, 4751.976240118777, 4766.475687674422, 4780.067886762048, 4786.712797232177, 3472.2361080562237, 3487.0584942064993, 3493.3537295600395, 3494.633063528395, 3495.8601655933476, 5012.248162775467, 5024.271480635361, 5043.2939388486375, 5062.746862656926, 5095.344013195652, 4756.91115372324, 4817.759112044314, 4887.36464259644, 4891.070696567641, 4892.730899800546, 4893.168161412497, 4897.167481528078, 4899.755012249445, 4906.362172917497, 4957.429895562056, 4828.782704778364, 4840.588549973291, 4880.0, 4882.389701287339, 4903.583195428429, 4816.590589799906, 4903.688248419038, 4964.4539100698175, 4967.900641987212, 4968.329275547755, 4618.584327410549, 4632.5135860734135, 4740.956989462451, 4772.832950846704, 4777.617790576676], "value": 3669.911520215556, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.0743455079179, 609.1785561172095, 653.5915053091818, 667.2193533565728, 680.9455243580514, 12220.572279970203, 12820.93589532051, 12822.80765788514, 12828.743425131503, 12829.294388808636, 12361.134720569542, 12632.747345053116, 12877.871221287784, 12906.677333066678, 13007.73984520309, 748.648135376375, 764.6100488750749, 765.7932358263265, 766.7967988483057, 767.8541077195315, 610.7251736718472, 636.9012803015517, 753.6194221917924, 778.0624347661084, 785.5208322923013, 816.0941355095839, 816.942814003017, 818.6316157729016, 818.8894499242615, 819.573821612761, 812.5977641067709, 813.8535063688533, 814.071957967917, 814.2264848393991, 814.6782021101691, 472.46375363961806, 488.14087206516433, 566.5071387892518, 585.4350551717613, 599.194083957077, 12316.81524777129, 12325.753484930252, 12346.382680865921, 12348.197367171106, 12354.62936111909, 11734.0, 12213.938930305381, 12333.013358931265, 12404.689882752913, 12634.620961371174, 11167.664970050912, 11199.944000280027, 11512.827307590393, 11616.767664646744, 11636.76726465466, 3970.3250447424007, 3980.86066987654, 4018.477597912282, 4053.97973010136, 4054.6350828425584, 61413.385866141216, 61724.69137654328, 61748.0737788938, 62176.0, 62506.0624090639, 9093.4998575079, 9265.44407335562, 9989.0, 10110.949445252727, 10120.366489011294, 19377.321793737152, 19777.30779422742, 19814.50463738418, 19869.105890234972, 20129.0, 6467.353264673589, 6501.187351581052, 6663.06717059612, 6699.330066993359, 6877.071595334666, 3387.3902697514686, 3518.0677120563073, 3624.3657359961903, 3657.3416784978426, 3732.5894151643297, 2838.7161283871446, 2924.3712601790294, 2949.601803756508, 2960.541116126961, 2965.599644048069, 509.5465036117858, 513.3608657221782, 522.7699812082672, 530.1173546045791, 538.7037129578716, 578.3522454850511, 611.810338794975, 618.4063299232697, 619.9318075011745, 637.0285314894822, 7237.598635949019, 7786.532808031537, 7955.005624296963, 8404.747857564284, 8455.239028487465, 483.6179418259606, 552.1607157121233, 567.3730527766759, 583.1486030395586, 584.9678267695233, 3903.4730311408166, 3904.882853514399, 3920.3727403615853, 3921.509811273591, 4033.2941735196223, 48796.5120348792, 57589.97810703142, 67573.32426675769, 106931.0, 107420.0, 56198.7190064047, 68065.65967170133, 69251.0, 69578.0, 87664.6850297246, 51887.74056129695, 68872.0, 70908.0, 72186.63906680538, 72545.0, 7958.84082318362, 8047.315978141689, 8080.515169089874, 8155.225253600898, 8479.448835825651, 30704.385912282076, 33488.83255583706, 40226.0, 41162.176756464105, 41936.3709544351, 56050.0, 61463.692681536304, 62483.37516624776, 65659.34340656723, 65713.34286657264, 10313.587456501957, 10498.95010498944, 11100.833487497855, 11223.887761122285, 11346.773064538498, 12426.502939882303, 12720.74558508843, 13027.413766380725, 13257.801132983206, 13423.0, 11474.254173478697, 11478.356383244163, 11490.0, 12006.965174129353, 12127.332996685267, 11976.700582485508, 12144.453499592717, 12342.50629974827, 12417.441215145522, 12612.747745045232, 11201.943990280322, 11346.716332091764, 11471.082313415074, 11952.76094478123, 12030.218035827644, 10122.190224782147, 10490.324967133332, 10758.623448179276, 10925.672229833117, 11354.602588909349, 10180.338278012201, 10253.436061016417, 10293.0, 10300.175985921258, 10327.32872363294], "value": 6424.005753668216, "unit": "score"}], "name": "dromaeo_css", "value": 6167.837548184234, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 115.0, 116.0, 117.0, 115.0, 116.0, 117.0, 115.0, 115.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 129.0, 134.0, 165.0, 130.0, 128.0, 130.0, 134.0, 163.0, 130.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 163.0, 161.0, 162.0, 161.0, 162.0, 160.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 117.0, 76.0, 79.0, 77.0, 77.0, 103.0, 76.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 130.0, 84.0, 83.0, 83.0, 110.0, 83.0, 84.0, 115.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 73.0, 63.0, 71.0, 65.0, 68.0, 65.0, 65.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 71.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 82.0, 86.0, 84.0, 88.0, 83.0, 82.0, 88.0, 85.0, 82.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 139.0, 138.0, 138.0, 143.0, 146.0, 139.0, 145.0, 181.0, 138.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 179.0, 177.0, 185.0, 180.0, 175.0, 176.0, 174.0, 179.0, 173.0], "value": 177.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 69.0, 70.0, 69.0, 68.0, 68.0, 69.0, 69.0, 68.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1562.4999999999998, "alertThreshold": 2.0}]} 11:42:44 INFO - Return code: 0 11:42:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:42:44 INFO - # TBPL SUCCESS # 11:42:44 INFO - Running post-action listener: _resource_record_post_action 11:42:44 INFO - [mozharness: 2016-10-10 18:42:44.089103Z] Finished run-tests step (success) 11:42:44 INFO - Running post-run listener: _resource_record_post_run 11:42:44 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401514496; Read time: 12; Write time: 258744 11:42:44 INFO - TinderboxPrint: CPU usage
13.0% 11:42:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:42:44 INFO - TinderboxPrint: I/O write bytes / time
401,514,496 / 258,744 11:42:44 INFO - TinderboxPrint: CPU idle
8,361.8 (87.0%) 11:42:44 INFO - TinderboxPrint: CPU user
1,204.4 (12.5%) 11:42:44 INFO - TinderboxPrint: Swap in / out
0 / 0 11:42:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110579712; Read time: 0; Write time: 57748 11:42:44 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 290045952; Read time: 0; Write time: 200972 11:42:44 INFO - Running post-run listener: _upload_blobber_files 11:42:44 INFO - Blob upload gear active. 11:42:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:42:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:42:44 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:42:44 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:42:45 INFO - (blobuploader) - INFO - Open directory for files ... 11:42:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:42:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:42:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:45 INFO - (blobuploader) - INFO - Done attempting. 11:42:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:42:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:42:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:46 INFO - (blobuploader) - INFO - Done attempting. 11:42:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:42:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:42:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:50 INFO - (blobuploader) - INFO - Done attempting. 11:42:50 INFO - (blobuploader) - INFO - Iteration through files over. 11:42:50 INFO - Return code: 0 11:42:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:42:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:42:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9cdd26427812bfcabc684275e022ca2b4c3e95d637fbf66f7386c6f6772a1f9e0e20423353fec5fd6b67fcd56bd65fa0593caf78f6d158e57a71cf36ff8be3c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/ac939877185dd9f7e29ed5ef99bab3dba776d546b47deab407d65562741a629f8681b8d1017c1215fd81e1b1a00a3981cc6e0c023588e62e17f8a8134f10f847", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/106efe955a0db171b76e12f69aa8b70c13b75681a07bfae65699f0377535730c8a45ccc102fd9e92ef02a6212eede004e94e7c662efcc6ae6b4797d0e1a55cf4"} 11:42:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:42:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:42:50 INFO - Contents: 11:42:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9cdd26427812bfcabc684275e022ca2b4c3e95d637fbf66f7386c6f6772a1f9e0e20423353fec5fd6b67fcd56bd65fa0593caf78f6d158e57a71cf36ff8be3c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/ac939877185dd9f7e29ed5ef99bab3dba776d546b47deab407d65562741a629f8681b8d1017c1215fd81e1b1a00a3981cc6e0c023588e62e17f8a8134f10f847", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/106efe955a0db171b76e12f69aa8b70c13b75681a07bfae65699f0377535730c8a45ccc102fd9e92ef02a6212eede004e94e7c662efcc6ae6b4797d0e1a55cf4"} 11:42:50 INFO - Running post-run listener: copy_logs_to_upload_dir 11:42:50 INFO - Copying logs to upload dir... 11:42:50 INFO - mkdir: /builds/slave/test/build/upload/logs 11:42:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.562009 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-10 11:42:49.157877) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 11:42:49.161604) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9cdd26427812bfcabc684275e022ca2b4c3e95d637fbf66f7386c6f6772a1f9e0e20423353fec5fd6b67fcd56bd65fa0593caf78f6d158e57a71cf36ff8be3c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/ac939877185dd9f7e29ed5ef99bab3dba776d546b47deab407d65562741a629f8681b8d1017c1215fd81e1b1a00a3981cc6e0c023588e62e17f8a8134f10f847", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/106efe955a0db171b76e12f69aa8b70c13b75681a07bfae65699f0377535730c8a45ccc102fd9e92ef02a6212eede004e94e7c662efcc6ae6b4797d0e1a55cf4"} build_url:https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011393 build_url: 'https://queue.taskcluster.net/v1/task/Cf_RMJrdQrGfdgsW8txRQw/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/Larch-Non-PGO/sha512/9cdd26427812bfcabc684275e022ca2b4c3e95d637fbf66f7386c6f6772a1f9e0e20423353fec5fd6b67fcd56bd65fa0593caf78f6d158e57a71cf36ff8be3c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/ac939877185dd9f7e29ed5ef99bab3dba776d546b47deab407d65562741a629f8681b8d1017c1215fd81e1b1a00a3981cc6e0c023588e62e17f8a8134f10f847", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/106efe955a0db171b76e12f69aa8b70c13b75681a07bfae65699f0377535730c8a45ccc102fd9e92ef02a6212eede004e94e7c662efcc6ae6b4797d0e1a55cf4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 11:42:49.187393) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 11:42:49.187742) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1476123283.48506-1216172315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 11:42:49.273091) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 11:42:49.273432) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 11:42:49.273759) ========= ========= Total master_lag: 0.16 =========