builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1475644735.42 results: success (0) buildid: 20161004204200 builduid: 49edf6c42fcf48ef8ad227eb607aeb41 revision: 2ba7a111b2a73cddd9cb8fcddc3482642a161c23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 22:18:55.416328) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 22:18:55.416797) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 22:18:55.417081) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 22:18:55.432387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 22:18:55.432750) ========= 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=db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 22:18:55-- 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% 42.6M=0s 2016-10-04 22:18:55 (42.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091483 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 22:18:55.727684) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 22:18:55.728026) ========= 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=db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017897 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 22:18:55.775136) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 22:18:55.775494) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 2ba7a111b2a73cddd9cb8fcddc3482642a161c23 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 2ba7a111b2a73cddd9cb8fcddc3482642a161c23 --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=db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 22:18:56,254 truncating revision to first 12 chars 2016-10-04 22:18:56,254 Setting DEBUG logging. 2016-10-04 22:18:56,254 attempt 1/10 2016-10-04 22:18:56,254 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/2ba7a111b2a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 22:18:56,573 unpacking tar archive at: autoland-2ba7a111b2a7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656168 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 22:18:56.465516) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 22:18:56.469065) ========= script_repo_revision: 2ba7a111b2a73cddd9cb8fcddc3482642a161c23 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 22:18:56.469776) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 22:18:56.470236) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 22:18:56.482223) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-04 22:18:56.482870) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:18:57 INFO - MultiFileLogger online at 20161004 22:18:57 in /builds/slave/test 22:18:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 22:18:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:18:57 INFO - {'append_to_log': False, 22:18:57 INFO - 'base_work_dir': '/builds/slave/test', 22:18:57 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 22:18:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:18:57 INFO - 'branch': 'Autoland-Non-PGO', 22:18:57 INFO - 'buildbot_json_path': 'buildprops.json', 22:18:57 INFO - 'config_files': ('talos/linux_config.py',), 22:18:57 INFO - 'default_actions': ('clobber', 22:18:57 INFO - 'read-buildbot-config', 22:18:57 INFO - 'download-and-extract', 22:18:57 INFO - 'populate-webroot', 22:18:57 INFO - 'create-virtualenv', 22:18:57 INFO - 'install', 22:18:57 INFO - 'run-tests'), 22:18:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:18:57 INFO - 'download_minidump_stackwalk': True, 22:18:57 INFO - 'download_symbols': 'ondemand', 22:18:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:18:57 INFO - 'tooltool.py': '/tools/tooltool.py', 22:18:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:18:57 INFO - '/tools/misc-python/virtualenv.py')}, 22:18:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:18:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:18:57 INFO - 'installer_path': 'installer.exe', 22:18:57 INFO - 'log_level': 'info', 22:18:57 INFO - 'log_name': 'talos', 22:18:57 INFO - 'log_to_console': True, 22:18:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:18:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:18:57 INFO - 'opt_config_files': (), 22:18:57 INFO - 'pip_index': False, 22:18:57 INFO - 'sps_profile': False, 22:18:57 INFO - 'sps_profile_interval': 0, 22:18:57 INFO - 'suite': 'dromaeojs', 22:18:57 INFO - 'system_bits': '32', 22:18:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:18:57 INFO - 'title': 'talos-linux64-ix-049', 22:18:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:18:57 INFO - 'use_talos_json': True, 22:18:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:18:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:18:57 INFO - 'work_dir': 'build'} 22:18:57 INFO - [mozharness: 2016-10-05 05:18:57.042902Z] Running clobber step. 22:18:57 INFO - Running pre-action listener: _resource_record_pre_action 22:18:57 INFO - Running main action method: clobber 22:18:57 INFO - rmtree: /builds/slave/test/build 22:18:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:18:58 INFO - Running post-action listener: _resource_record_post_action 22:18:58 INFO - [mozharness: 2016-10-05 05:18:58.023582Z] Finished clobber step (success) 22:18:58 INFO - [mozharness: 2016-10-05 05:18:58.023691Z] Running read-buildbot-config step. 22:18:58 INFO - Running pre-action listener: _resource_record_pre_action 22:18:58 INFO - Running main action method: read_buildbot_config 22:18:58 INFO - Using buildbot properties: 22:18:58 INFO - { 22:18:58 INFO - "project": "", 22:18:58 INFO - "product": "firefox", 22:18:58 INFO - "script_repo_revision": "production", 22:18:58 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 22:18:58 INFO - "repository": "", 22:18:58 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 22:18:58 INFO - "buildid": "20161004204200", 22:18:58 INFO - "pgo_build": "False", 22:18:58 INFO - "basedir": "/builds/slave/test", 22:18:58 INFO - "buildnumber": 702, 22:18:58 INFO - "slavename": "talos-linux64-ix-049", 22:18:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:18:58 INFO - "platform": "ubuntu64_hw", 22:18:58 INFO - "scheduler": "tests-autoland-linux64-talos", 22:18:58 INFO - "branch": "autoland", 22:18:58 INFO - "repo_path": "integration/autoland", 22:18:58 INFO - "revision": "2ba7a111b2a73cddd9cb8fcddc3482642a161c23", 22:18:58 INFO - "stage_platform": "linux64", 22:18:58 INFO - "builduid": "49edf6c42fcf48ef8ad227eb607aeb41", 22:18:58 INFO - "slavebuilddir": "test" 22:18:58 INFO - } 22:18:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:18:58 INFO - Running post-action listener: _resource_record_post_action 22:18:58 INFO - [mozharness: 2016-10-05 05:18:58.026415Z] Finished read-buildbot-config step (success) 22:18:58 INFO - [mozharness: 2016-10-05 05:18:58.026513Z] Running download-and-extract step. 22:18:58 INFO - Running pre-action listener: _resource_record_pre_action 22:18:58 INFO - Running main action method: download_and_extract 22:18:58 INFO - mkdir: /builds/slave/test/build/tests 22:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:18:58 INFO - trying https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:18:58 INFO - Downloading https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/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 22:18:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/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 22:18:58 INFO - Downloaded 1361 bytes. 22:18:58 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:18:58 INFO - Using the following test package requirements: 22:18:58 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:18:58 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:18:58 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:18:58 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:58 INFO - u'jsshell-linux-x86_64.zip'], 22:18:58 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:18:58 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:18:58 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:18:58 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:18:58 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:18:58 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:18:58 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:18:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:18:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:18:58 INFO - Fetch https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:18:59 INFO - Http code: 200 22:18:59 INFO - via: 1.1 6e65abb04cb818a6ec78111935b507f7.cloudfront.net (CloudFront) 22:18:59 INFO - x-amz-cf-id: Lm9eS-BVp4DV_ur3BwIuojQPaxA_pvlfYtQsjoRBPnRAGZ4amO4ZjQ== 22:18:59 INFO - x-amz-version-id: Ra_BpZ9UBsBVTt.8sE1pWtz3v04bc.ER 22:18:59 INFO - Expected file size: 20421205 22:18:59 INFO - Obtained file size: 20421205 22:19:03 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 22:19:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:19:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:19:03 INFO - Fetch https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:19:04 INFO - Http code: 200 22:19:04 INFO - via: 1.1 f0ef92e52918ab5129ebd66f2f633cbb.cloudfront.net (CloudFront) 22:19:04 INFO - x-amz-cf-id: bjVLceLfHCS_YfaGmDERxxSn3SDetJgX6XAjQZBj1CGdCMgvNi4a2Q== 22:19:04 INFO - x-amz-version-id: Ra_BpZ9UBsBVTt.8sE1pWtz3v04bc.ER 22:19:04 INFO - Expected file size: 20421205 22:19:04 INFO - Obtained file size: 20421205 22:19:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:19:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:19:08 INFO - Fetch https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:19:09 INFO - Http code: 200 22:19:09 INFO - via: 1.1 55676da1e5c0a9c4e60a94a95b01dc04.cloudfront.net (CloudFront) 22:19:09 INFO - x-amz-cf-id: wJbRplEwW1MHpkQHUGbT4M6U1fV3Ib6rpS8rZ6hVwFatisfKF7zWvg== 22:19:09 INFO - x-amz-version-id: 1pNo2_vdcbX5xH3qqwG9hwvNDlgpRKpP 22:19:09 INFO - Expected file size: 14409006 22:19:09 INFO - Obtained file size: 14409006 22:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:09 INFO - trying https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:19:09 INFO - Downloading https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/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 22:19:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/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 22:19:11 INFO - Downloaded 55799182 bytes. 22:19:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:19:11 INFO - mkdir: /builds/slave/test/properties 22:19:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:19:11 INFO - Writing to file /builds/slave/test/properties/build_url 22:19:11 INFO - Contents: 22:19:11 INFO - build_url:https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:19:12 INFO - Running post-action listener: _resource_record_post_action 22:19:12 INFO - Running post-action listener: set_extra_try_arguments 22:19:12 INFO - [mozharness: 2016-10-05 05:19:12.660969Z] Finished download-and-extract step (success) 22:19:12 INFO - [mozharness: 2016-10-05 05:19:12.661200Z] Running populate-webroot step. 22:19:12 INFO - Running pre-action listener: _resource_record_pre_action 22:19:12 INFO - Running main action method: populate_webroot 22:19:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:19:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:19:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:19:12 INFO - '--tppagecycles', 22:19:12 INFO - '7'], 22:19:12 INFO - 'tests': ['tsvgm']}}, 22:19:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:19:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:19:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:19:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:19:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:19:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:19:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:12 INFO - 'talos_options': ['--disable-e10s'], 22:19:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:19:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:19:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:12 INFO - 'talos_options': ['--disable-e10s'], 22:19:12 INFO - 'tests': ['damp', 'tps']}, 22:19:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:12 INFO - 'tests': ['damp', 'tps']}, 22:19:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:19:12 INFO - 'tests': ['dromaeo_dom']}, 22:19:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:19:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:19:12 INFO - 'tests': ['basic_compositor_video']}, 22:19:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:19:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:19:12 INFO - 'tests': ['a11yr', 22:19:12 INFO - 'ts_paint', 22:19:12 INFO - 'tpaint', 22:19:12 INFO - 'sessionrestore', 22:19:12 INFO - 'sessionrestore_no_auto_restore', 22:19:12 INFO - 'tabpaint']}, 22:19:12 INFO - 'other-e10s': {'tests': ['a11yr', 22:19:12 INFO - 'ts_paint', 22:19:12 INFO - 'tpaint', 22:19:12 INFO - 'sessionrestore', 22:19:12 INFO - 'sessionrestore_no_auto_restore', 22:19:12 INFO - 'tabpaint']}, 22:19:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:19:12 INFO - 'ts_paint', 22:19:12 INFO - 'tpaint', 22:19:12 INFO - 'sessionrestore', 22:19:12 INFO - 'sessionrestore_no_auto_restore', 22:19:12 INFO - 'tabpaint']}, 22:19:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:19:12 INFO - 'ts_paint', 22:19:12 INFO - 'tpaint', 22:19:12 INFO - 'sessionrestore', 22:19:12 INFO - 'sessionrestore_no_auto_restore', 22:19:12 INFO - 'tabpaint']}, 22:19:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:19:12 INFO - 'tests': ['a11yr', 22:19:12 INFO - 'ts_paint', 22:19:12 INFO - 'tpaint', 22:19:12 INFO - 'sessionrestore', 22:19:12 INFO - 'sessionrestore_no_auto_restore', 22:19:12 INFO - 'tabpaint']}, 22:19:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:19:12 INFO - 'tests': ['a11yr', 22:19:12 INFO - 'ts_paint', 22:19:12 INFO - 'tpaint', 22:19:12 INFO - 'sessionrestore', 22:19:12 INFO - 'sessionrestore_no_auto_restore', 22:19:12 INFO - 'tabpaint']}, 22:19:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:19:12 INFO - 'tests': ['tsvgx', 22:19:12 INFO - 'tsvgr_opacity', 22:19:12 INFO - 'tart', 22:19:12 INFO - 'tscrollx', 22:19:12 INFO - 'cart']}, 22:19:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:19:12 INFO - 'tsvgr_opacity', 22:19:12 INFO - 'tart', 22:19:12 INFO - 'tscrollx', 22:19:12 INFO - 'cart']}, 22:19:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:12 INFO - 'talos_options': ['--disable-e10s'], 22:19:12 INFO - 'tests': ['tp5o']}, 22:19:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:12 INFO - 'tests': ['tp5o']}, 22:19:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:12 INFO - 'talos_options': ['--disable-e10s', 22:19:12 INFO - '--xperf_path', 22:19:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:19:12 INFO - 'tests': ['tp5n']}, 22:19:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:12 INFO - 'talos_options': ['--xperf_path', 22:19:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:19:12 INFO - 'tests': ['tp5n']}}, 22:19:12 INFO - 'talos.zip': {'path': '', 22:19:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:19:12 INFO - Running post-action listener: _resource_record_post_action 22:19:12 INFO - [mozharness: 2016-10-05 05:19:12.681765Z] Finished populate-webroot step (success) 22:19:12 INFO - [mozharness: 2016-10-05 05:19:12.681853Z] Running create-virtualenv step. 22:19:12 INFO - Running pre-action listener: _resource_record_pre_action 22:19:12 INFO - Running main action method: create_virtualenv 22:19:12 INFO - Creating virtualenv /builds/slave/test/build/venv 22:19:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:19:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:19:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:19:12 INFO - Using real prefix '/usr' 22:19:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:19:13 INFO - Installing distribute.............................................................................................................................................................................................done. 22:19:15 INFO - Installing pip.................done. 22:19:15 INFO - Return code: 0 22:19:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:19:15 INFO - Reading from file tmpfile_stdout 22:19:15 INFO - Output received: 22:19:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 22:19:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1dbfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1168ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1165f60>, '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 0x1166d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11671d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', '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 22:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:19:15 INFO - Using env: {'DISPLAY': ':0', 22:19:15 INFO - 'HOME': '/home/cltbld', 22:19:15 INFO - 'LANG': 'en_US.UTF-8', 22:19:15 INFO - 'LANGUAGE': 'en_US:en', 22:19:15 INFO - 'LOGNAME': 'cltbld', 22:19:15 INFO - 'MAIL': '/var/mail/cltbld', 22:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:15 INFO - 'MOZ_NO_REMOTE': '1', 22:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:15 INFO - 'NO_EM_RESTART': '1', 22:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:15 INFO - 'PWD': '/builds/slave/test', 22:19:15 INFO - 'SHELL': '/bin/bash', 22:19:15 INFO - 'SHLVL': '1', 22:19:15 INFO - 'TERM': 'linux', 22:19:15 INFO - 'TMOUT': '86400', 22:19:15 INFO - 'USER': 'cltbld', 22:19:15 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', 22:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:15 INFO - '_': '/tools/buildbot/bin/python'} 22:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:19:15 INFO - Cleaning up... 22:19:15 INFO - Return code: 0 22:19:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1dbfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1168ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1165f60>, '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 0x1166d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11671d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', '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 22:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:19:15 INFO - Using env: {'DISPLAY': ':0', 22:19:15 INFO - 'HOME': '/home/cltbld', 22:19:15 INFO - 'LANG': 'en_US.UTF-8', 22:19:15 INFO - 'LANGUAGE': 'en_US:en', 22:19:15 INFO - 'LOGNAME': 'cltbld', 22:19:15 INFO - 'MAIL': '/var/mail/cltbld', 22:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:15 INFO - 'MOZ_NO_REMOTE': '1', 22:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:15 INFO - 'NO_EM_RESTART': '1', 22:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:15 INFO - 'PWD': '/builds/slave/test', 22:19:15 INFO - 'SHELL': '/bin/bash', 22:19:15 INFO - 'SHLVL': '1', 22:19:15 INFO - 'TERM': 'linux', 22:19:15 INFO - 'TMOUT': '86400', 22:19:15 INFO - 'USER': 'cltbld', 22:19:15 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', 22:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:15 INFO - '_': '/tools/buildbot/bin/python'} 22:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:15 INFO - Downloading/unpacking psutil>=3.1.1 22:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:19:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:19:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:19:17 INFO - Installing collected packages: psutil 22:19:17 INFO - Running setup.py install for psutil 22:19:18 INFO - building 'psutil._psutil_linux' extension 22:19:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:19:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:19:18 INFO - building 'psutil._psutil_posix' extension 22:19:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:19:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:19:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:19:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:19:18 INFO - Successfully installed psutil 22:19:18 INFO - Cleaning up... 22:19:18 INFO - Return code: 0 22:19:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1dbfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1168ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1165f60>, '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 0x1166d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11671d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', '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 22:19:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:19:18 INFO - Using env: {'DISPLAY': ':0', 22:19:18 INFO - 'HOME': '/home/cltbld', 22:19:18 INFO - 'LANG': 'en_US.UTF-8', 22:19:18 INFO - 'LANGUAGE': 'en_US:en', 22:19:18 INFO - 'LOGNAME': 'cltbld', 22:19:18 INFO - 'MAIL': '/var/mail/cltbld', 22:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:18 INFO - 'MOZ_NO_REMOTE': '1', 22:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:18 INFO - 'NO_EM_RESTART': '1', 22:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:18 INFO - 'PWD': '/builds/slave/test', 22:19:18 INFO - 'SHELL': '/bin/bash', 22:19:18 INFO - 'SHLVL': '1', 22:19:18 INFO - 'TERM': 'linux', 22:19:18 INFO - 'TMOUT': '86400', 22:19:18 INFO - 'USER': 'cltbld', 22:19:18 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', 22:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:18 INFO - '_': '/tools/buildbot/bin/python'} 22:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:19:20 INFO - Installing collected packages: mozsystemmonitor 22:19:20 INFO - Running setup.py install for mozsystemmonitor 22:19:20 INFO - Successfully installed mozsystemmonitor 22:19:20 INFO - Cleaning up... 22:19:20 INFO - Return code: 0 22:19:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1dbfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1168ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1165f60>, '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 0x1166d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11671d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', '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 22:19:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:19:20 INFO - Using env: {'DISPLAY': ':0', 22:19:20 INFO - 'HOME': '/home/cltbld', 22:19:20 INFO - 'LANG': 'en_US.UTF-8', 22:19:20 INFO - 'LANGUAGE': 'en_US:en', 22:19:20 INFO - 'LOGNAME': 'cltbld', 22:19:20 INFO - 'MAIL': '/var/mail/cltbld', 22:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:20 INFO - 'MOZ_NO_REMOTE': '1', 22:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:20 INFO - 'NO_EM_RESTART': '1', 22:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:20 INFO - 'PWD': '/builds/slave/test', 22:19:20 INFO - 'SHELL': '/bin/bash', 22:19:20 INFO - 'SHLVL': '1', 22:19:20 INFO - 'TERM': 'linux', 22:19:20 INFO - 'TMOUT': '86400', 22:19:20 INFO - 'USER': 'cltbld', 22:19:20 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', 22:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:20 INFO - '_': '/tools/buildbot/bin/python'} 22:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:21 INFO - Downloading/unpacking jsonschema==2.5.1 22:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:19:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19:23 INFO - Downloading functools32-3.2.3-2.tar.gz 22:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:19:23 INFO - warning: no files found matching '*.txt' 22:19:23 INFO - no previously-included directories found matching 'build' 22:19:23 INFO - no previously-included directories found matching 'dist' 22:19:23 INFO - no previously-included directories found matching '.git*' 22:19:23 INFO - Installing collected packages: jsonschema, functools32 22:19:23 INFO - Running setup.py install for functools32 22:19:23 INFO - warning: no files found matching '*.txt' 22:19:23 INFO - no previously-included directories found matching 'build' 22:19:23 INFO - no previously-included directories found matching 'dist' 22:19:23 INFO - no previously-included directories found matching '.git*' 22:19:23 INFO - Successfully installed jsonschema functools32 22:19:23 INFO - Cleaning up... 22:19:23 INFO - Return code: 0 22:19:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1dbfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1168ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1165f60>, '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 0x1166d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11671d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', '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 22:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:19:23 INFO - Using env: {'DISPLAY': ':0', 22:19:23 INFO - 'HOME': '/home/cltbld', 22:19:23 INFO - 'LANG': 'en_US.UTF-8', 22:19:23 INFO - 'LANGUAGE': 'en_US:en', 22:19:23 INFO - 'LOGNAME': 'cltbld', 22:19:23 INFO - 'MAIL': '/var/mail/cltbld', 22:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:23 INFO - 'MOZ_NO_REMOTE': '1', 22:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:23 INFO - 'NO_EM_RESTART': '1', 22:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:23 INFO - 'PWD': '/builds/slave/test', 22:19:23 INFO - 'SHELL': '/bin/bash', 22:19:23 INFO - 'SHLVL': '1', 22:19:23 INFO - 'TERM': 'linux', 22:19:23 INFO - 'TMOUT': '86400', 22:19:23 INFO - 'USER': 'cltbld', 22:19:23 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', 22:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:23 INFO - '_': '/tools/buildbot/bin/python'} 22:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:19:23 INFO - Cleaning up... 22:19:23 INFO - Return code: 0 22:19:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1dbfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1168ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1165f60>, '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 0x1166d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11671d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', '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 22:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:19:23 INFO - Using env: {'DISPLAY': ':0', 22:19:23 INFO - 'HOME': '/home/cltbld', 22:19:23 INFO - 'LANG': 'en_US.UTF-8', 22:19:23 INFO - 'LANGUAGE': 'en_US:en', 22:19:23 INFO - 'LOGNAME': 'cltbld', 22:19:23 INFO - 'MAIL': '/var/mail/cltbld', 22:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:23 INFO - 'MOZ_NO_REMOTE': '1', 22:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:23 INFO - 'NO_EM_RESTART': '1', 22:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:23 INFO - 'PWD': '/builds/slave/test', 22:19:23 INFO - 'SHELL': '/bin/bash', 22:19:23 INFO - 'SHLVL': '1', 22:19:23 INFO - 'TERM': 'linux', 22:19:23 INFO - 'TMOUT': '86400', 22:19:23 INFO - 'USER': 'cltbld', 22:19:23 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', 22:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:23 INFO - '_': '/tools/buildbot/bin/python'} 22:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:23 INFO - Downloading/unpacking blobuploader==1.2.4 22:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:25 INFO - Downloading blobuploader-1.2.4.tar.gz 22:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:19:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:19:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:26 INFO - Downloading docopt-0.6.1.tar.gz 22:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:19:26 INFO - Installing collected packages: blobuploader, requests, docopt 22:19:26 INFO - Running setup.py install for blobuploader 22:19:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:19:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:19:26 INFO - Running setup.py install for requests 22:19:26 INFO - Running setup.py install for docopt 22:19:27 INFO - Successfully installed blobuploader requests docopt 22:19:27 INFO - Cleaning up... 22:19:27 INFO - Return code: 0 22:19:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19: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')]} 22:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19: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')]} 22:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1dbfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1168ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1165f60>, '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 0x1166d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11671d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', '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 22:19:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:19:27 INFO - Using env: {'DISPLAY': ':0', 22:19:27 INFO - 'HOME': '/home/cltbld', 22:19:27 INFO - 'LANG': 'en_US.UTF-8', 22:19:27 INFO - 'LANGUAGE': 'en_US:en', 22:19:27 INFO - 'LOGNAME': 'cltbld', 22:19:27 INFO - 'MAIL': '/var/mail/cltbld', 22:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:27 INFO - 'MOZ_NO_REMOTE': '1', 22:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:27 INFO - 'NO_EM_RESTART': '1', 22:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:27 INFO - 'PWD': '/builds/slave/test', 22:19:27 INFO - 'SHELL': '/bin/bash', 22:19:27 INFO - 'SHLVL': '1', 22:19:27 INFO - 'TERM': 'linux', 22:19:27 INFO - 'TMOUT': '86400', 22:19:27 INFO - 'USER': 'cltbld', 22:19:27 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', 22:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:27 INFO - '_': '/tools/buildbot/bin/python'} 22:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:19:27 INFO - Running setup.py (path:/tmp/pip-KEL9MP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:19:27 INFO - Running setup.py (path:/tmp/pip-fXEDrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:19:27 INFO - Running setup.py (path:/tmp/pip-b1JVcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:19:27 INFO - Running setup.py (path:/tmp/pip-h2aPTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:19:27 INFO - Running setup.py (path:/tmp/pip-9G_M2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:19:27 INFO - Running setup.py (path:/tmp/pip-d6heFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:19:27 INFO - Running setup.py (path:/tmp/pip-Irpr19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:19:27 INFO - Running setup.py (path:/tmp/pip-HfkzOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:19:27 INFO - Running setup.py (path:/tmp/pip-Uc6Bp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:19:27 INFO - Running setup.py (path:/tmp/pip-CGKz1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:19:28 INFO - Running setup.py (path:/tmp/pip-9dIzxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:19:28 INFO - Running setup.py (path:/tmp/pip-9dO8HX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:19:28 INFO - Running setup.py (path:/tmp/pip-_mBpry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:19:28 INFO - Running setup.py (path:/tmp/pip-fwUtFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:28 INFO - Running setup.py (path:/tmp/pip-H1XnRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:19:28 INFO - Running setup.py (path:/tmp/pip-ooHJlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:19:28 INFO - Running setup.py (path:/tmp/pip-P23EbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:19:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:19:28 INFO - Running setup.py install for manifestparser 22:19:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:19:28 INFO - Running setup.py install for mozcrash 22:19:28 INFO - Running setup.py install for mozdebug 22:19:28 INFO - Running setup.py install for mozdevice 22:19:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:19:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:19:29 INFO - Running setup.py install for mozfile 22:19:29 INFO - Running setup.py install for mozhttpd 22:19:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:19:29 INFO - Running setup.py install for mozinfo 22:19:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:19:29 INFO - Running setup.py install for mozInstall 22:19:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:19:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:19:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:19:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:19:29 INFO - Running setup.py install for mozleak 22:19:29 INFO - Running setup.py install for mozlog 22:19:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:19:29 INFO - Running setup.py install for moznetwork 22:19:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:19:29 INFO - Running setup.py install for mozprocess 22:19:29 INFO - Running setup.py install for mozprofile 22:19:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:19:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:19:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:19:29 INFO - Running setup.py install for mozrunner 22:19:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:19:30 INFO - Running setup.py install for mozscreenshot 22:19:30 INFO - Running setup.py install for moztest 22:19:30 INFO - Running setup.py install for mozversion 22:19:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:19:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:19:30 INFO - Cleaning up... 22:19:30 INFO - Return code: 0 22:19:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1dbfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1168ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1165f60>, '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 0x1166d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11671d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', '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 22:19:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:19:30 INFO - Using env: {'DISPLAY': ':0', 22:19:30 INFO - 'HOME': '/home/cltbld', 22:19:30 INFO - 'LANG': 'en_US.UTF-8', 22:19:30 INFO - 'LANGUAGE': 'en_US:en', 22:19:30 INFO - 'LOGNAME': 'cltbld', 22:19:30 INFO - 'MAIL': '/var/mail/cltbld', 22:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:30 INFO - 'MOZ_NO_REMOTE': '1', 22:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:30 INFO - 'NO_EM_RESTART': '1', 22:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:30 INFO - 'PWD': '/builds/slave/test', 22:19:30 INFO - 'SHELL': '/bin/bash', 22:19:30 INFO - 'SHLVL': '1', 22:19:30 INFO - 'TERM': 'linux', 22:19:30 INFO - 'TMOUT': '86400', 22:19:30 INFO - 'USER': 'cltbld', 22:19:30 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', 22:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:30 INFO - '_': '/tools/buildbot/bin/python'} 22:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:19:30 INFO - Running setup.py (path:/tmp/pip-hAHO5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:19:30 INFO - Running setup.py (path:/tmp/pip-qqjtG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:19:30 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)) 22:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:19:30 INFO - Running setup.py (path:/tmp/pip-MuOFDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:19:30 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)) 22:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:19:30 INFO - Running setup.py (path:/tmp/pip-jGirkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:19:30 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)) 22:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:19:30 INFO - Running setup.py (path:/tmp/pip-mACt6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:19:30 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)) 22:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:19:30 INFO - Running setup.py (path:/tmp/pip-G9fdlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:19:31 INFO - Running setup.py (path:/tmp/pip-GvH3Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:19:31 INFO - Running setup.py (path:/tmp/pip-vwgzcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:19:31 INFO - Running setup.py (path:/tmp/pip-vzCZgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:19:31 INFO - Running setup.py (path:/tmp/pip-SvP4rL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:19:31 INFO - Running setup.py (path:/tmp/pip-lSZUXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:19:31 INFO - Running setup.py (path:/tmp/pip-LuuIds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:19:31 INFO - Running setup.py (path:/tmp/pip-AHmL1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:19:31 INFO - Running setup.py (path:/tmp/pip-DS0w1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:19:31 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)) 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:31 INFO - Running setup.py (path:/tmp/pip-tNtEHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:19:31 INFO - Running setup.py (path:/tmp/pip-qCVV9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:19:31 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)) 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:19:31 INFO - Running setup.py (path:/tmp/pip-Mv0bGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:19:31 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)) 22:19:31 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)) 22:19:31 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)) 22:19:31 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)) 22:19:31 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)) 22:19:31 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)) 22:19:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:19:31 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 22:19:31 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 22:19:31 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 22:19:31 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 22:19:31 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 22:19:31 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 22:19:33 INFO - Downloading blessings-1.6.tar.gz 22:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:19:33 INFO - Installing collected packages: blessings 22:19:33 INFO - Running setup.py install for blessings 22:19:33 INFO - Successfully installed blessings 22:19:33 INFO - Cleaning up... 22:19:33 INFO - Return code: 0 22:19:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:19:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:19:34 INFO - Reading from file tmpfile_stdout 22:19:34 INFO - Current package versions: 22:19:34 INFO - argparse == 1.2.1 22:19:34 INFO - blessings == 1.6 22:19:34 INFO - blobuploader == 1.2.4 22:19:34 INFO - docopt == 0.6.1 22:19:34 INFO - functools32 == 3.2.3-2 22:19:34 INFO - jsonschema == 2.5.1 22:19:34 INFO - manifestparser == 1.1 22:19:34 INFO - mozInstall == 1.12 22:19:34 INFO - mozcrash == 0.17 22:19:34 INFO - mozdebug == 0.1 22:19:34 INFO - mozdevice == 0.48 22:19:34 INFO - mozfile == 1.2 22:19:34 INFO - mozhttpd == 0.7 22:19:34 INFO - mozinfo == 0.9 22:19:34 INFO - mozleak == 0.1 22:19:34 INFO - mozlog == 3.4 22:19:34 INFO - moznetwork == 0.27 22:19:34 INFO - mozprocess == 0.23 22:19:34 INFO - mozprofile == 0.28 22:19:34 INFO - mozrunner == 6.12 22:19:34 INFO - mozscreenshot == 0.1 22:19:34 INFO - mozsystemmonitor == 0.3 22:19:34 INFO - moztest == 0.7 22:19:34 INFO - mozversion == 1.4 22:19:34 INFO - psutil == 3.1.1 22:19:34 INFO - requests == 1.2.3 22:19:34 INFO - wsgiref == 0.1.2 22:19:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19: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')]} 22:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19: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')]} 22:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1dbfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1168ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1165f60>, '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 0x1166d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11671d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', '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 22:19:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:19:34 INFO - Using env: {'DISPLAY': ':0', 22:19:34 INFO - 'HOME': '/home/cltbld', 22:19:34 INFO - 'LANG': 'en_US.UTF-8', 22:19:34 INFO - 'LANGUAGE': 'en_US:en', 22:19:34 INFO - 'LOGNAME': 'cltbld', 22:19:34 INFO - 'MAIL': '/var/mail/cltbld', 22:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:34 INFO - 'MOZ_NO_REMOTE': '1', 22:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:34 INFO - 'NO_EM_RESTART': '1', 22:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:34 INFO - 'PWD': '/builds/slave/test', 22:19:34 INFO - 'SHELL': '/bin/bash', 22:19:34 INFO - 'SHLVL': '1', 22:19:34 INFO - 'TERM': 'linux', 22:19:34 INFO - 'TMOUT': '86400', 22:19:34 INFO - 'USER': 'cltbld', 22:19:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', 22:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:34 INFO - '_': '/tools/buildbot/bin/python'} 22:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:19:34 INFO - Cleaning up... 22:19:34 INFO - Return code: 0 22:19:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:19: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')]} 22:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19: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')]} 22:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:34 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 0x7f2d1dbfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1168ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1165f60>, '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 0x1166d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11671d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', '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 22:19:34 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 22:19:34 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 22:19:34 INFO - Using env: {'DISPLAY': ':0', 22:19:34 INFO - 'HOME': '/home/cltbld', 22:19:34 INFO - 'LANG': 'en_US.UTF-8', 22:19:34 INFO - 'LANGUAGE': 'en_US:en', 22:19:34 INFO - 'LOGNAME': 'cltbld', 22:19:34 INFO - 'MAIL': '/var/mail/cltbld', 22:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:34 INFO - 'MOZ_NO_REMOTE': '1', 22:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:34 INFO - 'NO_EM_RESTART': '1', 22:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:34 INFO - 'PWD': '/builds/slave/test', 22:19:34 INFO - 'SHELL': '/bin/bash', 22:19:34 INFO - 'SHLVL': '1', 22:19:34 INFO - 'TERM': 'linux', 22:19:34 INFO - 'TMOUT': '86400', 22:19:34 INFO - 'USER': 'cltbld', 22:19:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', 22:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:34 INFO - '_': '/tools/buildbot/bin/python'} 22:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:19:34 INFO - Cleaning up... 22:19:34 INFO - Return code: 0 22:19:34 INFO - Running post-action listener: _resource_record_post_action 22:19:34 INFO - Running post-action listener: _start_resource_monitoring 22:19:34 INFO - Starting resource monitoring. 22:19:34 INFO - [mozharness: 2016-10-05 05:19:34.686460Z] Finished create-virtualenv step (success) 22:19:34 INFO - [mozharness: 2016-10-05 05:19:34.686920Z] Running install step. 22:19:34 INFO - Running pre-action listener: _resource_record_pre_action 22:19:34 INFO - Running main action method: install 22:19:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:19:34 INFO - Reading from file tmpfile_stdout 22:19:34 INFO - Detecting whether we're running mozinstall >=1.0... 22:19:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:19:34 INFO - Reading from file tmpfile_stdout 22:19:34 INFO - Output received: 22:19:34 INFO - Usage: mozinstall [options] installer 22:19:34 INFO - Options: 22:19:34 INFO - -h, --help show this help message and exit 22:19:34 INFO - -d DEST, --destination=DEST 22:19:34 INFO - Directory to install application into. [default: 22:19:34 INFO - "/builds/slave/test"] 22:19:34 INFO - --app=APP Application being installed. [default: firefox] 22:19:34 INFO - mkdir: /builds/slave/test/build/application 22:19:34 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'] 22:19:34 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 22:19:51 INFO - Reading from file tmpfile_stdout 22:19:51 INFO - Output received: 22:19:51 INFO - /builds/slave/test/build/application/firefox/firefox 22:19:51 INFO - Running post-action listener: _resource_record_post_action 22:19:51 INFO - [mozharness: 2016-10-05 05:19:51.425286Z] Finished install step (success) 22:19:51 INFO - [mozharness: 2016-10-05 05:19:51.425530Z] Running run-tests step. 22:19:51 INFO - Running pre-action listener: _resource_record_pre_action 22:19:51 INFO - Running main action method: run_tests 22:19:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:19:51 INFO - Python 2.7.3 22:19:51 INFO - Return code: 0 22:19:51 INFO - grabbing minidump binary from tooltool 22:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:51 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1165f60>, '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 0x1166d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11671d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:19:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:19:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:19:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:19:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:19:51 INFO - Return code: 0 22:19:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:19:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:19:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:19:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:19:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:19:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 22:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 22:19:51 INFO - Using env: {'DISPLAY': ':0', 22:19:51 INFO - 'HOME': '/home/cltbld', 22:19:51 INFO - 'LANG': 'en_US.UTF-8', 22:19:51 INFO - 'LANGUAGE': 'en_US:en', 22:19:51 INFO - 'LOGNAME': 'cltbld', 22:19:51 INFO - 'MAIL': '/var/mail/cltbld', 22:19:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:19:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:51 INFO - 'MOZ_NO_REMOTE': '1', 22:19:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:51 INFO - 'NO_EM_RESTART': '1', 22:19:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:51 INFO - 'PWD': '/builds/slave/test', 22:19:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:19:51 INFO - 'SHELL': '/bin/bash', 22:19:51 INFO - 'SHLVL': '1', 22:19:51 INFO - 'TERM': 'linux', 22:19:51 INFO - 'TMOUT': '86400', 22:19:51 INFO - 'USER': 'cltbld', 22:19:51 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898', 22:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:51 INFO - '_': '/tools/buildbot/bin/python'} 22:19:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 22:19:51 INFO - mozversion application_buildid: 20161004204200 22:19:51 INFO - mozversion application_changeset: 2ba7a111b2a73cddd9cb8fcddc3482642a161c23 22:19:51 INFO - mozversion application_display_name: Nightly 22:19:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:19:51 INFO - mozversion application_name: Firefox 22:19:51 INFO - mozversion application_remotingname: firefox 22:19:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 22:19:51 INFO - mozversion application_vendor: Mozilla 22:19:51 INFO - mozversion application_version: 52.0a1 22:19:51 INFO - mozversion platform_buildid: 20161004204200 22:19:51 INFO - mozversion platform_changeset: 2ba7a111b2a73cddd9cb8fcddc3482642a161c23 22:19:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 22:19:51 INFO - mozversion platform_version: 52.0a1 22:19:51 INFO - using testdate: 1475644791 22:19:51 INFO - actual date: 1475644791 22:19:51 INFO - starting webserver on 'localhost:56050' 22:19:51 INFO - SUITE-START | Running 2 tests 22:19:51 INFO - TEST-START | dromaeo_css 22:19:51 INFO - operating with platform_type : linux_ 22:19:51 INFO - Initialising browser for dromaeo_css test... 22:19:51 INFO - TEST-INFO | started process 11526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUhIEb_/profile http://localhost:56050/getInfo.html) 22:19:56 INFO - PROCESS | 11526 | __metrics Screen width/height:1600/1200 22:19:56 INFO - PROCESS | 11526 | colorDepth:24 22:19:56 INFO - PROCESS | 11526 | Browser inner width/height: 1024/697 22:19:56 INFO - PROCESS | 11526 | __metrics 22:19:57 INFO - PROCESS | 11526 | 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" 22:19:57 INFO - PROCESS | 11526 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:19:57 INFO - PROCESS | 11526 | console.error: PushService: 22:19:57 INFO - PROCESS | 11526 | stateChangeProcessEnqueue: Error transitioning state 22:19:57 INFO - PROCESS | 11526 | UnknownError 22:19:58 INFO - TEST-INFO | 11526: exit 0 22:19:58 INFO - Browser initialized. 22:19:58 INFO - Running cycle 1/1 for dromaeo_css test... 22:19:58 INFO - TEST-INFO | started process 11610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUhIEb_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:20:10 INFO - PROCESS | 11610 | RSS: Main: 174989312 22:20:10 INFO - PROCESS | 11610 | 22:21:01 INFO - PROCESS | 11610 | 1475644861968 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] 22:23:15 INFO - PROCESS | 11610 | Cycle 1(1): loaded http://localhost:56050/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56050/tests/dromaeo/cssquery-ext.html) 22:23:16 INFO - PROCESS | 11610 | RSS: Main: 309800960 22:23:16 INFO - PROCESS | 11610 | 22:26:19 INFO - PROCESS | 11610 | Cycle 1(1): loaded http://localhost:56050/tests/dromaeo/cssquery-ext.html (next: http://localhost:56050/tests/dromaeo/cssquery-jquery.html) 22:26:20 INFO - PROCESS | 11610 | RSS: Main: 279404544 22:26:20 INFO - PROCESS | 11610 | 22:29:22 INFO - PROCESS | 11610 | Cycle 1(1): loaded http://localhost:56050/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56050/tests/dromaeo/cssquery-mootools.html) 22:29:22 INFO - PROCESS | 11610 | RSS: Main: 277061632 22:29:22 INFO - PROCESS | 11610 | 22:32:25 INFO - PROCESS | 11610 | Cycle 1(1): loaded http://localhost:56050/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56050/tests/dromaeo/cssquery-prototype.html) 22:32:25 INFO - PROCESS | 11610 | RSS: Main: 219889664 22:32:25 INFO - PROCESS | 11610 | 22:35:29 INFO - PROCESS | 11610 | Cycle 1(1): loaded http://localhost:56050/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56050/tests/dromaeo/cssquery-yui.html) 22:35:29 INFO - PROCESS | 11610 | RSS: Main: 218869760 22:35:29 INFO - PROCESS | 11610 | 22:38:32 INFO - PROCESS | 11610 | Cycle 1(1): loaded http://localhost:56050/tests/dromaeo/cssquery-yui.html (next: http://localhost:56050/tests/dromaeo/cssquery-dojo.html) 22:38:33 INFO - PROCESS | 11610 | RSS: Main: 313606144 22:38:33 INFO - PROCESS | 11610 | 22:38:33 INFO - PROCESS | 11610 | __start_tp_report 22:38:33 INFO - PROCESS | 11610 | _x_x_mozilla_page_load 22:38:33 INFO - PROCESS | 11610 | _x_x_mozilla_page_load_details 22:38:33 INFO - PROCESS | 11610 | |i|pagename|runs| 22:38:33 INFO - PROCESS | 11610 | |0;dojo.html;2550.107462388163;2555.6294337321087;2599.0513462586155;2601.75283348082;2613.699424566173;4453.710508816925;4482.282834746441;4596.172688915994;4632.97683511582;4649.6280297576195;4533.4786499552565;4540.704854184476;4541.250693635546;4557.931631025529;4566.611837993774;4143.792810359478;4182.769947652878;4187.204431158086;4267.295896177127;4324.935125973113;4239.236937351276;4247.129338485603;4334.5448727883595;4349.304111342186;4397.912041759163;4285.142971405716;4295.849645262417;4298.183345164424;4348.717333373336;4353.71700839446;4192.853250136246;4313.935290970638;4397.230484665203;4403.889902752425;4409.2283850326385;4189.581041895816;4282.693778397587;4305.590968857953;4328.610425061728;4329.523752387235;4554.863354099382;4574.565416285448;4583.656225783079;4625.907481850378;4629.23617603095;4861.343718598015;4880.365552478191;5004.724740139291;5007.424146223195;5019.67372120811;4927.3884841034305;4941.061198372297;4956.925646115311;4974.825881094144;5033.572146367563;4490.326451032306;4609.516000819933;4612.630989520831;4615.653825963066;4677.462091859412;4942.456329803718;5009.849704508871;5031.723255220924;5045.772940217699;5053.646244762831;4839.443464001614;4855.514448555116;4861.124997500413;4865.440474345425;4904.4605093439695;4824.396950381202;4942.5304596063315;4956.851294461172;4962;5009.874753131201;4832.540908613676;4859.489753575895;4904.950950490449;4911.8280860169725;4955.529224723646;4896.510348965075;4898.828541001048;4900.583450406755;4945.332380128637;4964.975175124174;4198.433211516467;4200.642945349679;4201.747895126302;4249.490061192677;4252.978735106367;3580.7493475456467;3603.7657552259543;3627.183883626216;3639.563252409675;3706.7590606610484;4263.893402664959;4268.466441694788;4290.656747460196;4306.0311429928015;4308.633766129914;5023.372078490189;5029.069622119846;5032.748362581856;5036.345275114211;5096.031753966735;4112.115895082512;4266.274733295348;4274.10243848789;4274.764887931132;4325.826966921288;4370.431843860278;4440.644748420119;4498.212812757754;4498.415206023196;4572.657050721209;4753.001869607421;4754.286856971482;4761;4765.046990601824;4827.782749776339;4966.528179822911;4970.801167953241;5006.574441172541;5014.323066385991;5074.6194035448225;4577.679562430598;4601.079784043138;4610.377599024089;4612.238980568303;4629.513901040342;4771.498992605726;4783.115123702126;4796.088743138793;4842.176829938849;4843.176659967743;4848.8302909398;4850.757462126809;4854.247591623162;4861.732604706775;4923;4691.249400095969;4719.032598317405;4733.573978341966;4742.88142796419;4759.881002974953;4767;4767.856964291077;4768.380110585602;4816.662833601615;4822.180229361087;4694.084653492673;4708.128996135726;4710.528947105399;4758.095961767253;4761.642876784185;4706.411698537683;4754.809807607657;4790.209615413418;4791.880202994953;4793.113274044313;4651.604613607746;4654.697444666086;4685.789139488799;4690.226112691368;4748.857534273978 22:38:33 INFO - PROCESS | 11610 | |1;ext.html;567.492094575355;576.3947854752508;577.428345937522;578.6238944685956;580.9716801261768;27192.59211111835;42447.78776106119;43743.56256437435;43888;43940.560594394046;39277;39654;39656;39676.206475870466;39710;7524.73663421779;7667.693292268303;7675.692972281102;7676.961615191916;7678.731244406447;7536.811579710524;7607.125180604246;7632.160462349138;7634.961825190866;7638.427117966147;7621.847563048764;7657.310842024217;7659.731909383145;7659.923400766004;7678.7696369108735;7576.393888488935;7594.734184303523;7598.164201937782;7608.885866712004;7623.809404764897;7618.352440042603;7683.423743219281;7687.2697093776005;7690.692372305101;7695.192004839523;37546;37958.43062354067;37968;37974.240515189544;38000.80999594984;3010.8795648174046;3154.1168472827644;3156.542301366289;3276.3774882772195;3549.378858699717;27354.316142096406;27885.58171627427;27986;28060.579091313648;29092.709072909212;3486.1981744198974;3534.3991521441417;3545.0782796473104;3553.9111522211892;3661.6155303692994;252379;252940;253618;254076;254702;30360.392792144034;51486;51758.74120629373;51772.74113629408;51841.48158518442;31535.526967095513;33562;33711.15722106967;33719;33734;12290.569830055905;12412.689682757822;12427.565035223724;12427.93786031064;12433.254004759743;9874.950625246971;9932.652357167464;9953.502324883726;9962.203023758082;9969.501524923724;7837.747334855971;7855.13593504714;7884.093329267208;7970.481918675384;7971.202879712098;3082.4143412751505;3093.273080826004;3124.906252812419;3143.1984843864666;3159.3997140543224;817.8486979908736;871.1593312453513;942.1406032690751;984.7341217871278;997.4165113408737;26997.86501067482;27461.45077098487;27862;28084.71915280862;28365;891.6567121658079;928.3223247029706;939.248601119102;957.7892863570004;970.5438443931341;13438.664033399244;13713.59706784599;13742.244176570184;13850.307484625728;13877.236751978537;368270;368570;369789;370604;370921;48005.279920801215;48564;48571;48649.513504864495;48656.27015594769;1048.4652827058255;1107.5293000474767;1155.1221071985183;1179.168686076314;1204.897583705395;26158.86920565385;28525.857370713013;28955.855220724603;29400.55899161557;29453.558196627495;40527.163098582816;41052.79473602613;41077.79461102675;41109.794451027556;41184.38223426711;308191;310893;311150;311315;311340;21562.78437215608;22157.667634985166;25023.249302520955;38172.80913595414;39365;37785;41007.38488922728;41558.79220603878;42113.57886421219;42608.78695606502;34948.825255873555;35663.64336356603;35983.64016359803;36186;36392;35787.28425431529;35886.28227435489;35994.46008309825;36664.26671466609;36767.264654707295;34968.82515587406;35314.293714126085;35454.290914182086;35469.29061418809;35545.644543554234;31108.222294441915;32414.51378229281;32848.1787955303;32874.50688239631;32896.342073158885;24713.135040273504;24924.37689057788;24945.50108997846;25159.24522264335;25184.668989547037 22:38:33 INFO - PROCESS | 11610 | |2;jquery.html;323.23554792914763;349.9160201551627;351.8645321551203;355.2557392263208;383.4363485676057;12182.939085304572;15651.373945042198;15875.364985400585;17655.91172044141;17876.82123178768;15890.205489725526;15904.84095159048;16928.83071169288;17001.48995530133;17379;4948.406191257054;4980.526849949258;5081.517255860687;5121.180611102224;5210.452902445246;3663.8717644882436;3855.556610989744;5041.344625198719;5122.8207012754565;5130.486951304858;3834.022324307298;3878.9806050969705;3891.8443262269475;3892.8637497687587;4470.552944705536;5945.019071853139;6049.122877182828;6051.697415129248;6060.181875446802;6060.575759696823;4686.390769200017;4978.054169707744;5001.649884508086;5285.920711189336;5289.391719952217;12146.271223726517;12303;12362.134650574373;12402.379881006003;18807.717884231748;1858.0616788521845;1901.895395753233;1916.6741653918866;1934;1940.8156225158586;8816.294696424271;9165.816683666357;9308.813823723487;9659.517024148765;9752.609895604168;1552.208373729395;1612.5887898585902;1613.185341402584;1675.9748603770831;1695.0677127579904;67114.66442667755;68553.3144668552;69923.65038174827;70000.6499967497;71249.9312510318;9776.560054797552;9799;10343.27597068213;10697.197710171613;10751.78496430067;13442.46230150783;13452.865471345356;13478.25869577163;13498;13499.190048597116;6768.763093291711;6770.458363330922;6802.285759995129;7046.401055910203;7078.079849619517;6237.500999919996;6397.936020639827;6448.161738973903;6505;6523.804285871432;4234.237837189336;4252.532221455637;4276.123394704078;4276.80754366048;4362.709577471853;1742.4249997500795;1748;1792.7490151378818;1793.2916497983224;1802.5493626593352;816.6651672814118;818.2145140665028;826.5371392020488;828.7389472316202;902.7201567513961;16030.599235018984;16110.113943732973;16520.00879947207;17600.119994000248;17740.733888991675;844.1642773654038;860.3977215948861;881.8456770065342;895.6909866096187;906.465185540521;9067.455952642862;9769.609215631295;9830.213582913493;9842.720446342073;9873;361469;365005;368934;374702;376079;80113.59943200246;80481.59759201284;80504.19495805084;80549;80801;906.918377346042;916.2852974679761;941.091846368258;949.4777872170279;950.1686024728363;15065.849341506444;15140.621484462976;15503.379864805282;15550.37798488093;15739.606509837346;29325;36269;36583;37520;39278.6072139275;45187;46807.76596116998;48287.5171248283;56417.43582564286;56886.7155664219;4636.559526844944;4720.5043470436485;4822.5887056471765;6424.196975378078;7009.859802803813;9684.46735429558;11352.262102963281;11528.884711152781;11761.47073381717;11800.291982481078;9823.312368134162;10416.1667066636;10530.31552949056;10538.525766340686;10790.931939579588;8543.444676096035;9838.655647052605;10237.590496380062;10265.435401053013;10632.574697012342;9427.198688111588;9718.514074296398;9831.262655300738;9899.059589339002;9984.101430871257;7083.610401427971;7153.964230178815;7238.674259658223;7362.263773622595;7490;9314.860277095984;9696.175825054666;9697.272704547328;9886.060824221688;10035.297529172887 22:38:33 INFO - PROCESS | 11610 | |3;mootools.html;1187.2935603316023;1343.8723321284479;1400.754867898118;1414.9434022639095;1673.4728560503434;6742.426893714034;7078.929210707892;7390.224026477216;7390.852182956338;7621.275978782007;7437.590932498711;7502.774916752493;7503.13713922899;7509.737159199429;7511.023566936305;2093.27781915239;2107.95784084319;2108.9578208435823;2112.4930016795934;2121.673953778888;2080.157536197842;2127.0747224957195;2134.3703607435764;2136.134865379524;2137.8396620253466;2084.4997200671883;2090.4460318015663;2101.4116047506645;2101.443117573844;2131.3392848217104;2042.3872838148645;2047.2118234479683;2058.3927741316347;2059.3821853443906;2065.607534568435;2006.56858775364;2020.3029954665617;2043.039771307483;2050.2721533855415;2051.8974051297378;7634.809129771745;7676.46264761467;7784.221577842227;7805.9609701951695;7812.492188007761;4458.487273963503;4665.113628410591;4694.08465349257;4697.577218050392;4712.764361781898;2830.5188118019987;2976.627921509811;3012.653544842349;3037.58992536007;3040.5743195952587;905.0994260710635;913.5112714697605;927.193341792638;927.8330098625603;936.2089034765612;10642.308249963728;10685.145188384988;10698.090662293793;10767.3539587625;10773.084287835543;3836.5396152461885;3869.9806500967316;3956.22853543562;3961.960380396159;3974.2448934702315;8430.072692003874;8495.490270583661;8507.659693612186;8517.361197910057;8517.829643407098;4454.57681520255;4457.2199865023495;4461.219286624828;4461.888452788707;4462.263726485158;3458.688718015391;3564.6435356464663;4077.938830917539;4081.306177949696;4091.7749523775883;3193.6007999000126;3237.093613788143;3308.7849289796086;3327.600687917417;3345.481450375196;973.522973742875;994.4083270454068;998.8912307338848;1000.8448690452991;1014.9086582207636;700.7792545348199;708.553611224925;727.6143643868758;848.1433751910491;852.5481494807761;5261.394939581921;5363.410024897258;5474.644148130359;5585.972070139624;5592.412796656374;791.5013541468837;813.515958004986;828.9088200297963;844.957752112392;922.3958307308724;3312.7184189344175;3553.9822300888845;3627.111357717376;3639.94540081899;3729.7948612826553;9253.537323133816;9700.466474343837;9722.125008749246;9728.513574321256;9768.413895166314;9689.660861869801;9701.805963880683;9706.126448619658;9710.465924374086;9719.222462203006;7189.424846012306;7209.639518024078;7249.7462588810195;7341.082364704412;7351.44864135192;5189.429162792166;5211.713355765318;5326.041312563776;5329.147336426308;5382;8695.217430431292;8788.945326560854;8926.509042002752;8929.553522323728;8955.910440895508;8553.486790792573;8606.139386061344;8616.138386161334;8900.109989001307;9038.186563209343;5817.214676018683;6297.055441683784;6408.263049749338;6416.390442907917;6416.839579010375;6791.966040169767;7333.230010848997;7575.924240757742;7625.466217364731;7628.466007379652;6572.7042283098335;6672.232693240339;6689.5986240825705;6863.862722745617;6933.826654333682;6526.24948130971;6640.9335906642245;6741.966290168518;6770.086038384952;6780.898286525805;6202.968985155046;6294.874102518015;6305.054241863757;6306.590071645328;6311.463525600376;4381.67137464685;4448.288273876165;4511.8646440606835;4549.863504094882;4600.079984003146;4425.291953287458;4481.439820022497;4538.387317712067;4582.19811532987;4641.930371044369 22:38:33 INFO - PROCESS | 11610 | |4;prototype.html;292.5845299674462;296.9346743716383;300.0862374070954;300.8991987684126;302.8985289927874;4604.240300350442;4616.353710480531;4622.676412651112;4631.536846315366;4674.083625713458;4576.5652263035045;4591.357209990596;4596.839110631128;4598.747068911209;4601.171789077965;3453.8273086345644;3515.367233897897;3558.1638314996085;3633.1462106404974;3658.567052909812;3658.981705091484;3660.2313514162056;3663.3222853772136;3696.4270538066507;3698.2973235085383;3618.945715814252;3647.781133132007;3652.086978255436;3666.4500324951337;3687.815609219542;3454.758166928316;3526.823658817049;3567.714582833367;3640.3083414151492;3657.9268414631824;3213.4537128687944;3218.8090406549727;3224.6782316731915;3225.822579758112;3242.8864989725485;4506.301523263899;4522.344260082303;4529.4791099023705;4532.773361331921;4570.154521413516;3903.765774053566;4134.875953721393;4155.459790227282;4168.645665118469;4179.2059508693255;4862.541237628698;4866.46468888422;4867.902641947141;4882.609391248727;4910.37295047148;3480.120734803203;3482.945062413163;3485.2506711057245;3486.3724529584665;3494.8602055917986;5006.774695138727;5122.359705036871;5149.6910185389;5157.369741431859;5158.896822063575;3463.930721385558;3484.8954531364097;3485.6165821759587;3503.4219353806848;3506.9123271917897;3542.982285088558;3548.929021419609;3568.5360903082433;3568.964310356915;3581.9641803582153;4069.1658210066867;4076.9184616307507;4098.6516146127915;4120.649744771728;4124.422580838685;4716.217431715305;4858.246971719389;4937.0624478435275;4943.332650092263;4944.898418172263;1214.2350319298962;1225.8048402807192;1232.9568465103678;1233.4018001269378;1237.2329155923385;784.7959530521991;791.9032140485353;803.8311954489506;811.338758911497;812.1147948735907;4112.753234805921;4250.086231460189;4254.255505286563;4261.595148460891;4267.743935363888;4878.341423907798;4952.192449755813;5031.4465408805;5040.647154699136;5056.84829455117;4297.205017071852;4298.26929421999;4301.2257793597455;4308.827646894152;4338.349247612883;2558.6929568451906;2629.1061039246747;2649.6555447791666;2674.424998625305;2680.517506848747;4791.736454495036;4807.927881081787;4815.518448155157;4815.544072522968;4833.589144922651;5134.897302053938;5152.711822044489;5155.6391052626705;5161.251618515369;5165.9741701292005;4639.30410438437;4791.496892826272;4820.168336032285;4827.782749776268;4849.951500485021;5031.798728050837;5034.546890779848;5048.646594738333;5051.141305978066;5053.519915608012;4961.5534601886;4990.802207470108;4992.600591952708;4999.900002000012;5000.949990500194;4619.630429565559;4819.903601928012;4849.442314133919;4860.392450943632;4873.439554451284;3553.076200187918;3574.588922273868;3574.982125089358;3597.298526787356;3599.262151259038;5056.797728090835;5086.771095300646;5086.872828179177;5096.388433388017;5098.566621837185;4815.927761083657;4868.77177078051;4893.266010098514;4907.214845624683;4926.802927882844;4848.80604775805;4880.41435027799;4886;4891.559759621651;4898.8775280618265;4800.783964721666;4820.662553621213;4864.537868902448;4867.7322747249245;4888.828890988798;4676.46220684612;4684.704494797593;4831.613470922388;4929.383827021622;4971.577415919543;4602.838900638461;4754.120487709784;4770.260609605517;4777.737224452689;4791.669789496266 22:38:33 INFO - PROCESS | 11610 | |5;yui.html;616.6639181646002;639.7536948274912;668.8996650502421;723.508014550106;737.3032484302333;12679.556215532459;13852.168869867815;13911;13952.58142255734;13977.23125228112;13253.933730331335;13368.53210137643;13389.129706569067;13464.596062118128;13478.123921945067;603.3664652115283;618.2673531864732;741.6959046790817;742.9591372474512;756.7124492692769;761.1399118995555;763.1262204775529;763.4045444553258;763.4236151705483;763.6105586151075;807.4953154278576;809.3201710563126;811.2536466450879;812.10262659761;812.5124925044955;618.298231507238;635.3963734452266;769.5575044349465;795.6181033104084;798.3892322373389;579.2585490572075;580.9941900580982;581.8167277307634;583.1107560969513;585.2041223935487;12255.1421400502;12269.69325766863;12276.693082673004;12281.324527151002;12285.262884226975;12982.740345193044;13405.597832065054;13652.112612680145;13684.315784210849;13898.900747811029;10319.84520232197;10755.677329680122;10774.515146818334;10836.241463097585;11040.613578524793;3339.7495187860764;3357.0768038789283;3400.302937897725;3416.7266618670446;3495.038864312334;63271.36728632701;63331.36668633301;63918.36081639171;64034;64474;10411.635592754368;10451.895481045092;10481.947590262;10736.946315268373;10895.945520272506;17010.659786804194;17764.3123903229;17855.464336069937;18512.07439628013;18636.906815465834;6908.723651053901;6908.827279317957;7020.7542736004;7086.893696594555;7244.746433874789;3452.413089774694;3475.8783442579893;3497.45789402643;3569.696575791087;3652.8457582655014;2923.6199294092057;3019.139545229599;3039;3041.832699201521;3044.25415773137;498.20536244690385;500.52700198312243;506.8023470846373;507.7283653245496;511.98720031998755;459.55423239457673;592.3720855892767;594.8750762339957;607.2166904692984;621.1490258346095;9412;9707;9900.306978511579;9960.850587241197;10071.546780394754;565.9745311460912;590.8611476303065;596.1356033751078;599.5593238969354;628.940250676185;4080.836766529365;4130.277201489727;4252.808623611945;4311.784410779448;4364.454443194601;60370;87299.56350218208;91820.54089729642;92155;92421.53789231011;74179.62910185523;75820.62089689517;76901.61549192331;78949.60525197338;81235.59382203169;64056.67971660112;67077.66461167761;68449.65775171093;69061.65469172622;69828.65085674539;7452.366548843409;7561.3194812467145;7640.961795190989;7895.210478952059;7942.44402891792;40804.59195408127;41702.37446438367;42088.36867447052;42148.1570368597;42891;51984.220236697234;58600.4139958595;58872.705636471546;60391.39608604033;60829.39170608237;10040.347377420445;10222.437765922945;10234.744131396774;10242.846357304796;10665.89334106649;10913.290636108628;11061.557537698402;11137.777244455228;11839.342492051292;12103.576374826838;10377.9481102594;10730.73173170677;10883.23817332779;11079.50142243585;11432;9921.851172232278;10102.747431314276;10362.378257304284;10585.735356615838;10826.13390928708;10297.330673506198;10413.375197488174;10481.42352170638;10671.35971841692;10936.671899843017;8576.185262400062;8724.651013959625;9094;9214.815703685754;9342.579583918605;7954.244346787046;8656;8760.386772925835;9395.151659899646;9436.85844712316 22:38:33 INFO - PROCESS | 11610 | __end_tp_report 22:38:33 INFO - PROCESS | 11610 | __start_cc_report 22:38:33 INFO - PROCESS | 11610 | _x_x_mozilla_cycle_collect,1259 22:38:33 INFO - PROCESS | 11610 | __end_cc_report 22:38:33 INFO - PROCESS | 11610 | __startTimestamp1475645913007__endTimestamp 22:38:33 INFO - PROCESS | 11610 | 22:38:33 INFO - PROCESS | 11610 | ------- Summary: start ------- 22:38:33 INFO - PROCESS | 11610 | Number of tests: 6 22:38:33 INFO - PROCESS | 11610 | 22:38:33 INFO - PROCESS | 11610 | [#0] dojo.html Cycles:165 Average:4563.51 Median:4685.79 stddev:471.62 (10.1%) stddev-sans-first:445.84 22:38:33 INFO - PROCESS | 11610 | Values: 2550.1 2555.6 2599.1 2601.8 2613.7 4453.7 4482.3 4596.2 4633.0 4649.6 4533.5 4540.7 4541.3 4557.9 4566.6 4143.8 4182.8 4187.2 4267.3 4324.9 4239.2 4247.1 4334.5 4349.3 4397.9 4285.1 4295.8 4298.2 4348.7 4353.7 4192.9 4313.9 4397.2 4403.9 4409.2 4189.6 4282.7 4305.6 4328.6 4329.5 4554.9 4574.6 4583.7 4625.9 4629.2 4861.3 4880.4 5004.7 5007.4 5019.7 4927.4 4941.1 4956.9 4974.8 5033.6 4490.3 4609.5 4612.6 4615.7 4677.5 4942.5 5009.8 5031.7 5045.8 5053.6 4839.4 4855.5 4861.1 4865.4 4904.5 4824.4 4942.5 4956.9 4962.0 5009.9 4832.5 4859.5 4905.0 4911.8 4955.5 4896.5 4898.8 4900.6 4945.3 4965.0 4198.4 4200.6 4201.7 4249.5 4253.0 3580.7 3603.8 3627.2 3639.6 3706.8 4263.9 4268.5 4290.7 4306.0 4308.6 5023.4 5029.1 5032.7 5036.3 5096.0 4112.1 4266.3 4274.1 4274.8 4325.8 4370.4 4440.6 4498.2 4498.4 4572.7 4753.0 4754.3 4761.0 4765.0 4827.8 4966.5 4970.8 5006.6 5014.3 5074.6 4577.7 4601.1 4610.4 4612.2 4629.5 4771.5 4783.1 4796.1 4842.2 4843.2 4848.8 4850.8 4854.2 4861.7 4923.0 4691.2 4719.0 4733.6 4742.9 4759.9 4767.0 4767.9 4768.4 4816.7 4822.2 4694.1 4708.1 4710.5 4758.1 4761.6 4706.4 4754.8 4790.2 4791.9 4793.1 4651.6 4654.7 4685.8 4690.2 4748.9 22:38:33 INFO - PROCESS | 11610 | 22:38:33 INFO - PROCESS | 11610 | [#1] ext.html Cycles:180 Average:45464.04 Median:368420.00 stddev:82965.05 (22.5%) stddev-sans-first:83129.31 22:38:33 INFO - PROCESS | 11610 | Values: 567.5 576.4 577.4 578.6 581.0 27192.6 42447.8 43743.6 43888.0 43940.6 39277.0 39654.0 39656.0 39676.2 39710.0 7524.7 7667.7 7675.7 7677.0 7678.7 7536.8 7607.1 7632.2 7635.0 7638.4 7621.8 7657.3 7659.7 7659.9 7678.8 7576.4 7594.7 7598.2 7608.9 7623.8 7618.4 7683.4 7687.3 7690.7 7695.2 37546.0 37958.4 37968.0 37974.2 38000.8 3010.9 3154.1 3156.5 3276.4 3549.4 27354.3 27885.6 27986.0 28060.6 29092.7 3486.2 3534.4 3545.1 3553.9 3661.6 252379.0 252940.0 253618.0 254076.0 254702.0 30360.4 51486.0 51758.7 51772.7 51841.5 31535.5 33562.0 33711.2 33719.0 33734.0 12290.6 12412.7 12427.6 12427.9 12433.3 9875.0 9932.7 9953.5 9962.2 9969.5 7837.7 7855.1 7884.1 7970.5 7971.2 3082.4 3093.3 3124.9 3143.2 3159.4 817.8 871.2 942.1 984.7 997.4 26997.9 27461.5 27862.0 28084.7 28365.0 891.7 928.3 939.2 957.8 970.5 13438.7 13713.6 13742.2 13850.3 13877.2 368270.0 368570.0 369789.0 370604.0 370921.0 48005.3 48564.0 48571.0 48649.5 48656.3 1048.5 1107.5 1155.1 1179.2 1204.9 26158.9 28525.9 28955.9 29400.6 29453.6 40527.2 41052.8 41077.8 41109.8 41184.4 308191.0 310893.0 311150.0 311315.0 311340.0 21562.8 22157.7 25023.2 38172.8 39365.0 37785.0 41007.4 41558.8 42113.6 42608.8 34948.8 35663.6 35983.6 36186.0 36392.0 35787.3 35886.3 35994.5 36664.3 36767.3 34968.8 35314.3 35454.3 35469.3 35545.6 31108.2 32414.5 32848.2 32874.5 32896.3 24713.1 24924.4 24945.5 25159.2 25184.7 22:38:33 INFO - PROCESS | 11610 | 22:38:33 INFO - PROCESS | 11610 | [#2] jquery.html Cycles:180 Average:23363.97 Median:4703.45 stddev:61285.76 (1303.0%) stddev-sans-first:61433.27 22:38:33 INFO - PROCESS | 11610 | Values: 323.2 349.9 351.9 355.3 383.4 12182.9 15651.4 15875.4 17655.9 17876.8 15890.2 15904.8 16928.8 17001.5 17379.0 4948.4 4980.5 5081.5 5121.2 5210.5 3663.9 3855.6 5041.3 5122.8 5130.5 3834.0 3879.0 3891.8 3892.9 4470.6 5945.0 6049.1 6051.7 6060.2 6060.6 4686.4 4978.1 5001.6 5285.9 5289.4 12146.3 12303.0 12362.1 12402.4 18807.7 1858.1 1901.9 1916.7 1934.0 1940.8 8816.3 9165.8 9308.8 9659.5 9752.6 1552.2 1612.6 1613.2 1676.0 1695.1 67114.7 68553.3 69923.7 70000.6 71249.9 9776.6 9799.0 10343.3 10697.2 10751.8 13442.5 13452.9 13478.3 13498.0 13499.2 6768.8 6770.5 6802.3 7046.4 7078.1 6237.5 6397.9 6448.2 6505.0 6523.8 4234.2 4252.5 4276.1 4276.8 4362.7 1742.4 1748.0 1792.7 1793.3 1802.5 816.7 818.2 826.5 828.7 902.7 16030.6 16110.1 16520.0 17600.1 17740.7 844.2 860.4 881.8 895.7 906.5 9067.5 9769.6 9830.2 9842.7 9873.0 361469.0 365005.0 368934.0 374702.0 376079.0 80113.6 80481.6 80504.2 80549.0 80801.0 906.9 916.3 941.1 949.5 950.2 15065.8 15140.6 15503.4 15550.4 15739.6 29325.0 36269.0 36583.0 37520.0 39278.6 45187.0 46807.8 48287.5 56417.4 56886.7 4636.6 4720.5 4822.6 6424.2 7009.9 9684.5 11352.3 11528.9 11761.5 11800.3 9823.3 10416.2 10530.3 10538.5 10790.9 8543.4 9838.7 10237.6 10265.4 10632.6 9427.2 9718.5 9831.3 9899.1 9984.1 7083.6 7154.0 7238.7 7362.3 7490.0 9314.9 9696.2 9697.3 9886.1 10035.3 22:38:33 INFO - PROCESS | 11610 | 22:38:33 INFO - PROCESS | 11610 | [#3] mootools.html Cycles:180 Average:5031.27 Median:5589.19 stddev:2859.60 (51.2%) stddev-sans-first:2853.03 22:38:33 INFO - PROCESS | 11610 | Values: 1187.3 1343.9 1400.8 1414.9 1673.5 6742.4 7078.9 7390.2 7390.9 7621.3 7437.6 7502.8 7503.1 7509.7 7511.0 2093.3 2108.0 2109.0 2112.5 2121.7 2080.2 2127.1 2134.4 2136.1 2137.8 2084.5 2090.4 2101.4 2101.4 2131.3 2042.4 2047.2 2058.4 2059.4 2065.6 2006.6 2020.3 2043.0 2050.3 2051.9 7634.8 7676.5 7784.2 7806.0 7812.5 4458.5 4665.1 4694.1 4697.6 4712.8 2830.5 2976.6 3012.7 3037.6 3040.6 905.1 913.5 927.2 927.8 936.2 10642.3 10685.1 10698.1 10767.4 10773.1 3836.5 3870.0 3956.2 3962.0 3974.2 8430.1 8495.5 8507.7 8517.4 8517.8 4454.6 4457.2 4461.2 4461.9 4462.3 3458.7 3564.6 4077.9 4081.3 4091.8 3193.6 3237.1 3308.8 3327.6 3345.5 973.5 994.4 998.9 1000.8 1014.9 700.8 708.6 727.6 848.1 852.5 5261.4 5363.4 5474.6 5586.0 5592.4 791.5 813.5 828.9 845.0 922.4 3312.7 3554.0 3627.1 3639.9 3729.8 9253.5 9700.5 9722.1 9728.5 9768.4 9689.7 9701.8 9706.1 9710.5 9719.2 7189.4 7209.6 7249.7 7341.1 7351.4 5189.4 5211.7 5326.0 5329.1 5382.0 8695.2 8788.9 8926.5 8929.6 8955.9 8553.5 8606.1 8616.1 8900.1 9038.2 5817.2 6297.1 6408.3 6416.4 6416.8 6792.0 7333.2 7575.9 7625.5 7628.5 6572.7 6672.2 6689.6 6863.9 6933.8 6526.2 6640.9 6742.0 6770.1 6780.9 6203.0 6294.9 6305.1 6306.6 6311.5 4381.7 4448.3 4511.9 4549.9 4600.1 4425.3 4481.4 4538.4 4582.2 4641.9 22:38:33 INFO - PROCESS | 11610 | 22:38:33 INFO - PROCESS | 11610 | [#4] prototype.html Cycles:180 Average:4055.16 Median:4603.54 stddev:1187.86 (25.8%) stddev-sans-first:1157.14 22:38:33 INFO - PROCESS | 11610 | Values: 292.6 296.9 300.1 300.9 302.9 4604.2 4616.4 4622.7 4631.5 4674.1 4576.6 4591.4 4596.8 4598.7 4601.2 3453.8 3515.4 3558.2 3633.1 3658.6 3659.0 3660.2 3663.3 3696.4 3698.3 3618.9 3647.8 3652.1 3666.5 3687.8 3454.8 3526.8 3567.7 3640.3 3657.9 3213.5 3218.8 3224.7 3225.8 3242.9 4506.3 4522.3 4529.5 4532.8 4570.2 3903.8 4134.9 4155.5 4168.6 4179.2 4862.5 4866.5 4867.9 4882.6 4910.4 3480.1 3482.9 3485.3 3486.4 3494.9 5006.8 5122.4 5149.7 5157.4 5158.9 3463.9 3484.9 3485.6 3503.4 3506.9 3543.0 3548.9 3568.5 3569.0 3582.0 4069.2 4076.9 4098.7 4120.6 4124.4 4716.2 4858.2 4937.1 4943.3 4944.9 1214.2 1225.8 1233.0 1233.4 1237.2 784.8 791.9 803.8 811.3 812.1 4112.8 4250.1 4254.3 4261.6 4267.7 4878.3 4952.2 5031.4 5040.6 5056.8 4297.2 4298.3 4301.2 4308.8 4338.3 2558.7 2629.1 2649.7 2674.4 2680.5 4791.7 4807.9 4815.5 4815.5 4833.6 5134.9 5152.7 5155.6 5161.3 5166.0 4639.3 4791.5 4820.2 4827.8 4850.0 5031.8 5034.5 5048.6 5051.1 5053.5 4961.6 4990.8 4992.6 4999.9 5000.9 4619.6 4819.9 4849.4 4860.4 4873.4 3553.1 3574.6 3575.0 3597.3 3599.3 5056.8 5086.8 5086.9 5096.4 5098.6 4815.9 4868.8 4893.3 4907.2 4926.8 4848.8 4880.4 4886.0 4891.6 4898.9 4800.8 4820.7 4864.5 4867.7 4888.8 4676.5 4684.7 4831.6 4929.4 4971.6 4602.8 4754.1 4770.3 4777.7 4791.7 22:38:33 INFO - PROCESS | 11610 | 22:38:33 INFO - PROCESS | 11610 | [#5] yui.html Cycles:180 Average:16720.54 Median:26248.10 stddev:23237.73 (88.5%) stddev-sans-first:23271.46 22:38:33 INFO - PROCESS | 11610 | Values: 616.7 639.8 668.9 723.5 737.3 12679.6 13852.2 13911.0 13952.6 13977.2 13253.9 13368.5 13389.1 13464.6 13478.1 603.4 618.3 741.7 743.0 756.7 761.1 763.1 763.4 763.4 763.6 807.5 809.3 811.3 812.1 812.5 618.3 635.4 769.6 795.6 798.4 579.3 581.0 581.8 583.1 585.2 12255.1 12269.7 12276.7 12281.3 12285.3 12982.7 13405.6 13652.1 13684.3 13898.9 10319.8 10755.7 10774.5 10836.2 11040.6 3339.7 3357.1 3400.3 3416.7 3495.0 63271.4 63331.4 63918.4 64034.0 64474.0 10411.6 10451.9 10481.9 10736.9 10895.9 17010.7 17764.3 17855.5 18512.1 18636.9 6908.7 6908.8 7020.8 7086.9 7244.7 3452.4 3475.9 3497.5 3569.7 3652.8 2923.6 3019.1 3039.0 3041.8 3044.3 498.2 500.5 506.8 507.7 512.0 459.6 592.4 594.9 607.2 621.1 9412.0 9707.0 9900.3 9960.9 10071.5 566.0 590.9 596.1 599.6 628.9 4080.8 4130.3 4252.8 4311.8 4364.5 60370.0 87299.6 91820.5 92155.0 92421.5 74179.6 75820.6 76901.6 78949.6 81235.6 64056.7 67077.7 68449.7 69061.7 69828.7 7452.4 7561.3 7641.0 7895.2 7942.4 40804.6 41702.4 42088.4 42148.2 42891.0 51984.2 58600.4 58872.7 60391.4 60829.4 10040.3 10222.4 10234.7 10242.8 10665.9 10913.3 11061.6 11137.8 11839.3 12103.6 10377.9 10730.7 10883.2 11079.5 11432.0 9921.9 10102.7 10362.4 10585.7 10826.1 10297.3 10413.4 10481.4 10671.4 10936.7 8576.2 8724.7 9094.0 9214.8 9342.6 7954.2 8656.0 8760.4 9395.2 9436.9 22:38:33 INFO - PROCESS | 11610 | -------- Summary: end -------- 22:38:33 INFO - PROCESS | 11610 | 22:38:34 INFO - TEST-INFO | 11610: exit 0 22:38:34 INFO - TEST-OK | dromaeo_css | took 1122345ms 22:38:34 INFO - TEST-START | kraken 22:38:34 INFO - operating with platform_type : linux_ 22:38:34 INFO - Initialising browser for kraken test... 22:38:34 INFO - TEST-INFO | started process 11919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBQmNz9/profile http://localhost:56050/getInfo.html) 22:38:38 INFO - PROCESS | 11919 | __metrics Screen width/height:1600/1200 22:38:38 INFO - PROCESS | 11919 | colorDepth:24 22:38:38 INFO - PROCESS | 11919 | Browser inner width/height: 1024/697 22:38:38 INFO - PROCESS | 11919 | __metrics 22:38:39 INFO - PROCESS | 11919 | 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" 22:38:39 INFO - PROCESS | 11919 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:38:39 INFO - PROCESS | 11919 | console.error: PushService: 22:38:39 INFO - PROCESS | 11919 | stateChangeProcessEnqueue: Error transitioning state 22:38:39 INFO - PROCESS | 11919 | UnknownError 22:38:40 INFO - TEST-INFO | 11919: exit 0 22:38:40 INFO - Browser initialized. 22:38:40 INFO - Running cycle 1/1 for kraken test... 22:38:40 INFO - TEST-INFO | started process 12002 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBQmNz9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:38:52 INFO - PROCESS | 12002 | RSS: Main: 174407680 22:38:52 INFO - PROCESS | 12002 | 22:38:55 INFO - PROCESS | 12002 | Cycle 1(1): loaded http://localhost:56050/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56050/tests/kraken/driver.html?testName=audio-beat-detection) 22:38:56 INFO - PROCESS | 12002 | RSS: Main: 233959424 22:38:56 INFO - PROCESS | 12002 | 22:38:59 INFO - PROCESS | 12002 | Cycle 1(1): loaded http://localhost:56050/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56050/tests/kraken/driver.html?testName=audio-dft) 22:38:59 INFO - PROCESS | 12002 | RSS: Main: 218566656 22:38:59 INFO - PROCESS | 12002 | 22:39:03 INFO - PROCESS | 12002 | Cycle 1(1): loaded http://localhost:56050/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56050/tests/kraken/driver.html?testName=audio-fft) 22:39:03 INFO - PROCESS | 12002 | RSS: Main: 300589056 22:39:03 INFO - PROCESS | 12002 | 22:39:05 INFO - PROCESS | 12002 | Cycle 1(1): loaded http://localhost:56050/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56050/tests/kraken/driver.html?testName=audio-oscillator) 22:39:06 INFO - PROCESS | 12002 | RSS: Main: 211415040 22:39:06 INFO - PROCESS | 12002 | 22:39:08 INFO - PROCESS | 12002 | Cycle 1(1): loaded http://localhost:56050/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56050/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:39:09 INFO - PROCESS | 12002 | RSS: Main: 214499328 22:39:09 INFO - PROCESS | 12002 | 22:39:12 INFO - PROCESS | 12002 | Cycle 1(1): loaded http://localhost:56050/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56050/tests/kraken/driver.html?testName=imaging-darkroom) 22:39:13 INFO - PROCESS | 12002 | RSS: Main: 250580992 22:39:13 INFO - PROCESS | 12002 | 22:39:16 INFO - PROCESS | 12002 | Cycle 1(1): loaded http://localhost:56050/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56050/tests/kraken/driver.html?testName=imaging-desaturate) 22:39:17 INFO - PROCESS | 12002 | RSS: Main: 249044992 22:39:17 INFO - PROCESS | 12002 | 22:39:20 INFO - PROCESS | 12002 | Cycle 1(1): loaded http://localhost:56050/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56050/tests/kraken/driver.html?testName=json-parse-financial) 22:39:20 INFO - PROCESS | 12002 | RSS: Main: 249421824 22:39:20 INFO - PROCESS | 12002 | 22:39:22 INFO - PROCESS | 12002 | Cycle 1(1): loaded http://localhost:56050/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56050/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:39:23 INFO - PROCESS | 12002 | RSS: Main: 211460096 22:39:23 INFO - PROCESS | 12002 | 22:39:25 INFO - PROCESS | 12002 | Cycle 1(1): loaded http://localhost:56050/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56050/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:39:25 INFO - PROCESS | 12002 | RSS: Main: 218128384 22:39:25 INFO - PROCESS | 12002 | 22:39:27 INFO - PROCESS | 12002 | Cycle 1(1): loaded http://localhost:56050/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56050/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:39:28 INFO - PROCESS | 12002 | RSS: Main: 228409344 22:39:28 INFO - PROCESS | 12002 | 22:39:31 INFO - PROCESS | 12002 | Cycle 1(1): loaded http://localhost:56050/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56050/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:39:32 INFO - PROCESS | 12002 | RSS: Main: 236724224 22:39:32 INFO - PROCESS | 12002 | 22:39:35 INFO - PROCESS | 12002 | Cycle 1(1): loaded http://localhost:56050/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56050/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:39:35 INFO - PROCESS | 12002 | RSS: Main: 234033152 22:39:35 INFO - PROCESS | 12002 | 22:39:37 INFO - PROCESS | 12002 | Cycle 1(1): loaded http://localhost:56050/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56050/tests/kraken/driver.html?testName=ai-astar) 22:39:37 INFO - PROCESS | 12002 | RSS: Main: 284393472 22:39:37 INFO - PROCESS | 12002 | 22:39:37 INFO - PROCESS | 12002 | __start_tp_report 22:39:37 INFO - PROCESS | 12002 | _x_x_mozilla_page_load 22:39:37 INFO - PROCESS | 12002 | _x_x_mozilla_page_load_details 22:39:37 INFO - PROCESS | 12002 | |i|pagename|runs| 22:39:37 INFO - PROCESS | 12002 | |0;ai-astar;113;114;115;115;114;115;115;114;114;115 22:39:37 INFO - PROCESS | 12002 | |1;audio-beat-detection;151;133;130;168;127;127;128;134;169;132 22:39:37 INFO - PROCESS | 12002 | |2;audio-dft;162;161;171;161;161;162;164;165;163;163 22:39:37 INFO - PROCESS | 12002 | |3;audio-fft;76;76;75;112;77;76;77;76;105;78 22:39:37 INFO - PROCESS | 12002 | |4;audio-oscillator;84;82;136;83;83;82;105;83;82;117 22:39:37 INFO - PROCESS | 12002 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;117;118 22:39:37 INFO - PROCESS | 12002 | |6;imaging-darkroom;147;146;148;147;146;146;145;147;146;145 22:39:37 INFO - PROCESS | 12002 | |7;imaging-desaturate;95;95;95;95;95;97;95;95;95;95 22:39:37 INFO - PROCESS | 12002 | |8;json-parse-financial;67;66;63;65;65;66;74;66;66;65 22:39:37 INFO - PROCESS | 12002 | |9;json-stringify-tinderbox;67;68;67;67;67;66;67;66;68;67 22:39:37 INFO - PROCESS | 12002 | |10;stanford-crypto-aes;84;84;92;87;83;83;83;92;83;83 22:39:37 INFO - PROCESS | 12002 | |11;stanford-crypto-ccm;151;142;140;140;140;139;140;139;184;149 22:39:37 INFO - PROCESS | 12002 | |12;stanford-crypto-pbkdf2;184;179;189;178;175;178;174;176;174;174 22:39:37 INFO - PROCESS | 12002 | |13;stanford-crypto-sha256-iterative;79;71;71;70;70;75;70;69;70;71 22:39:37 INFO - PROCESS | 12002 | __end_tp_report 22:39:37 INFO - PROCESS | 12002 | __start_cc_report 22:39:37 INFO - PROCESS | 12002 | _x_x_mozilla_cycle_collect,1936 22:39:37 INFO - PROCESS | 12002 | __end_cc_report 22:39:37 INFO - PROCESS | 12002 | __startTimestamp1475645977763__endTimestamp 22:39:37 INFO - PROCESS | 12002 | 22:39:37 INFO - PROCESS | 12002 | ------- Summary: start ------- 22:39:37 INFO - PROCESS | 12002 | Number of tests: 14 22:39:37 INFO - PROCESS | 12002 | 22:39:37 INFO - PROCESS | 12002 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 22:39:37 INFO - PROCESS | 12002 | Values: 113.0 114.0 115.0 115.0 114.0 115.0 115.0 114.0 114.0 115.0 22:39:37 INFO - PROCESS | 12002 | 22:39:37 INFO - PROCESS | 12002 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:133.50 stddev:16.59 (12.4%) stddev-sans-first:17.10 22:39:37 INFO - PROCESS | 12002 | Values: 151.0 133.0 130.0 168.0 127.0 127.0 128.0 134.0 169.0 132.0 22:39:37 INFO - PROCESS | 12002 | 22:39:37 INFO - PROCESS | 12002 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:3.02 (1.9%) stddev-sans-first:3.17 22:39:37 INFO - PROCESS | 12002 | Values: 162.0 161.0 171.0 161.0 161.0 162.0 164.0 165.0 163.0 163.0 22:39:37 INFO - PROCESS | 12002 | 22:39:37 INFO - PROCESS | 12002 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:13.67 (18.0%) stddev-sans-first:14.28 22:39:37 INFO - PROCESS | 12002 | Values: 76.0 76.0 75.0 112.0 77.0 76.0 77.0 76.0 105.0 78.0 22:39:37 INFO - PROCESS | 12002 | 22:39:37 INFO - PROCESS | 12002 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:82.50 stddev:19.17 (23.2%) stddev-sans-first:20.01 22:39:37 INFO - PROCESS | 12002 | Values: 84.0 82.0 136.0 83.0 83.0 82.0 105.0 83.0 82.0 117.0 22:39:37 INFO - PROCESS | 12002 | 22:39:37 INFO - PROCESS | 12002 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:39:37 INFO - PROCESS | 12002 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 22:39:37 INFO - PROCESS | 12002 | 22:39:37 INFO - PROCESS | 12002 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 22:39:37 INFO - PROCESS | 12002 | Values: 147.0 146.0 148.0 147.0 146.0 146.0 145.0 147.0 146.0 145.0 22:39:37 INFO - PROCESS | 12002 | 22:39:37 INFO - PROCESS | 12002 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 22:39:37 INFO - PROCESS | 12002 | Values: 95.0 95.0 95.0 95.0 95.0 97.0 95.0 95.0 95.0 95.0 22:39:37 INFO - PROCESS | 12002 | 22:39:37 INFO - PROCESS | 12002 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.00 stddev:2.91 (4.4%) stddev-sans-first:3.07 22:39:37 INFO - PROCESS | 12002 | Values: 67.0 66.0 63.0 65.0 65.0 66.0 74.0 66.0 66.0 65.0 22:39:37 INFO - PROCESS | 12002 | 22:39:37 INFO - PROCESS | 12002 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 22:39:37 INFO - PROCESS | 12002 | Values: 67.0 68.0 67.0 67.0 67.0 66.0 67.0 66.0 68.0 67.0 22:39:37 INFO - PROCESS | 12002 | 22:39:37 INFO - PROCESS | 12002 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:84.00 stddev:3.69 (4.4%) stddev-sans-first:3.88 22:39:37 INFO - PROCESS | 12002 | Values: 84.0 84.0 92.0 87.0 83.0 83.0 83.0 92.0 83.0 83.0 22:39:37 INFO - PROCESS | 12002 | 22:39:37 INFO - PROCESS | 12002 | [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:141.00 stddev:13.88 (9.8%) stddev-sans-first:14.62 22:39:37 INFO - PROCESS | 12002 | Values: 151.0 142.0 140.0 140.0 140.0 139.0 140.0 139.0 184.0 149.0 22:39:37 INFO - PROCESS | 12002 | 22:39:37 INFO - PROCESS | 12002 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.10 Median:178.00 stddev:4.93 (2.8%) stddev-sans-first:4.75 22:39:37 INFO - PROCESS | 12002 | Values: 184.0 179.0 189.0 178.0 175.0 178.0 174.0 176.0 174.0 174.0 22:39:37 INFO - PROCESS | 12002 | 22:39:37 INFO - PROCESS | 12002 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:71.00 stddev:3.06 (4.3%) stddev-sans-first:1.72 22:39:37 INFO - PROCESS | 12002 | Values: 79.0 71.0 71.0 70.0 70.0 75.0 70.0 69.0 70.0 71.0 22:39:37 INFO - PROCESS | 12002 | -------- Summary: end -------- 22:39:37 INFO - PROCESS | 12002 | 22:39:39 INFO - TEST-INFO | 12002: exit 0 22:39:39 INFO - TEST-OK | kraken | took 65051ms 22:39:39 INFO - SUITE-END | took 1187s 22:39:39 INFO - Completed test suite (00:19:47) 22:39:39 INFO - javascript benchmark 22:39:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2550.107462388163, 2555.6294337321087, 2599.0513462586155, 2601.75283348082, 2613.699424566173, 4453.710508816925, 4482.282834746441, 4596.172688915994, 4632.97683511582, 4649.6280297576195, 4533.4786499552565, 4540.704854184476, 4541.250693635546, 4557.931631025529, 4566.611837993774, 4143.792810359478, 4182.769947652878, 4187.204431158086, 4267.295896177127, 4324.935125973113, 4239.236937351276, 4247.129338485603, 4334.5448727883595, 4349.304111342186, 4397.912041759163, 4285.142971405716, 4295.849645262417, 4298.183345164424, 4348.717333373336, 4353.71700839446, 4192.853250136246, 4313.935290970638, 4397.230484665203, 4403.889902752425, 4409.2283850326385, 4189.581041895816, 4282.693778397587, 4305.590968857953, 4328.610425061728, 4329.523752387235, 4554.863354099382, 4574.565416285448, 4583.656225783079, 4625.907481850378, 4629.23617603095, 4861.343718598015, 4880.365552478191, 5004.724740139291, 5007.424146223195, 5019.67372120811, 4927.3884841034305, 4941.061198372297, 4956.925646115311, 4974.825881094144, 5033.572146367563, 4490.326451032306, 4609.516000819933, 4612.630989520831, 4615.653825963066, 4677.462091859412, 4942.456329803718, 5009.849704508871, 5031.723255220924, 5045.772940217699, 5053.646244762831, 4839.443464001614, 4855.514448555116, 4861.124997500413, 4865.440474345425, 4904.4605093439695, 4824.396950381202, 4942.5304596063315, 4956.851294461172, 4962.0, 5009.874753131201, 4832.540908613676, 4859.489753575895, 4904.950950490449, 4911.8280860169725, 4955.529224723646, 4896.510348965075, 4898.828541001048, 4900.583450406755, 4945.332380128637, 4964.975175124174, 4198.433211516467, 4200.642945349679, 4201.747895126302, 4249.490061192677, 4252.978735106367, 3580.7493475456467, 3603.7657552259543, 3627.183883626216, 3639.563252409675, 3706.7590606610484, 4263.893402664959, 4268.466441694788, 4290.656747460196, 4306.0311429928015, 4308.633766129914, 5023.372078490189, 5029.069622119846, 5032.748362581856, 5036.345275114211, 5096.031753966735, 4112.115895082512, 4266.274733295348, 4274.10243848789, 4274.764887931132, 4325.826966921288, 4370.431843860278, 4440.644748420119, 4498.212812757754, 4498.415206023196, 4572.657050721209, 4753.001869607421, 4754.286856971482, 4761.0, 4765.046990601824, 4827.782749776339, 4966.528179822911, 4970.801167953241, 5006.574441172541, 5014.323066385991, 5074.6194035448225, 4577.679562430598, 4601.079784043138, 4610.377599024089, 4612.238980568303, 4629.513901040342, 4771.498992605726, 4783.115123702126, 4796.088743138793, 4842.176829938849, 4843.176659967743, 4848.8302909398, 4850.757462126809, 4854.247591623162, 4861.732604706775, 4923.0, 4691.249400095969, 4719.032598317405, 4733.573978341966, 4742.88142796419, 4759.881002974953, 4767.0, 4767.856964291077, 4768.380110585602, 4816.662833601615, 4822.180229361087, 4694.084653492673, 4708.128996135726, 4710.528947105399, 4758.095961767253, 4761.642876784185, 4706.411698537683, 4754.809807607657, 4790.209615413418, 4791.880202994953, 4793.113274044313, 4651.604613607746, 4654.697444666086, 4685.789139488799, 4690.226112691368, 4748.857534273978], "value": 4533.694490487273, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.492094575355, 576.3947854752508, 577.428345937522, 578.6238944685956, 580.9716801261768, 27192.59211111835, 42447.78776106119, 43743.56256437435, 43888.0, 43940.560594394046, 39277.0, 39654.0, 39656.0, 39676.206475870466, 39710.0, 7524.73663421779, 7667.693292268303, 7675.692972281102, 7676.961615191916, 7678.731244406447, 7536.811579710524, 7607.125180604246, 7632.160462349138, 7634.961825190866, 7638.427117966147, 7621.847563048764, 7657.310842024217, 7659.731909383145, 7659.923400766004, 7678.7696369108735, 7576.393888488935, 7594.734184303523, 7598.164201937782, 7608.885866712004, 7623.809404764897, 7618.352440042603, 7683.423743219281, 7687.2697093776005, 7690.692372305101, 7695.192004839523, 37546.0, 37958.43062354067, 37968.0, 37974.240515189544, 38000.80999594984, 3010.8795648174046, 3154.1168472827644, 3156.542301366289, 3276.3774882772195, 3549.378858699717, 27354.316142096406, 27885.58171627427, 27986.0, 28060.579091313648, 29092.709072909212, 3486.1981744198974, 3534.3991521441417, 3545.0782796473104, 3553.9111522211892, 3661.6155303692994, 252379.0, 252940.0, 253618.0, 254076.0, 254702.0, 30360.392792144034, 51486.0, 51758.74120629373, 51772.74113629408, 51841.48158518442, 31535.526967095513, 33562.0, 33711.15722106967, 33719.0, 33734.0, 12290.569830055905, 12412.689682757822, 12427.565035223724, 12427.93786031064, 12433.254004759743, 9874.950625246971, 9932.652357167464, 9953.502324883726, 9962.203023758082, 9969.501524923724, 7837.747334855971, 7855.13593504714, 7884.093329267208, 7970.481918675384, 7971.202879712098, 3082.4143412751505, 3093.273080826004, 3124.906252812419, 3143.1984843864666, 3159.3997140543224, 817.8486979908736, 871.1593312453513, 942.1406032690751, 984.7341217871278, 997.4165113408737, 26997.86501067482, 27461.45077098487, 27862.0, 28084.71915280862, 28365.0, 891.6567121658079, 928.3223247029706, 939.248601119102, 957.7892863570004, 970.5438443931341, 13438.664033399244, 13713.59706784599, 13742.244176570184, 13850.307484625728, 13877.236751978537, 368270.0, 368570.0, 369789.0, 370604.0, 370921.0, 48005.279920801215, 48564.0, 48571.0, 48649.513504864495, 48656.27015594769, 1048.4652827058255, 1107.5293000474767, 1155.1221071985183, 1179.168686076314, 1204.897583705395, 26158.86920565385, 28525.857370713013, 28955.855220724603, 29400.55899161557, 29453.558196627495, 40527.163098582816, 41052.79473602613, 41077.79461102675, 41109.794451027556, 41184.38223426711, 308191.0, 310893.0, 311150.0, 311315.0, 311340.0, 21562.78437215608, 22157.667634985166, 25023.249302520955, 38172.80913595414, 39365.0, 37785.0, 41007.38488922728, 41558.79220603878, 42113.57886421219, 42608.78695606502, 34948.825255873555, 35663.64336356603, 35983.64016359803, 36186.0, 36392.0, 35787.28425431529, 35886.28227435489, 35994.46008309825, 36664.26671466609, 36767.264654707295, 34968.82515587406, 35314.293714126085, 35454.290914182086, 35469.29061418809, 35545.644543554234, 31108.222294441915, 32414.51378229281, 32848.1787955303, 32874.50688239631, 32896.342073158885, 24713.135040273504, 24924.37689057788, 24945.50108997846, 25159.24522264335, 25184.668989547037], "value": 16247.549884163287, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.23554792914763, 349.9160201551627, 351.8645321551203, 355.2557392263208, 383.4363485676057, 12182.939085304572, 15651.373945042198, 15875.364985400585, 17655.91172044141, 17876.82123178768, 15890.205489725526, 15904.84095159048, 16928.83071169288, 17001.48995530133, 17379.0, 4948.406191257054, 4980.526849949258, 5081.517255860687, 5121.180611102224, 5210.452902445246, 3663.8717644882436, 3855.556610989744, 5041.344625198719, 5122.8207012754565, 5130.486951304858, 3834.022324307298, 3878.9806050969705, 3891.8443262269475, 3892.8637497687587, 4470.552944705536, 5945.019071853139, 6049.122877182828, 6051.697415129248, 6060.181875446802, 6060.575759696823, 4686.390769200017, 4978.054169707744, 5001.649884508086, 5285.920711189336, 5289.391719952217, 12146.271223726517, 12303.0, 12362.134650574373, 12402.379881006003, 18807.717884231748, 1858.0616788521845, 1901.895395753233, 1916.6741653918866, 1934.0, 1940.8156225158586, 8816.294696424271, 9165.816683666357, 9308.813823723487, 9659.517024148765, 9752.609895604168, 1552.208373729395, 1612.5887898585902, 1613.185341402584, 1675.9748603770831, 1695.0677127579904, 67114.66442667755, 68553.3144668552, 69923.65038174827, 70000.6499967497, 71249.9312510318, 9776.560054797552, 9799.0, 10343.27597068213, 10697.197710171613, 10751.78496430067, 13442.46230150783, 13452.865471345356, 13478.25869577163, 13498.0, 13499.190048597116, 6768.763093291711, 6770.458363330922, 6802.285759995129, 7046.401055910203, 7078.079849619517, 6237.500999919996, 6397.936020639827, 6448.161738973903, 6505.0, 6523.804285871432, 4234.237837189336, 4252.532221455637, 4276.123394704078, 4276.80754366048, 4362.709577471853, 1742.4249997500795, 1748.0, 1792.7490151378818, 1793.2916497983224, 1802.5493626593352, 816.6651672814118, 818.2145140665028, 826.5371392020488, 828.7389472316202, 902.7201567513961, 16030.599235018984, 16110.113943732973, 16520.00879947207, 17600.119994000248, 17740.733888991675, 844.1642773654038, 860.3977215948861, 881.8456770065342, 895.6909866096187, 906.465185540521, 9067.455952642862, 9769.609215631295, 9830.213582913493, 9842.720446342073, 9873.0, 361469.0, 365005.0, 368934.0, 374702.0, 376079.0, 80113.59943200246, 80481.59759201284, 80504.19495805084, 80549.0, 80801.0, 906.918377346042, 916.2852974679761, 941.091846368258, 949.4777872170279, 950.1686024728363, 15065.849341506444, 15140.621484462976, 15503.379864805282, 15550.37798488093, 15739.606509837346, 29325.0, 36269.0, 36583.0, 37520.0, 39278.6072139275, 45187.0, 46807.76596116998, 48287.5171248283, 56417.43582564286, 56886.7155664219, 4636.559526844944, 4720.5043470436485, 4822.5887056471765, 6424.196975378078, 7009.859802803813, 9684.46735429558, 11352.262102963281, 11528.884711152781, 11761.47073381717, 11800.291982481078, 9823.312368134162, 10416.1667066636, 10530.31552949056, 10538.525766340686, 10790.931939579588, 8543.444676096035, 9838.655647052605, 10237.590496380062, 10265.435401053013, 10632.574697012342, 9427.198688111588, 9718.514074296398, 9831.262655300738, 9899.059589339002, 9984.101430871257, 7083.610401427971, 7153.964230178815, 7238.674259658223, 7362.263773622595, 7490.0, 9314.860277095984, 9696.175825054666, 9697.272704547328, 9886.060824221688, 10035.297529172887], "value": 7811.899612255317, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1187.2935603316023, 1343.8723321284479, 1400.754867898118, 1414.9434022639095, 1673.4728560503434, 6742.426893714034, 7078.929210707892, 7390.224026477216, 7390.852182956338, 7621.275978782007, 7437.590932498711, 7502.774916752493, 7503.13713922899, 7509.737159199429, 7511.023566936305, 2093.27781915239, 2107.95784084319, 2108.9578208435823, 2112.4930016795934, 2121.673953778888, 2080.157536197842, 2127.0747224957195, 2134.3703607435764, 2136.134865379524, 2137.8396620253466, 2084.4997200671883, 2090.4460318015663, 2101.4116047506645, 2101.443117573844, 2131.3392848217104, 2042.3872838148645, 2047.2118234479683, 2058.3927741316347, 2059.3821853443906, 2065.607534568435, 2006.56858775364, 2020.3029954665617, 2043.039771307483, 2050.2721533855415, 2051.8974051297378, 7634.809129771745, 7676.46264761467, 7784.221577842227, 7805.9609701951695, 7812.492188007761, 4458.487273963503, 4665.113628410591, 4694.08465349257, 4697.577218050392, 4712.764361781898, 2830.5188118019987, 2976.627921509811, 3012.653544842349, 3037.58992536007, 3040.5743195952587, 905.0994260710635, 913.5112714697605, 927.193341792638, 927.8330098625603, 936.2089034765612, 10642.308249963728, 10685.145188384988, 10698.090662293793, 10767.3539587625, 10773.084287835543, 3836.5396152461885, 3869.9806500967316, 3956.22853543562, 3961.960380396159, 3974.2448934702315, 8430.072692003874, 8495.490270583661, 8507.659693612186, 8517.361197910057, 8517.829643407098, 4454.57681520255, 4457.2199865023495, 4461.219286624828, 4461.888452788707, 4462.263726485158, 3458.688718015391, 3564.6435356464663, 4077.938830917539, 4081.306177949696, 4091.7749523775883, 3193.6007999000126, 3237.093613788143, 3308.7849289796086, 3327.600687917417, 3345.481450375196, 973.522973742875, 994.4083270454068, 998.8912307338848, 1000.8448690452991, 1014.9086582207636, 700.7792545348199, 708.553611224925, 727.6143643868758, 848.1433751910491, 852.5481494807761, 5261.394939581921, 5363.410024897258, 5474.644148130359, 5585.972070139624, 5592.412796656374, 791.5013541468837, 813.515958004986, 828.9088200297963, 844.957752112392, 922.3958307308724, 3312.7184189344175, 3553.9822300888845, 3627.111357717376, 3639.94540081899, 3729.7948612826553, 9253.537323133816, 9700.466474343837, 9722.125008749246, 9728.513574321256, 9768.413895166314, 9689.660861869801, 9701.805963880683, 9706.126448619658, 9710.465924374086, 9719.222462203006, 7189.424846012306, 7209.639518024078, 7249.7462588810195, 7341.082364704412, 7351.44864135192, 5189.429162792166, 5211.713355765318, 5326.041312563776, 5329.147336426308, 5382.0, 8695.217430431292, 8788.945326560854, 8926.509042002752, 8929.553522323728, 8955.910440895508, 8553.486790792573, 8606.139386061344, 8616.138386161334, 8900.109989001307, 9038.186563209343, 5817.214676018683, 6297.055441683784, 6408.263049749338, 6416.390442907917, 6416.839579010375, 6791.966040169767, 7333.230010848997, 7575.924240757742, 7625.466217364731, 7628.466007379652, 6572.7042283098335, 6672.232693240339, 6689.5986240825705, 6863.862722745617, 6933.826654333682, 6526.24948130971, 6640.9335906642245, 6741.966290168518, 6770.086038384952, 6780.898286525805, 6202.968985155046, 6294.874102518015, 6305.054241863757, 6306.590071645328, 6311.463525600376, 4381.67137464685, 4448.288273876165, 4511.8646440606835, 4549.863504094882, 4600.079984003146, 4425.291953287458, 4481.439820022497, 4538.387317712067, 4582.19811532987, 4641.930371044369], "value": 4018.8753460497182, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.5845299674462, 296.9346743716383, 300.0862374070954, 300.8991987684126, 302.8985289927874, 4604.240300350442, 4616.353710480531, 4622.676412651112, 4631.536846315366, 4674.083625713458, 4576.5652263035045, 4591.357209990596, 4596.839110631128, 4598.747068911209, 4601.171789077965, 3453.8273086345644, 3515.367233897897, 3558.1638314996085, 3633.1462106404974, 3658.567052909812, 3658.981705091484, 3660.2313514162056, 3663.3222853772136, 3696.4270538066507, 3698.2973235085383, 3618.945715814252, 3647.781133132007, 3652.086978255436, 3666.4500324951337, 3687.815609219542, 3454.758166928316, 3526.823658817049, 3567.714582833367, 3640.3083414151492, 3657.9268414631824, 3213.4537128687944, 3218.8090406549727, 3224.6782316731915, 3225.822579758112, 3242.8864989725485, 4506.301523263899, 4522.344260082303, 4529.4791099023705, 4532.773361331921, 4570.154521413516, 3903.765774053566, 4134.875953721393, 4155.459790227282, 4168.645665118469, 4179.2059508693255, 4862.541237628698, 4866.46468888422, 4867.902641947141, 4882.609391248727, 4910.37295047148, 3480.120734803203, 3482.945062413163, 3485.2506711057245, 3486.3724529584665, 3494.8602055917986, 5006.774695138727, 5122.359705036871, 5149.6910185389, 5157.369741431859, 5158.896822063575, 3463.930721385558, 3484.8954531364097, 3485.6165821759587, 3503.4219353806848, 3506.9123271917897, 3542.982285088558, 3548.929021419609, 3568.5360903082433, 3568.964310356915, 3581.9641803582153, 4069.1658210066867, 4076.9184616307507, 4098.6516146127915, 4120.649744771728, 4124.422580838685, 4716.217431715305, 4858.246971719389, 4937.0624478435275, 4943.332650092263, 4944.898418172263, 1214.2350319298962, 1225.8048402807192, 1232.9568465103678, 1233.4018001269378, 1237.2329155923385, 784.7959530521991, 791.9032140485353, 803.8311954489506, 811.338758911497, 812.1147948735907, 4112.753234805921, 4250.086231460189, 4254.255505286563, 4261.595148460891, 4267.743935363888, 4878.341423907798, 4952.192449755813, 5031.4465408805, 5040.647154699136, 5056.84829455117, 4297.205017071852, 4298.26929421999, 4301.2257793597455, 4308.827646894152, 4338.349247612883, 2558.6929568451906, 2629.1061039246747, 2649.6555447791666, 2674.424998625305, 2680.517506848747, 4791.736454495036, 4807.927881081787, 4815.518448155157, 4815.544072522968, 4833.589144922651, 5134.897302053938, 5152.711822044489, 5155.6391052626705, 5161.251618515369, 5165.9741701292005, 4639.30410438437, 4791.496892826272, 4820.168336032285, 4827.782749776268, 4849.951500485021, 5031.798728050837, 5034.546890779848, 5048.646594738333, 5051.141305978066, 5053.519915608012, 4961.5534601886, 4990.802207470108, 4992.600591952708, 4999.900002000012, 5000.949990500194, 4619.630429565559, 4819.903601928012, 4849.442314133919, 4860.392450943632, 4873.439554451284, 3553.076200187918, 3574.588922273868, 3574.982125089358, 3597.298526787356, 3599.262151259038, 5056.797728090835, 5086.771095300646, 5086.872828179177, 5096.388433388017, 5098.566621837185, 4815.927761083657, 4868.77177078051, 4893.266010098514, 4907.214845624683, 4926.802927882844, 4848.80604775805, 4880.41435027799, 4886.0, 4891.559759621651, 4898.8775280618265, 4800.783964721666, 4820.662553621213, 4864.537868902448, 4867.7322747249245, 4888.828890988798, 4676.46220684612, 4684.704494797593, 4831.613470922388, 4929.383827021622, 4971.577415919543, 4602.838900638461, 4754.120487709784, 4770.260609605517, 4777.737224452689, 4791.669789496266], "value": 3678.0982444648434, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.6639181646002, 639.7536948274912, 668.8996650502421, 723.508014550106, 737.3032484302333, 12679.556215532459, 13852.168869867815, 13911.0, 13952.58142255734, 13977.23125228112, 13253.933730331335, 13368.53210137643, 13389.129706569067, 13464.596062118128, 13478.123921945067, 603.3664652115283, 618.2673531864732, 741.6959046790817, 742.9591372474512, 756.7124492692769, 761.1399118995555, 763.1262204775529, 763.4045444553258, 763.4236151705483, 763.6105586151075, 807.4953154278576, 809.3201710563126, 811.2536466450879, 812.10262659761, 812.5124925044955, 618.298231507238, 635.3963734452266, 769.5575044349465, 795.6181033104084, 798.3892322373389, 579.2585490572075, 580.9941900580982, 581.8167277307634, 583.1107560969513, 585.2041223935487, 12255.1421400502, 12269.69325766863, 12276.693082673004, 12281.324527151002, 12285.262884226975, 12982.740345193044, 13405.597832065054, 13652.112612680145, 13684.315784210849, 13898.900747811029, 10319.84520232197, 10755.677329680122, 10774.515146818334, 10836.241463097585, 11040.613578524793, 3339.7495187860764, 3357.0768038789283, 3400.302937897725, 3416.7266618670446, 3495.038864312334, 63271.36728632701, 63331.36668633301, 63918.36081639171, 64034.0, 64474.0, 10411.635592754368, 10451.895481045092, 10481.947590262, 10736.946315268373, 10895.945520272506, 17010.659786804194, 17764.3123903229, 17855.464336069937, 18512.07439628013, 18636.906815465834, 6908.723651053901, 6908.827279317957, 7020.7542736004, 7086.893696594555, 7244.746433874789, 3452.413089774694, 3475.8783442579893, 3497.45789402643, 3569.696575791087, 3652.8457582655014, 2923.6199294092057, 3019.139545229599, 3039.0, 3041.832699201521, 3044.25415773137, 498.20536244690385, 500.52700198312243, 506.8023470846373, 507.7283653245496, 511.98720031998755, 459.55423239457673, 592.3720855892767, 594.8750762339957, 607.2166904692984, 621.1490258346095, 9412.0, 9707.0, 9900.306978511579, 9960.850587241197, 10071.546780394754, 565.9745311460912, 590.8611476303065, 596.1356033751078, 599.5593238969354, 628.940250676185, 4080.836766529365, 4130.277201489727, 4252.808623611945, 4311.784410779448, 4364.454443194601, 60370.0, 87299.56350218208, 91820.54089729642, 92155.0, 92421.53789231011, 74179.62910185523, 75820.62089689517, 76901.61549192331, 78949.60525197338, 81235.59382203169, 64056.67971660112, 67077.66461167761, 68449.65775171093, 69061.65469172622, 69828.65085674539, 7452.366548843409, 7561.3194812467145, 7640.961795190989, 7895.210478952059, 7942.44402891792, 40804.59195408127, 41702.37446438367, 42088.36867447052, 42148.1570368597, 42891.0, 51984.220236697234, 58600.4139958595, 58872.705636471546, 60391.39608604033, 60829.39170608237, 10040.347377420445, 10222.437765922945, 10234.744131396774, 10242.846357304796, 10665.89334106649, 10913.290636108628, 11061.557537698402, 11137.777244455228, 11839.342492051292, 12103.576374826838, 10377.9481102594, 10730.73173170677, 10883.23817332779, 11079.50142243585, 11432.0, 9921.851172232278, 10102.747431314276, 10362.378257304284, 10585.735356615838, 10826.13390928708, 10297.330673506198, 10413.375197488174, 10481.42352170638, 10671.35971841692, 10936.671899843017, 8576.185262400062, 8724.651013959625, 9094.0, 9214.815703685754, 9342.579583918605, 7954.244346787046, 8656.0, 8760.386772925835, 9395.151659899646, 9436.85844712316], "value": 6357.894757811881, "unit": "score"}], "name": "dromaeo_css", "value": 6149.613195812356, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 115.0, 114.0, 115.0, 115.0, 114.0, 114.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 133.0, 130.0, 168.0, 127.0, 127.0, 128.0, 134.0, 169.0, 132.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 171.0, 161.0, 161.0, 162.0, 164.0, 165.0, 163.0, 163.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 112.0, 77.0, 76.0, 77.0, 76.0, 105.0, 78.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 136.0, 83.0, 83.0, 82.0, 105.0, 83.0, 82.0, 117.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 147.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 63.0, 65.0, 65.0, 66.0, 74.0, 66.0, 66.0, 65.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 68.0, 67.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 92.0, 87.0, 83.0, 83.0, 83.0, 92.0, 83.0, 83.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 142.0, 140.0, 140.0, 140.0, 139.0, 140.0, 139.0, 184.0, 149.0], "value": 146.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 179.0, 189.0, 178.0, 175.0, 178.0, 174.0, 176.0, 174.0, 174.0], "value": 178.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 71.0, 71.0, 70.0, 70.0, 75.0, 70.0, 69.0, 70.0, 71.0], "value": 71.6, "unit": "score"}], "name": "kraken", "value": 1567.6000000000001, "alertThreshold": 2.0}]} 22:39:39 INFO - Return code: 0 22:39:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:39:39 INFO - # TBPL SUCCESS # 22:39:39 INFO - Running post-action listener: _resource_record_post_action 22:39:39 INFO - [mozharness: 2016-10-05 05:39:39.575205Z] Finished run-tests step (success) 22:39:39 INFO - Running post-run listener: _resource_record_post_run 22:39:39 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407420928; Read time: 12; Write time: 248300 22:39:39 INFO - TinderboxPrint: CPU usage
13.0% 22:39:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 22:39:39 INFO - TinderboxPrint: I/O write bytes / time
407,420,928 / 248,300 22:39:39 INFO - TinderboxPrint: CPU idle
8,356.2 (87.0%) 22:39:39 INFO - TinderboxPrint: CPU user
1,202.4 (12.5%) 22:39:39 INFO - TinderboxPrint: Swap in / out
0 / 0 22:39:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115994624; Read time: 0; Write time: 69260 22:39:39 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290521088; Read time: 12; Write time: 179016 22:39:40 INFO - Running post-run listener: _upload_blobber_files 22:39:40 INFO - Blob upload gear active. 22:39:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:39:40 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 22:39:40 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:39:40 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:39:40 INFO - (blobuploader) - INFO - Open directory for files ... 22:39:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:39:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:39:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:39:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:39:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:39:41 INFO - (blobuploader) - INFO - Done attempting. 22:39:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:39:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:39:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:39:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:39:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:39:42 INFO - (blobuploader) - INFO - Done attempting. 22:39:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:39:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:39:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:39:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:39:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:39:45 INFO - (blobuploader) - INFO - Done attempting. 22:39:45 INFO - (blobuploader) - INFO - Iteration through files over. 22:39:45 INFO - Return code: 0 22:39:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:39:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:39:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3da802e43cdaa8155662db1745b6801f60c3882576961e4437727352ec2d6cbcaa7f91a0ea336f9ad52699bef33880cb9a9a1a9cc57b05ca422c2af1c7732dae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/998a3eb43bbcc65aba4043e6438ca90973baa13e0d4950f126bc350d72079b4e0337bea85b4dfa8c4718040de88e2478af48867e9d28413d738bc80bad8c584c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a8bcde0bab21dca9455d6856ec88ee178c643433428d10408f33c28d1c145bd2524a264dec7fedac542ab3b250e6b3eda7451d382758fcacdfc3e7ef461cef04"} 22:39:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:39:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:39:45 INFO - Contents: 22:39:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3da802e43cdaa8155662db1745b6801f60c3882576961e4437727352ec2d6cbcaa7f91a0ea336f9ad52699bef33880cb9a9a1a9cc57b05ca422c2af1c7732dae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/998a3eb43bbcc65aba4043e6438ca90973baa13e0d4950f126bc350d72079b4e0337bea85b4dfa8c4718040de88e2478af48867e9d28413d738bc80bad8c584c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a8bcde0bab21dca9455d6856ec88ee178c643433428d10408f33c28d1c145bd2524a264dec7fedac542ab3b250e6b3eda7451d382758fcacdfc3e7ef461cef04"} 22:39:45 INFO - Running post-run listener: copy_logs_to_upload_dir 22:39:45 INFO - Copying logs to upload dir... 22:39:45 INFO - mkdir: /builds/slave/test/build/upload/logs 22:39:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.928750 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-04 22:39:45.424887) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 22:39:45.428233) ========= 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=db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3da802e43cdaa8155662db1745b6801f60c3882576961e4437727352ec2d6cbcaa7f91a0ea336f9ad52699bef33880cb9a9a1a9cc57b05ca422c2af1c7732dae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/998a3eb43bbcc65aba4043e6438ca90973baa13e0d4950f126bc350d72079b4e0337bea85b4dfa8c4718040de88e2478af48867e9d28413d738bc80bad8c584c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a8bcde0bab21dca9455d6856ec88ee178c643433428d10408f33c28d1c145bd2524a264dec7fedac542ab3b250e6b3eda7451d382758fcacdfc3e7ef461cef04"} build_url:https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011424 build_url: 'https://queue.taskcluster.net/v1/task/ehuInRqrRWGXt99-IrdjNg/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/Autoland-Non-PGO/sha512/3da802e43cdaa8155662db1745b6801f60c3882576961e4437727352ec2d6cbcaa7f91a0ea336f9ad52699bef33880cb9a9a1a9cc57b05ca422c2af1c7732dae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/998a3eb43bbcc65aba4043e6438ca90973baa13e0d4950f126bc350d72079b4e0337bea85b4dfa8c4718040de88e2478af48867e9d28413d738bc80bad8c584c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a8bcde0bab21dca9455d6856ec88ee178c643433428d10408f33c28d1c145bd2524a264dec7fedac542ab3b250e6b3eda7451d382758fcacdfc3e7ef461cef04"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 22:39:45.454231) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 22:39:45.454591) ========= 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=db7e7c15f3ca076d53731445000001ba-1475643032.811975-519439898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 22:39:45.537714) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 22:39:45.538055) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 22:39:45.538411) ========= ========= Total master_lag: 0.37 =========