builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1475184618.14 results: success (0) buildid: 20160929141519 builduid: 14f2a8dc16064473b3555ee25fc915d4 revision: 7de011ec6e45a2e5019ecae87acacb8bb2a8f381 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 14:30:18.138516) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 14:30:18.138979) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 14:30:18.139293) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 14:30:18.161049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 14:30:18.161355) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-29 14:30:18-- 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% 22.1M=0.001s 2016-09-29 14:30:18 (22.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 14:30:18.277503) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 14:30:18.277868) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018640 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 14:30:18.327586) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 14:30:18.328001) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 7de011ec6e45a2e5019ecae87acacb8bb2a8f381 --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 7de011ec6e45a2e5019ecae87acacb8bb2a8f381 --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=516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-29 14:30:19,037 truncating revision to first 12 chars 2016-09-29 14:30:19,037 Setting DEBUG logging. 2016-09-29 14:30:19,037 attempt 1/10 2016-09-29 14:30:19,037 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/7de011ec6e45?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 14:30:19,919 unpacking tar archive at: autoland-7de011ec6e45/testing/mozharness/ program finished with exit code 0 elapsedTime=1.215489 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 14:30:19.560577) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 14:30:19.560951) ========= script_repo_revision: 7de011ec6e45a2e5019ecae87acacb8bb2a8f381 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 14:30:19.561404) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 14:30:19.561732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 14:30:19.572588) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-29 14:30:19.572994) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:30:20 INFO - MultiFileLogger online at 20160929 14:30:20 in /builds/slave/test 14:30:20 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 14:30:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:30:20 INFO - {'append_to_log': False, 14:30:20 INFO - 'base_work_dir': '/builds/slave/test', 14:30:20 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 14:30:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:30:20 INFO - 'branch': 'Autoland-Non-PGO', 14:30:20 INFO - 'buildbot_json_path': 'buildprops.json', 14:30:20 INFO - 'config_files': ('talos/linux_config.py',), 14:30:20 INFO - 'default_actions': ('clobber', 14:30:20 INFO - 'read-buildbot-config', 14:30:20 INFO - 'download-and-extract', 14:30:20 INFO - 'populate-webroot', 14:30:20 INFO - 'create-virtualenv', 14:30:20 INFO - 'install', 14:30:20 INFO - 'run-tests'), 14:30:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:30:20 INFO - 'download_minidump_stackwalk': True, 14:30:20 INFO - 'download_symbols': 'ondemand', 14:30:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:30:20 INFO - 'tooltool.py': '/tools/tooltool.py', 14:30:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:30:20 INFO - '/tools/misc-python/virtualenv.py')}, 14:30:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:30:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:30:20 INFO - 'installer_path': 'installer.exe', 14:30:20 INFO - 'log_level': 'info', 14:30:20 INFO - 'log_name': 'talos', 14:30:20 INFO - 'log_to_console': True, 14:30:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:30:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:30:20 INFO - 'opt_config_files': (), 14:30:20 INFO - 'pip_index': False, 14:30:20 INFO - 'sps_profile': False, 14:30:20 INFO - 'sps_profile_interval': 0, 14:30:20 INFO - 'suite': 'dromaeojs', 14:30:20 INFO - 'system_bits': '32', 14:30:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:30:20 INFO - 'title': 'talos-linux64-ix-061', 14:30:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:30:20 INFO - 'use_talos_json': True, 14:30:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:30:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:30:20 INFO - 'work_dir': 'build'} 14:30:20 INFO - [mozharness: 2016-09-29 21:30:20.379295Z] Running clobber step. 14:30:20 INFO - Running pre-action listener: _resource_record_pre_action 14:30:20 INFO - Running main action method: clobber 14:30:20 INFO - rmtree: /builds/slave/test/build 14:30:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:30:20 INFO - Running post-action listener: _resource_record_post_action 14:30:20 INFO - [mozharness: 2016-09-29 21:30:20.839968Z] Finished clobber step (success) 14:30:20 INFO - [mozharness: 2016-09-29 21:30:20.840068Z] Running read-buildbot-config step. 14:30:20 INFO - Running pre-action listener: _resource_record_pre_action 14:30:20 INFO - Running main action method: read_buildbot_config 14:30:20 INFO - Using buildbot properties: 14:30:20 INFO - { 14:30:20 INFO - "project": "", 14:30:20 INFO - "product": "firefox", 14:30:20 INFO - "script_repo_revision": "production", 14:30:20 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 14:30:20 INFO - "repository": "", 14:30:20 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 14:30:20 INFO - "buildid": "20160929141519", 14:30:20 INFO - "pgo_build": "False", 14:30:20 INFO - "basedir": "/builds/slave/test", 14:30:20 INFO - "buildnumber": 675, 14:30:20 INFO - "slavename": "talos-linux64-ix-061", 14:30:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:30:20 INFO - "platform": "ubuntu64_hw", 14:30:20 INFO - "scheduler": "tests-autoland-linux64-talos", 14:30:20 INFO - "branch": "autoland", 14:30:20 INFO - "repo_path": "integration/autoland", 14:30:20 INFO - "revision": "7de011ec6e45a2e5019ecae87acacb8bb2a8f381", 14:30:20 INFO - "stage_platform": "linux64", 14:30:20 INFO - "builduid": "14f2a8dc16064473b3555ee25fc915d4", 14:30:20 INFO - "slavebuilddir": "test" 14:30:20 INFO - } 14:30:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 14:30:20 INFO - Running post-action listener: _resource_record_post_action 14:30:20 INFO - [mozharness: 2016-09-29 21:30:20.842492Z] Finished read-buildbot-config step (success) 14:30:20 INFO - [mozharness: 2016-09-29 21:30:20.842581Z] Running download-and-extract step. 14:30:20 INFO - Running pre-action listener: _resource_record_pre_action 14:30:20 INFO - Running main action method: download_and_extract 14:30:20 INFO - mkdir: /builds/slave/test/build/tests 14:30: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')]} 14:30:20 INFO - trying https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:30:20 INFO - Downloading https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/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 14:30:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/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 14:30:21 INFO - Downloaded 1361 bytes. 14:30:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:30:21 INFO - Using the following test package requirements: 14:30:21 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:30:21 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:30:21 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:30:21 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:21 INFO - u'jsshell-linux-x86_64.zip'], 14:30:21 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:30:21 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:30:21 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:30:21 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:30:21 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:30:21 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:30:21 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:30:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:30:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:30:21 INFO - Fetch https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:30:21 INFO - Http code: 200 14:30:21 INFO - Content-Encoding: None 14:30:21 INFO - Content-Type: application/zip 14:30:21 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 14:30:21 INFO - x-amz-cf-id: gO2MqwVSKkPidHfZE9yXhILX-85fk3fTmInwFgXtyJyZM_zHMFUCKQ== 14:30:21 INFO - x-amz-version-id: ovunQfjQq0ekyCnDtLI687MvWyefZXiu 14:30:21 INFO - x-cache: Hit from cloudfront 14:30:22 INFO - Expected file size: 20418097 14:30:22 INFO - Obtained file size: 20418097 14:30:26 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 14:30:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:30:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:30:26 INFO - Fetch https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:30:26 INFO - Http code: 200 14:30:26 INFO - Content-Encoding: None 14:30:26 INFO - Content-Type: application/zip 14:30:26 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 14:30:26 INFO - x-amz-cf-id: 6uKUVgGxvJW6U_WivILxUW-xXFn5MMP32xFpeKFUkch12XyRuDQYmQ== 14:30:26 INFO - x-amz-version-id: ovunQfjQq0ekyCnDtLI687MvWyefZXiu 14:30:26 INFO - x-cache: Hit from cloudfront 14:30:27 INFO - Expected file size: 20418097 14:30:27 INFO - Obtained file size: 20418097 14:30:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 14:30:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:30:31 INFO - Fetch https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:30:32 INFO - Http code: 200 14:30:32 INFO - Content-Encoding: None 14:30:32 INFO - Content-Type: application/zip 14:30:32 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 14:30:32 INFO - x-amz-cf-id: aIX_EyJqkzwuneBw-s1EgWCwhVLXRZN72GCTH7TbbrNfJ0XTmhGBXA== 14:30:32 INFO - x-amz-version-id: 6Lq6JfQVg8ERFj3nfdWPddeZeps9zZXT 14:30:32 INFO - x-cache: Hit from cloudfront 14:30:32 INFO - Expected file size: 14414067 14:30:32 INFO - Obtained file size: 14414067 14:30:33 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')]} 14:30:33 INFO - trying https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:30:33 INFO - Downloading https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/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 14:30:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/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 14:30:34 INFO - Downloaded 55741929 bytes. 14:30:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:30:34 INFO - mkdir: /builds/slave/test/properties 14:30:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:30:34 INFO - Writing to file /builds/slave/test/properties/build_url 14:30:34 INFO - Contents: 14:30:34 INFO - build_url:https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:30:34 INFO - Running post-action listener: _resource_record_post_action 14:30:34 INFO - Running post-action listener: set_extra_try_arguments 14:30:34 INFO - [mozharness: 2016-09-29 21:30:34.858008Z] Finished download-and-extract step (success) 14:30:34 INFO - [mozharness: 2016-09-29 21:30:34.858233Z] Running populate-webroot step. 14:30:34 INFO - Running pre-action listener: _resource_record_pre_action 14:30:34 INFO - Running main action method: populate_webroot 14:30:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:30:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:30:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:30:34 INFO - '--tppagecycles', 14:30:34 INFO - '7'], 14:30:34 INFO - 'tests': ['tsvgm']}}, 14:30:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:30:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:30:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:30:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:30:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:30:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:30:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:34 INFO - 'talos_options': ['--disable-e10s'], 14:30:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:30:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:30:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:34 INFO - 'talos_options': ['--disable-e10s'], 14:30:34 INFO - 'tests': ['damp', 'tps']}, 14:30:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:34 INFO - 'tests': ['damp', 'tps']}, 14:30:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:30:34 INFO - 'tests': ['dromaeo_dom']}, 14:30:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:30:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:30:34 INFO - 'tests': ['basic_compositor_video']}, 14:30:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:30:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:30:34 INFO - 'tests': ['a11yr', 14:30:34 INFO - 'ts_paint', 14:30:34 INFO - 'tpaint', 14:30:34 INFO - 'sessionrestore', 14:30:34 INFO - 'sessionrestore_no_auto_restore', 14:30:34 INFO - 'tabpaint']}, 14:30:34 INFO - 'other-e10s': {'tests': ['a11yr', 14:30:34 INFO - 'ts_paint', 14:30:34 INFO - 'tpaint', 14:30:34 INFO - 'sessionrestore', 14:30:34 INFO - 'sessionrestore_no_auto_restore', 14:30:34 INFO - 'tabpaint']}, 14:30:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:30:34 INFO - 'ts_paint', 14:30:34 INFO - 'tpaint', 14:30:34 INFO - 'sessionrestore', 14:30:34 INFO - 'sessionrestore_no_auto_restore', 14:30:34 INFO - 'tabpaint']}, 14:30:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:30:34 INFO - 'ts_paint', 14:30:34 INFO - 'tpaint', 14:30:34 INFO - 'sessionrestore', 14:30:34 INFO - 'sessionrestore_no_auto_restore', 14:30:34 INFO - 'tabpaint']}, 14:30:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:30:34 INFO - 'tests': ['a11yr', 14:30:34 INFO - 'ts_paint', 14:30:34 INFO - 'tpaint', 14:30:34 INFO - 'sessionrestore', 14:30:34 INFO - 'sessionrestore_no_auto_restore', 14:30:34 INFO - 'tabpaint']}, 14:30:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:30:34 INFO - 'tests': ['a11yr', 14:30:34 INFO - 'ts_paint', 14:30:34 INFO - 'tpaint', 14:30:34 INFO - 'sessionrestore', 14:30:34 INFO - 'sessionrestore_no_auto_restore', 14:30:34 INFO - 'tabpaint']}, 14:30:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:30:34 INFO - 'tests': ['tsvgx', 14:30:34 INFO - 'tsvgr_opacity', 14:30:34 INFO - 'tart', 14:30:34 INFO - 'tscrollx', 14:30:34 INFO - 'cart']}, 14:30:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:30:34 INFO - 'tsvgr_opacity', 14:30:34 INFO - 'tart', 14:30:34 INFO - 'tscrollx', 14:30:34 INFO - 'cart']}, 14:30:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:34 INFO - 'talos_options': ['--disable-e10s'], 14:30:34 INFO - 'tests': ['tp5o']}, 14:30:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:34 INFO - 'tests': ['tp5o']}, 14:30:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:34 INFO - 'talos_options': ['--disable-e10s', 14:30:34 INFO - '--xperf_path', 14:30:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:30:34 INFO - 'tests': ['tp5n']}, 14:30:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:34 INFO - 'talos_options': ['--xperf_path', 14:30:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:30:34 INFO - 'tests': ['tp5n']}}, 14:30:34 INFO - 'talos.zip': {'path': '', 14:30:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:30:34 INFO - Running post-action listener: _resource_record_post_action 14:30:34 INFO - [mozharness: 2016-09-29 21:30:34.880296Z] Finished populate-webroot step (success) 14:30:34 INFO - [mozharness: 2016-09-29 21:30:34.880385Z] Running create-virtualenv step. 14:30:34 INFO - Running pre-action listener: _resource_record_pre_action 14:30:34 INFO - Running main action method: create_virtualenv 14:30:34 INFO - Creating virtualenv /builds/slave/test/build/venv 14:30:34 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 14:30:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:30:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:30:34 INFO - Using real prefix '/usr' 14:30:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:30:35 INFO - Installing distribute.............................................................................................................................................................................................done. 14:30:37 INFO - Installing pip.................done. 14:30:37 INFO - Return code: 0 14:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:30:37 INFO - Reading from file tmpfile_stdout 14:30:37 INFO - Output received: 14:30:37 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) 14:30:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:37 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 0x7ff3279bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1106ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f60>, '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 0x1104d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11051d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', '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 14:30:37 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 14:30:37 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 14:30:37 INFO - Using env: {'DISPLAY': ':0', 14:30:37 INFO - 'HOME': '/home/cltbld', 14:30:37 INFO - 'LANG': 'en_US.UTF-8', 14:30:37 INFO - 'LANGUAGE': 'en_US:en', 14:30:37 INFO - 'LOGNAME': 'cltbld', 14:30:37 INFO - 'MAIL': '/var/mail/cltbld', 14:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:37 INFO - 'MOZ_NO_REMOTE': '1', 14:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:37 INFO - 'NO_EM_RESTART': '1', 14:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:37 INFO - 'PWD': '/builds/slave/test', 14:30:37 INFO - 'SHELL': '/bin/bash', 14:30:37 INFO - 'SHLVL': '1', 14:30:37 INFO - 'TERM': 'linux', 14:30:37 INFO - 'TMOUT': '86400', 14:30:37 INFO - 'USER': 'cltbld', 14:30:37 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', 14:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:37 INFO - '_': '/tools/buildbot/bin/python'} 14:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:37 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 14:30:37 INFO - Cleaning up... 14:30:37 INFO - Return code: 0 14:30:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:37 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 0x7ff3279bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1106ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f60>, '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 0x1104d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11051d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', '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 14:30:37 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 14:30:37 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 14:30:37 INFO - Using env: {'DISPLAY': ':0', 14:30:37 INFO - 'HOME': '/home/cltbld', 14:30:37 INFO - 'LANG': 'en_US.UTF-8', 14:30:37 INFO - 'LANGUAGE': 'en_US:en', 14:30:37 INFO - 'LOGNAME': 'cltbld', 14:30:37 INFO - 'MAIL': '/var/mail/cltbld', 14:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:37 INFO - 'MOZ_NO_REMOTE': '1', 14:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:37 INFO - 'NO_EM_RESTART': '1', 14:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:37 INFO - 'PWD': '/builds/slave/test', 14:30:37 INFO - 'SHELL': '/bin/bash', 14:30:37 INFO - 'SHLVL': '1', 14:30:37 INFO - 'TERM': 'linux', 14:30:37 INFO - 'TMOUT': '86400', 14:30:37 INFO - 'USER': 'cltbld', 14:30:37 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', 14:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:37 INFO - '_': '/tools/buildbot/bin/python'} 14:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:38 INFO - Downloading/unpacking psutil>=3.1.1 14:30:38 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 14:30:38 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 14:30:38 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 14:30:38 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 14:30:38 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 14:30:38 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 14:30:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:30:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:40 INFO - Installing collected packages: psutil 14:30:40 INFO - Running setup.py install for psutil 14:30:40 INFO - building 'psutil._psutil_linux' extension 14:30:40 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 14:30:40 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 14:30:40 INFO - building 'psutil._psutil_posix' extension 14:30:40 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 14:30:40 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 14:30:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:40 INFO - Successfully installed psutil 14:30:40 INFO - Cleaning up... 14:30:40 INFO - Return code: 0 14:30:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:30:40 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')]} 14:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:40 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')]} 14:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:40 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 0x7ff3279bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1106ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f60>, '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 0x1104d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11051d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', '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 14:30:40 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 14:30:40 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 14:30:40 INFO - Using env: {'DISPLAY': ':0', 14:30:40 INFO - 'HOME': '/home/cltbld', 14:30:40 INFO - 'LANG': 'en_US.UTF-8', 14:30:40 INFO - 'LANGUAGE': 'en_US:en', 14:30:40 INFO - 'LOGNAME': 'cltbld', 14:30:40 INFO - 'MAIL': '/var/mail/cltbld', 14:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:40 INFO - 'MOZ_NO_REMOTE': '1', 14:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:40 INFO - 'NO_EM_RESTART': '1', 14:30:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:40 INFO - 'PWD': '/builds/slave/test', 14:30:40 INFO - 'SHELL': '/bin/bash', 14:30:40 INFO - 'SHLVL': '1', 14:30:40 INFO - 'TERM': 'linux', 14:30:40 INFO - 'TMOUT': '86400', 14:30:40 INFO - 'USER': 'cltbld', 14:30:40 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', 14:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:40 INFO - '_': '/tools/buildbot/bin/python'} 14:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:30:40 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 14:30:40 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 14:30:40 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 14:30:40 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 14:30:40 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 14:30:40 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 14:30:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:30:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:30:43 INFO - Installing collected packages: mozsystemmonitor 14:30:43 INFO - Running setup.py install for mozsystemmonitor 14:30:43 INFO - Successfully installed mozsystemmonitor 14:30:43 INFO - Cleaning up... 14:30:43 INFO - Return code: 0 14:30:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:30:43 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')]} 14:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:43 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')]} 14:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:43 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 0x7ff3279bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1106ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f60>, '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 0x1104d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11051d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', '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 14:30:43 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 14:30:43 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 14:30:43 INFO - Using env: {'DISPLAY': ':0', 14:30:43 INFO - 'HOME': '/home/cltbld', 14:30:43 INFO - 'LANG': 'en_US.UTF-8', 14:30:43 INFO - 'LANGUAGE': 'en_US:en', 14:30:43 INFO - 'LOGNAME': 'cltbld', 14:30:43 INFO - 'MAIL': '/var/mail/cltbld', 14:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:43 INFO - 'MOZ_NO_REMOTE': '1', 14:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:43 INFO - 'NO_EM_RESTART': '1', 14:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:43 INFO - 'PWD': '/builds/slave/test', 14:30:43 INFO - 'SHELL': '/bin/bash', 14:30:43 INFO - 'SHLVL': '1', 14:30:43 INFO - 'TERM': 'linux', 14:30:43 INFO - 'TMOUT': '86400', 14:30:43 INFO - 'USER': 'cltbld', 14:30:43 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', 14:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:43 INFO - '_': '/tools/buildbot/bin/python'} 14:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:43 INFO - Downloading/unpacking jsonschema==2.5.1 14:30:43 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 14:30:43 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 14:30:43 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 14:30:43 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 14:30:43 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 14:30:43 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 14:30:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:30:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:30:45 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 14:30:45 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 14:30:45 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 14:30:45 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 14:30:45 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 14:30:45 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 14:30:45 INFO - Downloading functools32-3.2.3-2.tar.gz 14:30:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:30:45 INFO - warning: no files found matching '*.txt' 14:30:45 INFO - no previously-included directories found matching 'build' 14:30:45 INFO - no previously-included directories found matching 'dist' 14:30:45 INFO - no previously-included directories found matching '.git*' 14:30:45 INFO - Installing collected packages: jsonschema, functools32 14:30:45 INFO - Running setup.py install for functools32 14:30:45 INFO - warning: no files found matching '*.txt' 14:30:45 INFO - no previously-included directories found matching 'build' 14:30:45 INFO - no previously-included directories found matching 'dist' 14:30:45 INFO - no previously-included directories found matching '.git*' 14:30:45 INFO - Successfully installed jsonschema functools32 14:30:45 INFO - Cleaning up... 14:30:45 INFO - Return code: 0 14:30:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:30:45 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')]} 14:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:45 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')]} 14:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:45 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 0x7ff3279bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1106ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f60>, '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 0x1104d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11051d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', '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 14:30:45 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 14:30:45 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 14:30:45 INFO - Using env: {'DISPLAY': ':0', 14:30:45 INFO - 'HOME': '/home/cltbld', 14:30:45 INFO - 'LANG': 'en_US.UTF-8', 14:30:45 INFO - 'LANGUAGE': 'en_US:en', 14:30:45 INFO - 'LOGNAME': 'cltbld', 14:30:45 INFO - 'MAIL': '/var/mail/cltbld', 14:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:45 INFO - 'MOZ_NO_REMOTE': '1', 14:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:45 INFO - 'NO_EM_RESTART': '1', 14:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:45 INFO - 'PWD': '/builds/slave/test', 14:30:45 INFO - 'SHELL': '/bin/bash', 14:30:45 INFO - 'SHLVL': '1', 14:30:45 INFO - 'TERM': 'linux', 14:30:45 INFO - 'TMOUT': '86400', 14:30:45 INFO - 'USER': 'cltbld', 14:30:45 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', 14:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:45 INFO - '_': '/tools/buildbot/bin/python'} 14:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:30:45 INFO - Cleaning up... 14:30:45 INFO - Return code: 0 14:30:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:30:45 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')]} 14:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:45 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')]} 14:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:45 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 0x7ff3279bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1106ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f60>, '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 0x1104d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11051d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', '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 14:30:45 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 14:30:45 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 14:30:45 INFO - Using env: {'DISPLAY': ':0', 14:30:45 INFO - 'HOME': '/home/cltbld', 14:30:45 INFO - 'LANG': 'en_US.UTF-8', 14:30:45 INFO - 'LANGUAGE': 'en_US:en', 14:30:45 INFO - 'LOGNAME': 'cltbld', 14:30:45 INFO - 'MAIL': '/var/mail/cltbld', 14:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:45 INFO - 'MOZ_NO_REMOTE': '1', 14:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:45 INFO - 'NO_EM_RESTART': '1', 14:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:45 INFO - 'PWD': '/builds/slave/test', 14:30:45 INFO - 'SHELL': '/bin/bash', 14:30:45 INFO - 'SHLVL': '1', 14:30:45 INFO - 'TERM': 'linux', 14:30:45 INFO - 'TMOUT': '86400', 14:30:45 INFO - 'USER': 'cltbld', 14:30:45 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', 14:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:45 INFO - '_': '/tools/buildbot/bin/python'} 14:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:46 INFO - Downloading/unpacking blobuploader==1.2.4 14:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:48 INFO - Downloading blobuploader-1.2.4.tar.gz 14:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:30:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:30:48 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 14:30:48 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 14:30:48 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 14:30:48 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 14:30:48 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 14:30:48 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 14:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:30:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:30:48 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 14:30:48 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 14:30:48 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 14:30:48 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 14:30:48 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 14:30:48 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 14:30:48 INFO - Downloading docopt-0.6.1.tar.gz 14:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:30:48 INFO - Installing collected packages: blobuploader, requests, docopt 14:30:48 INFO - Running setup.py install for blobuploader 14:30:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:30:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:30:48 INFO - Running setup.py install for requests 14:30:49 INFO - Running setup.py install for docopt 14:30:49 INFO - Successfully installed blobuploader requests docopt 14:30:49 INFO - Cleaning up... 14:30:49 INFO - Return code: 0 14:30:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30:49 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')]} 14:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:49 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')]} 14:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:49 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 0x7ff3279bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1106ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f60>, '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 0x1104d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11051d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', '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 14:30:49 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 14:30:49 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 14:30:49 INFO - Using env: {'DISPLAY': ':0', 14:30:49 INFO - 'HOME': '/home/cltbld', 14:30:49 INFO - 'LANG': 'en_US.UTF-8', 14:30:49 INFO - 'LANGUAGE': 'en_US:en', 14:30:49 INFO - 'LOGNAME': 'cltbld', 14:30:49 INFO - 'MAIL': '/var/mail/cltbld', 14:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:49 INFO - 'MOZ_NO_REMOTE': '1', 14:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:49 INFO - 'NO_EM_RESTART': '1', 14:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:49 INFO - 'PWD': '/builds/slave/test', 14:30:49 INFO - 'SHELL': '/bin/bash', 14:30:49 INFO - 'SHLVL': '1', 14:30:49 INFO - 'TERM': 'linux', 14:30:49 INFO - 'TMOUT': '86400', 14:30:49 INFO - 'USER': 'cltbld', 14:30:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', 14:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:49 INFO - '_': '/tools/buildbot/bin/python'} 14:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:30:49 INFO - Running setup.py (path:/tmp/pip-XkGWGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:30:49 INFO - Running setup.py (path:/tmp/pip-C0Po7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:30:49 INFO - Running setup.py (path:/tmp/pip-oTew0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:30:49 INFO - Running setup.py (path:/tmp/pip-YYikJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:30:49 INFO - Running setup.py (path:/tmp/pip-6UEpcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:30:50 INFO - Running setup.py (path:/tmp/pip-fHwVR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:30:50 INFO - Running setup.py (path:/tmp/pip-CyHoYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:30:50 INFO - Running setup.py (path:/tmp/pip-V6FRog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:30:50 INFO - Running setup.py (path:/tmp/pip-oQNZ1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:30:50 INFO - Running setup.py (path:/tmp/pip-1_R8An-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:30:50 INFO - Running setup.py (path:/tmp/pip-_dwuDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:30:50 INFO - Running setup.py (path:/tmp/pip-HGXG_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:30:50 INFO - Running setup.py (path:/tmp/pip-drU6r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:30:50 INFO - Running setup.py (path:/tmp/pip-GrjilI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:50 INFO - Running setup.py (path:/tmp/pip-7tfwVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:30:50 INFO - Running setup.py (path:/tmp/pip-mzkdpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:30:50 INFO - Running setup.py (path:/tmp/pip-oxvYKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:30:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:30:50 INFO - Running setup.py install for manifestparser 14:30:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:30:51 INFO - Running setup.py install for mozcrash 14:30:51 INFO - Running setup.py install for mozdebug 14:30:51 INFO - Running setup.py install for mozdevice 14:30:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:30:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:30:51 INFO - Running setup.py install for mozfile 14:30:51 INFO - Running setup.py install for mozhttpd 14:30:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:30:51 INFO - Running setup.py install for mozinfo 14:30:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:30:51 INFO - Running setup.py install for mozInstall 14:30:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:30:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:30:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:30:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:30:51 INFO - Running setup.py install for mozleak 14:30:51 INFO - Running setup.py install for mozlog 14:30:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:30:51 INFO - Running setup.py install for moznetwork 14:30:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:30:52 INFO - Running setup.py install for mozprocess 14:30:52 INFO - Running setup.py install for mozprofile 14:30:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:30:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:30:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:30:52 INFO - Running setup.py install for mozrunner 14:30:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:30:52 INFO - Running setup.py install for mozscreenshot 14:30:52 INFO - Running setup.py install for moztest 14:30:52 INFO - Running setup.py install for mozversion 14:30:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:30:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:30:52 INFO - Cleaning up... 14:30:52 INFO - Return code: 0 14:30:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:52 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 0x7ff3279bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1106ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f60>, '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 0x1104d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11051d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', '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 14:30:52 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 14:30:52 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 14:30:52 INFO - Using env: {'DISPLAY': ':0', 14:30:52 INFO - 'HOME': '/home/cltbld', 14:30:52 INFO - 'LANG': 'en_US.UTF-8', 14:30:52 INFO - 'LANGUAGE': 'en_US:en', 14:30:52 INFO - 'LOGNAME': 'cltbld', 14:30:52 INFO - 'MAIL': '/var/mail/cltbld', 14:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:52 INFO - 'MOZ_NO_REMOTE': '1', 14:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:52 INFO - 'NO_EM_RESTART': '1', 14:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:52 INFO - 'PWD': '/builds/slave/test', 14:30:52 INFO - 'SHELL': '/bin/bash', 14:30:52 INFO - 'SHLVL': '1', 14:30:52 INFO - 'TERM': 'linux', 14:30:52 INFO - 'TMOUT': '86400', 14:30:52 INFO - 'USER': 'cltbld', 14:30:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', 14:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:52 INFO - '_': '/tools/buildbot/bin/python'} 14:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:30:52 INFO - Running setup.py (path:/tmp/pip-1ifBBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:30:53 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)) 14:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:30:53 INFO - Running setup.py (path:/tmp/pip-xMUinP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:30:53 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)) 14:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:30:53 INFO - Running setup.py (path:/tmp/pip-OxQemc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:30:53 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)) 14:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:30:53 INFO - Running setup.py (path:/tmp/pip-nnpSVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:30:53 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)) 14:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:30:53 INFO - Running setup.py (path:/tmp/pip-KvIKdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:30:53 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)) 14:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:30:53 INFO - Running setup.py (path:/tmp/pip-_VZQLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:30:53 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)) 14:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:30:53 INFO - Running setup.py (path:/tmp/pip-1FPZ1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:30:53 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)) 14:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:30:53 INFO - Running setup.py (path:/tmp/pip-NsuF9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:30:53 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)) 14:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:30:53 INFO - Running setup.py (path:/tmp/pip-tH0zLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:30:53 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)) 14:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:30:53 INFO - Running setup.py (path:/tmp/pip-HfLCry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:30:53 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)) 14:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:30:53 INFO - Running setup.py (path:/tmp/pip-UxXoJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:30:53 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)) 14:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:30:53 INFO - Running setup.py (path:/tmp/pip-G1Ibk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:30:53 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)) 14:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:30:53 INFO - Running setup.py (path:/tmp/pip-09odWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:30:53 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)) 14:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:30:53 INFO - Running setup.py (path:/tmp/pip-uMEYaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:30:53 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)) 14:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:53 INFO - Running setup.py (path:/tmp/pip-xPP0fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:54 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)) 14:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:30:54 INFO - Running setup.py (path:/tmp/pip-NHTkui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:30:54 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)) 14:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:30:54 INFO - Running setup.py (path:/tmp/pip-jKAHFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:30:54 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)) 14:30:54 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)) 14:30:54 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)) 14:30:54 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)) 14:30:54 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)) 14:30:54 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)) 14:30:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:56 INFO - Downloading blessings-1.6.tar.gz 14:30:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:30:56 INFO - Installing collected packages: blessings 14:30:56 INFO - Running setup.py install for blessings 14:30:56 INFO - Successfully installed blessings 14:30:56 INFO - Cleaning up... 14:30:56 INFO - Return code: 0 14:30:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:30:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:30:56 INFO - Reading from file tmpfile_stdout 14:30:56 INFO - Current package versions: 14:30:56 INFO - argparse == 1.2.1 14:30:56 INFO - blessings == 1.6 14:30:56 INFO - blobuploader == 1.2.4 14:30:56 INFO - docopt == 0.6.1 14:30:56 INFO - functools32 == 3.2.3-2 14:30:56 INFO - jsonschema == 2.5.1 14:30:56 INFO - manifestparser == 1.1 14:30:56 INFO - mozInstall == 1.12 14:30:56 INFO - mozcrash == 0.17 14:30:56 INFO - mozdebug == 0.1 14:30:56 INFO - mozdevice == 0.48 14:30:56 INFO - mozfile == 1.2 14:30:56 INFO - mozhttpd == 0.7 14:30:56 INFO - mozinfo == 0.9 14:30:56 INFO - mozleak == 0.1 14:30:56 INFO - mozlog == 3.4 14:30:56 INFO - moznetwork == 0.27 14:30:56 INFO - mozprocess == 0.23 14:30:56 INFO - mozprofile == 0.28 14:30:56 INFO - mozrunner == 6.12 14:30:56 INFO - mozscreenshot == 0.1 14:30:56 INFO - mozsystemmonitor == 0.3 14:30:56 INFO - moztest == 0.7 14:30:56 INFO - mozversion == 1.4 14:30:56 INFO - psutil == 3.1.1 14:30:56 INFO - requests == 1.2.3 14:30:56 INFO - wsgiref == 0.1.2 14:30:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30:56 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')]} 14:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:56 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')]} 14:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:56 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 0x7ff3279bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1106ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f60>, '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 0x1104d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11051d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', '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 14:30:56 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 14:30:56 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 14:30:56 INFO - Using env: {'DISPLAY': ':0', 14:30:56 INFO - 'HOME': '/home/cltbld', 14:30:56 INFO - 'LANG': 'en_US.UTF-8', 14:30:56 INFO - 'LANGUAGE': 'en_US:en', 14:30:56 INFO - 'LOGNAME': 'cltbld', 14:30:56 INFO - 'MAIL': '/var/mail/cltbld', 14:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:56 INFO - 'MOZ_NO_REMOTE': '1', 14:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:56 INFO - 'NO_EM_RESTART': '1', 14:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:56 INFO - 'PWD': '/builds/slave/test', 14:30:56 INFO - 'SHELL': '/bin/bash', 14:30:56 INFO - 'SHLVL': '1', 14:30:56 INFO - 'TERM': 'linux', 14:30:56 INFO - 'TMOUT': '86400', 14:30:56 INFO - 'USER': 'cltbld', 14:30:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', 14:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:56 INFO - '_': '/tools/buildbot/bin/python'} 14:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:56 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)) 14:30:56 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)) 14:30:56 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)) 14:30:56 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)) 14:30:56 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)) 14:30:56 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)) 14:30:56 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)) 14:30:56 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)) 14:30:56 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)) 14:30:56 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)) 14:30:56 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)) 14:30:56 INFO - Cleaning up... 14:30:56 INFO - Return code: 0 14:30:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:30:56 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')]} 14:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:56 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')]} 14:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:56 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 0x7ff3279bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1106ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f60>, '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 0x1104d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11051d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', '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 14:30:56 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 14:30:56 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 14:30:56 INFO - Using env: {'DISPLAY': ':0', 14:30:56 INFO - 'HOME': '/home/cltbld', 14:30:56 INFO - 'LANG': 'en_US.UTF-8', 14:30:56 INFO - 'LANGUAGE': 'en_US:en', 14:30:56 INFO - 'LOGNAME': 'cltbld', 14:30:56 INFO - 'MAIL': '/var/mail/cltbld', 14:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:56 INFO - 'MOZ_NO_REMOTE': '1', 14:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:56 INFO - 'NO_EM_RESTART': '1', 14:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:56 INFO - 'PWD': '/builds/slave/test', 14:30:56 INFO - 'SHELL': '/bin/bash', 14:30:56 INFO - 'SHLVL': '1', 14:30:56 INFO - 'TERM': 'linux', 14:30:56 INFO - 'TMOUT': '86400', 14:30:56 INFO - 'USER': 'cltbld', 14:30:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', 14:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:56 INFO - '_': '/tools/buildbot/bin/python'} 14:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:30:57 INFO - Cleaning up... 14:30:57 INFO - Return code: 0 14:30:57 INFO - Running post-action listener: _resource_record_post_action 14:30:57 INFO - Running post-action listener: _start_resource_monitoring 14:30:57 INFO - Starting resource monitoring. 14:30:57 INFO - [mozharness: 2016-09-29 21:30:57.072818Z] Finished create-virtualenv step (success) 14:30:57 INFO - [mozharness: 2016-09-29 21:30:57.073334Z] Running install step. 14:30:57 INFO - Running pre-action listener: _resource_record_pre_action 14:30:57 INFO - Running main action method: install 14:30:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:30:57 INFO - Reading from file tmpfile_stdout 14:30:57 INFO - Detecting whether we're running mozinstall >=1.0... 14:30:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:30:57 INFO - Reading from file tmpfile_stdout 14:30:57 INFO - Output received: 14:30:57 INFO - Usage: mozinstall [options] installer 14:30:57 INFO - Options: 14:30:57 INFO - -h, --help show this help message and exit 14:30:57 INFO - -d DEST, --destination=DEST 14:30:57 INFO - Directory to install application into. [default: 14:30:57 INFO - "/builds/slave/test"] 14:30:57 INFO - --app=APP Application being installed. [default: firefox] 14:30:57 INFO - mkdir: /builds/slave/test/build/application 14:30:57 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'] 14:30:57 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 14:31:13 INFO - Reading from file tmpfile_stdout 14:31:13 INFO - Output received: 14:31:13 INFO - /builds/slave/test/build/application/firefox/firefox 14:31:13 INFO - Running post-action listener: _resource_record_post_action 14:31:13 INFO - [mozharness: 2016-09-29 21:31:13.481313Z] Finished install step (success) 14:31:13 INFO - [mozharness: 2016-09-29 21:31:13.481557Z] Running run-tests step. 14:31:13 INFO - Running pre-action listener: _resource_record_pre_action 14:31:13 INFO - Running main action method: run_tests 14:31:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:31:13 INFO - Python 2.7.3 14:31:13 INFO - Return code: 0 14:31:13 INFO - grabbing minidump binary from tooltool 14:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:13 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 0x1103f60>, '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 0x1104d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11051d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:31:13 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 14:31:13 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 14:31:13 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 14:31:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:31:13 INFO - Return code: 0 14:31:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:31:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:31:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:31:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:31:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:31:13 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/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 14:31:13 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/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 14:31:13 INFO - Using env: {'DISPLAY': ':0', 14:31:13 INFO - 'HOME': '/home/cltbld', 14:31:13 INFO - 'LANG': 'en_US.UTF-8', 14:31:13 INFO - 'LANGUAGE': 'en_US:en', 14:31:13 INFO - 'LOGNAME': 'cltbld', 14:31:13 INFO - 'MAIL': '/var/mail/cltbld', 14:31:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:31:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:13 INFO - 'MOZ_NO_REMOTE': '1', 14:31:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:13 INFO - 'NO_EM_RESTART': '1', 14:31:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:13 INFO - 'PWD': '/builds/slave/test', 14:31:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:31:13 INFO - 'SHELL': '/bin/bash', 14:31:13 INFO - 'SHLVL': '1', 14:31:13 INFO - 'TERM': 'linux', 14:31:13 INFO - 'TMOUT': '86400', 14:31:13 INFO - 'USER': 'cltbld', 14:31:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489', 14:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:13 INFO - '_': '/tools/buildbot/bin/python'} 14:31:13 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/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 14:31:13 INFO - mozversion application_buildid: 20160929141519 14:31:13 INFO - mozversion application_changeset: 7de011ec6e45a2e5019ecae87acacb8bb2a8f381 14:31:13 INFO - mozversion application_display_name: Nightly 14:31:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:31:13 INFO - mozversion application_name: Firefox 14:31:13 INFO - mozversion application_remotingname: firefox 14:31:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:31:13 INFO - mozversion application_vendor: Mozilla 14:31:13 INFO - mozversion application_version: 52.0a1 14:31:13 INFO - mozversion platform_buildid: 20160929141519 14:31:13 INFO - mozversion platform_changeset: 7de011ec6e45a2e5019ecae87acacb8bb2a8f381 14:31:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:31:13 INFO - mozversion platform_version: 52.0a1 14:31:13 INFO - using testdate: 1475184673 14:31:13 INFO - actual date: 1475184673 14:31:13 INFO - starting webserver on 'localhost:59416' 14:31:13 INFO - SUITE-START | Running 2 tests 14:31:13 INFO - TEST-START | dromaeo_css 14:31:13 INFO - operating with platform_type : linux_ 14:31:13 INFO - Initialising browser for dromaeo_css test... 14:31:13 INFO - TEST-INFO | started process 20860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpreNDoY/profile http://localhost:59416/getInfo.html) 14:31:18 INFO - PROCESS | 20860 | __metrics Screen width/height:1600/1200 14:31:18 INFO - PROCESS | 20860 | colorDepth:24 14:31:18 INFO - PROCESS | 20860 | Browser inner width/height: 1024/697 14:31:18 INFO - PROCESS | 20860 | __metrics 14:31:18 INFO - PROCESS | 20860 | 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" 14:31:18 INFO - PROCESS | 20860 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:31:19 INFO - PROCESS | 20860 | console.error: PushService: 14:31:19 INFO - PROCESS | 20860 | stateChangeProcessEnqueue: Error transitioning state 14:31:19 INFO - PROCESS | 20860 | UnknownError 14:31:20 INFO - TEST-INFO | 20860: exit 0 14:31:20 INFO - Browser initialized. 14:31:20 INFO - Running cycle 1/1 for dromaeo_css test... 14:31:20 INFO - TEST-INFO | started process 20941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpreNDoY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:32 INFO - PROCESS | 20941 | RSS: Main: 179351552 14:31:32 INFO - PROCESS | 20941 | 14:32:24 INFO - PROCESS | 20941 | 1475184744140 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] 14:34:36 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:59416/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59416/tests/dromaeo/cssquery-ext.html) 14:34:38 INFO - PROCESS | 20941 | RSS: Main: 317227008 14:34:38 INFO - PROCESS | 20941 | 14:37:41 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:59416/tests/dromaeo/cssquery-ext.html (next: http://localhost:59416/tests/dromaeo/cssquery-jquery.html) 14:37:41 INFO - PROCESS | 20941 | RSS: Main: 288948224 14:37:41 INFO - PROCESS | 20941 | 14:40:43 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:59416/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59416/tests/dromaeo/cssquery-mootools.html) 14:40:44 INFO - PROCESS | 20941 | RSS: Main: 258359296 14:40:44 INFO - PROCESS | 20941 | 14:43:46 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:59416/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59416/tests/dromaeo/cssquery-prototype.html) 14:43:47 INFO - PROCESS | 20941 | RSS: Main: 258011136 14:43:47 INFO - PROCESS | 20941 | 14:46:50 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:59416/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59416/tests/dromaeo/cssquery-yui.html) 14:46:51 INFO - PROCESS | 20941 | RSS: Main: 219926528 14:46:51 INFO - PROCESS | 20941 | 14:49:53 INFO - PROCESS | 20941 | Cycle 1(1): loaded http://localhost:59416/tests/dromaeo/cssquery-yui.html (next: http://localhost:59416/tests/dromaeo/cssquery-dojo.html) 14:49:54 INFO - PROCESS | 20941 | RSS: Main: 312913920 14:49:54 INFO - PROCESS | 20941 | 14:49:54 INFO - PROCESS | 20941 | __start_tp_report 14:49:54 INFO - PROCESS | 20941 | _x_x_mozilla_page_load 14:49:54 INFO - PROCESS | 20941 | _x_x_mozilla_page_load_details 14:49:54 INFO - PROCESS | 20941 | |i|pagename|runs| 14:49:54 INFO - PROCESS | 20941 | |0;dojo.html;2523.2808649534886;2544.2112944987043;2570.3702592864747;2575.9484810303793;2596.909108181214;4473.66447516436;4556.749378784166;4564.338170965208;4565.2923796811465;4570.268756998881;4519.163954668388;4550.180967425862;4551.522090180525;4582.198115329812;4587.42657167854;4205.432266644009;4240.787960601973;4242.406063151161;4245.596668316505;4342.544032876534;4263.126059157865;4322.373255877896;4323.654107671378;4343.543927887558;4357.716748411359;4095.9180816383505;4114.506259248909;4115.609017143366;4233.1322078973735;4290.678199135077;4227.154569086164;4240.830366785325;4241.49102107746;4243.596858298457;4244.257254980397;4154.5222299435645;4167.249895018896;4229.936550951707;4238.046439551076;4283.571642835723;4482.731036137842;4529.818807247706;4553.590176884097;4560.361549383089;4613.76931153441;4881.316615673809;4890.413150421937;4894.1679914414635;4900.607951363882;4948.233023881304;4782.473927867932;4822.71063736177;4894.4371397289415;4947.604191664658;4954.43024052235;4555.111753208159;4606.516315786827;4607.562281583244;4611.792469338888;4669.2996050592;5014.674046186986;5029.044481548567;5030.4215015272985;5034.622403319766;5089.083964886356;4715;4781.95218047822;4784.6889952153;4837.129316723023;4840.636952228527;4889.657723959289;4922.163232250526;4923.310736496894;4925.236588328815;4929.0388374267395;4846.224604063404;4876.634252431082;4883.121038213156;4900.117978763786;4903.975480122576;4771.188897887368;4821.879453013703;4825.879353016133;4881.902361952741;4907.975460122677;4199.643030342455;4244.3633454982;4249.3625956106835;4250.936235956463;4253.191893540217;3624.3657359961903;3667.431548110047;3701.3892707703467;3704.333220020368;3726.4596633488536;4180.16396720651;4246.554111818276;4247.362895565628;4248.383984322256;4304.634106100953;4889.951100489021;4896.608271338285;4904.141775189399;4905.558499735041;4906;4146.771927544014;4204.978975105105;4236.661067114624;4267.445232119804;4295.785210739513;4446.466424029137;4455.331700244924;4504.527024662429;4515.277555591089;4516.187086324428;4637.095766325534;4646.97676511622;4651.209294419957;4701.858944231679;4704.035672687022;4772.284157376422;4828.5412885775795;4909.852704418873;4910.43529994041;4912.091263116335;4607.562281583244;4629.328747331685;4663.790129444115;4671.976640116914;4728.810847566197;4854.805807767791;4855.587275081658;4864.148773964613;4875.853724388274;4893.192623217129;4747.112940861755;4919.4834542373965;4928.654994150375;4934.383202099738;4995.550400463976;4737.715737055788;4742.976285118552;4785.425748910153;4802.423709154924;4850.7817148227705;4798.664093513421;4802.399700037496;4805.207140821725;4808.110499557593;4863.294822250825;4713.599344055794;4739.075880203465;4741.454732705645;4751.619870410428;4790.880227994328;4615.515370886009;4691.835785747482;4736.881577960578;4763.952360476351;4813.3983252093485;4714.892000379977;4722.7874745635845;4722.858314250578;4743.169945259635;4780.211265141352 14:49:54 INFO - PROCESS | 20941 | |1;ext.html;546.3907742866702;557.5261028126096;558.0540983033757;567.5658121537025;569.9259096317479;27741.722582774193;28776.85611571942;30788.230294242654;37264.81367593158;38586.8070659647;39656.20687586254;40144.19711605766;40163.19673606526;40168.79915600418;40255;7572.318491335779;7731;7737.110232323271;7739.922600774004;7743;7538.133114691798;7611.619419029026;7612.505187162845;7621.314081732643;7628.313451789338;7630.7710768677025;7673.9616301918695;7681.155072941972;7681.57751323677;7684.231576842327;7589.468737188399;7613.42899282556;7619.5809230492305;7620.08558972924;7622.923770762277;7564.394848412169;7624.199459056775;7633.198514155989;7635.580043097628;7637.732679356196;36781.816090919376;37120.44319335212;37120.814395927846;37145;37152.62847371546;3086.722195002438;3139.0425920094362;3149.4173577888164;3406.42090844557;3462.6018007928906;27860.303492412648;27963.300917477227;28307.433851323065;28408.85795571009;28576.28559286014;3186.888458903927;3221.1463962050075;3323.9501407478906;3380.6281309055985;3396;176428.82499112468;179330.10334948372;179465;180031;180362;29725.946589079907;49763;50280.497195028314;50315.24527132023;50319;30638.38723225523;32778.508322375186;32790.34419311648;32793.34413311721;32795.1801204967;12695.809562856564;12871.42078606465;12872.485100596059;12874.806877896839;12877.871221287667;10193.388396696222;10200.132988696045;10213.387196768217;10217.540210690537;10218.489075546193;7631.809204769814;7640.274173953466;7746.147923728386;7752.26353496417;7756;3014.623172103487;3023.9697603023687;3042.2242328206607;3052.664206937235;3076.230942264434;876.3427429427929;900.8243392538392;901.3555307954844;916.3722849847876;964.8793900762405;26372.340691482867;27051;27106.087947573636;27981.300467488476;28488;933.1974501928336;942.6559305853314;955.441066975813;981.6613268422383;1000.5242267655295;13278.601641950758;14226.14643121416;14336.85663143376;14407;14646.780298295535;394646;397612;398750;399415;400904;46344.755867089654;46781.5321846784;46828;46892;46907.29639055417;1048.3709774135305;1078.8705355357408;1111.627604752417;1119.6864877834219;1137.4881303413663;25266.494670106862;28320.15039548817;28814.423711526073;28865.278368040967;28888;40188.79905600454;40783.796081019405;40840;40868.79565602153;40889.18221635491;297972;300011;300568;301208;301906.4904675463;21367.786322137203;21690.89154554217;23290.3012909613;23446;24185;37637.24725505529;38342;38453.230935380576;38501.80749096349;38645.420318695804;33476;33903;34369.656303437645;34384.82807585946;34416.82791586026;33101;33526.329473410886;33782.662173378936;34017.82991085029;34424.6641770526;33085.50371744474;33753.662463375054;33760.49359259564;34063;34093.69266685671;30300.242493936945;30549.389012220076;31026.379472409975;31301.530477042408;31358.216044599067;23871.641925370786;24056;24183.15358962428;24268.75731242665;24395.26814195577 14:49:54 INFO - PROCESS | 20941 | |2;jquery.html;341.1011983423678;348.16614208969503;361.6401680328073;363.5201533975153;380.46544604830206;12428.440720167591;15438.691226175484;16022.19889005551;16226.269817858196;16357.83642163578;15311.69376612467;15508.767368489454;15509.302081406335;15763.527094187193;15987;3671.3391589513876;4492.640588752892;4618.930716039262;4624.745638989854;5102.897942041157;4954.207326827708;4990.750462476862;5020.924686129711;5036.269740887569;5043.142665746814;4842.418909730837;5012.899742005157;5023.422306434771;5027.371578552681;5028.170351891952;5049.8485045448515;5058.494150584949;5064.341635587369;5065.11360511909;5074.695518268879;4466.9106617867465;4526.0495295987885;4577.702449340783;4579.7252164870215;4582.793774280165;18976.715349269773;19397.903010485;19447.90276048625;19689.901550492155;19708.70436943447;1806.223323970692;1858.1823997441084;1878.8966606836618;2111.7125691511437;2308.8225005247277;8384.813352780438;8803.119688031209;9060.637574497012;9167.083291670846;9272;1587.8809089318231;1657.5690320516753;1663.3679201903321;1674.196385734842;1736.3488691740597;65770;68216;68426.65786671084;69186.65406672934;70344.6482767588;9327.860082098638;9407.764805879908;9498.287628427757;9678;9732.318737688436;12938.741225175443;12997.740045199043;13053.216806991612;13066.738665226832;13090.607281781562;6267.655278959701;6370.904436433457;6384.744610215539;6389.968050159812;6416.903746443807;5864.091065884794;6161.137440758297;6307.9369206308265;6311.526635502356;6318.652474113968;3903.375459926398;3940.7241493095207;3990.144582768968;4071.0840060986634;4145.3781932709735;1679.2695177597784;1736.0798776648396;1736.9044702541482;1757.1829099468807;1762.3919747687028;823.555280148713;828.3125006244802;837.6691206973211;905.6151135767273;934.0566028311455;16007.759883601755;16261.59346016359;16309.18454077315;16411.753823692656;16981.745273820903;848.9830203395898;866.3545658484469;870.2211520688948;878.9780255493536;910.1126401758232;8866.246369058703;9416.152546270732;9418.905810941802;9456.196223320958;9557.808843823224;348680;353041;355656;355748;355912;71795;76016;76590;77346.2265377339;77356.61321693356;881.4789701453836;884.2616415293173;889.9777505562413;903.5572569441058;908.3641450984337;14264.144151350953;14285.857141428452;14404.711905761616;14416.044710834045;15066.246687665793;34624.48063279002;34916.47625285674;35565.644343557266;35839.283214335046;36156.74589286977;48355;48528.206051153575;48719;49029;49404.258936116705;7189.281071892978;7334.596597187206;7372.189059203376;7413.66638501258;7672.117706463605;10741.301815381976;11234.269772464764;11537.884621154017;11653.242539234923;11674.241174323643;9507.191888689538;9934.254930880357;9972.700818975442;9990.250731195334;10409.115225205942;9710.320277580502;10152.137068348977;10207.948960255448;10301.9484902575;10342.069213770797;9735.756606084904;9940.801183976424;10363.962380065206;10508.894911050791;10527.894721052691;7387.783664900616;7405.222451642716;7477.588732619541;7512.173660897188;7976.361891048586;9863.260255480724;10046.246531510313;10249.282550221413;10265.640702575673;10842.945785271024 14:49:54 INFO - PROCESS | 20941 | |3;mootools.html;1236.758832027755;1316.019565423759;1345.9528916487923;1384.5569417786312;1643.1948345310802;6445.323241059686;6908.171019477657;6929.168499780028;7246.7825965221;7247.710091596343;7107.502474826764;7442.813929651761;7458.88811667824;7468.141163766169;7495.175530691633;2034.128601686452;2066.2561477867957;2066.6486697261503;2073.9170433182653;2076.802703743142;2025.1291944463874;2055.0238636647623;2063.7420322459693;2070.420282320945;2075.335892514396;2055.4553043443498;2065.09135980169;2076.6677331626943;2077.1898959405844;2078.251829341436;1999.8100180482832;2009.1762377425187;2012.738344015276;2017.2334512885157;2020.0606717876112;1980.6137803128395;1987.7515310586177;2018.6164628720496;2019.9596008079757;2024.2914979757115;6993.545419547713;7227.638618069128;7260.38286745622;7332.156801967789;7346;4190.706650534464;4387.846425375096;4394.758288294142;4406.09675016624;4407.713498622579;2683.8121331506804;2760.30992251937;2807.4806160860308;2814.957775633367;2816.887324507017;868.1362044765499;873.2882700598991;884.920357167858;887.8756974023642;899.4603238057178;9825.361351512129;10033.448160351178;10038.196944244515;10040.447775372351;10043.14633256174;3727.2731817295366;3864.4589757433982;3989.2420440116284;4027.0536423940935;4033.1328764315813;8509.70216042448;8600.096989816104;8625.0943650917;8637.611307491177;8639.265662418638;4397.384366188736;4446.755428451466;4470.575295346936;4471.977640111779;4473.217186992329;3546.4325707886615;3678.8160591970295;3940.133170702441;4101.666958238585;4101.692373072032;3402.4556071028514;3427.074689833731;3534.8688419705963;3558.6085530591613;3559.341521818472;1160.3560024186656;1185.8221266810046;1186.5609724402027;1199.6940780101017;1206.4631239098692;738.8854727517244;761.1437133225122;762.4967521435826;780.4536824223067;781.5935713428985;4600.171969045537;4644.489106198315;4869.902601947942;5188.818391356284;5249.685018898878;786.9960650196826;857.0443954990266;858.8368210040197;862.5040601654074;874.7157173918501;3122.859471323796;3162.2094476380903;3221;3238.2875767331147;3532.434810430319;8988.595513201792;9017.63929442828;9125.133112354315;9209.677661281823;9231.815363692689;9119.726408207764;9125.726228213165;9153.725388238363;9164.266858651292;9172.908270917338;6750.662466876636;7009;7061.258567850302;7062.470314726416;7075.363217310364;4924.852254432372;4997.825076122318;5065.062963351792;5073.974630126826;5115.9232611510115;7972.441929064909;8252.752417427488;8448.788780280296;8450.281726053354;8460.492370457792;8145.185481451807;8301.169883011651;8341.624626891684;8439.451435656663;8460.619272132892;6262.655553944577;6439.517036222396;6800.965995169992;7128.786136415916;7136.6788494518905;6743.393094621508;6913.516053876381;6950.165980082423;7151.53515021522;7158.463115266271;6263.749450021948;6298.307186209605;6381.776637817654;6387.648679322682;6426.582272152295;6232.719527621177;6239.1577137085915;6362.109304697438;6423.518236132215;6534.509911756732;5746.885062298814;5879.059350503899;5881.7647294107755;5882.970585147047;5891.528677705859;4237.216115018731;4286.80709368073;4287.185434767384;4339.761313127682;4392.363107349481;4257.957420425756;4295.076558539929;4307.310830267143;4396.49440314368;4457.866264012085 14:49:54 INFO - PROCESS | 20941 | |4;prototype.html;283.52084976389887;283.76872848628363;291.2529362185994;291.58740382358957;292.14838745058154;4669.089527542131;4698.107359601673;4740.834070807522;4745.288206768986;4763.356946812175;4438.134563760068;4534.954650453495;4560.696848091718;4595.3107033944925;4699.0865663288805;3597.136687195074;3608.747387682863;3703.9814800925956;3711.498947642074;3730.5150330457004;3705.5738590062083;3715.814209289538;3720.6465385788442;3734.5705243897028;3738.7943663098517;3605.801680907549;3697.482352470656;3705.907352316187;3712.350338690732;3714.53568303962;3661.4873917651416;3719.1260053887313;3725.068732816796;3727.5340582427198;3747.8126093695478;3289.5559099521497;3289.7039266465895;3291.1607540077366;3294.8682052717863;3305.520699498559;4610.331501932201;4615.630749540029;4631.3516107744945;4638.165130276549;4639.025804581042;4102.138550904314;4174.749515029078;4229.302165142779;4252.893677658052;4270.957290427087;4898.926516102261;4904.53406926345;4907.975460122712;4914.68054576455;4923.606111511071;3553.1472446612884;3556.5020897074173;3556.715462762973;3557.964420355789;3595;4940.2709051831935;5211.436569029314;5225.973870130663;5229.50319719626;5239.711815850127;3526.7480044584318;3543.114221444639;3551.614870200624;3555.2000799819834;3561.3411518869093;3604.540161234704;3610.3681855675677;3616.240589476187;3616.553378648509;3616.9819150904605;4163.333866581333;4187.91624167515;4190.078182799779;4197.286461301525;4202.306619407825;4843.75781210938;4957.958828645953;4984.42679091909;5044.192929131322;5066.949330506648;1232.9198602090835;1247.5197049136148;1248.076423446661;1249.2254802022621;1250.3748125937032;760.5360729954723;779.8167430653792;781.2773184804147;782.5383024015858;786.1352512236494;4263.488381394252;4278.593533614302;4408.404865343137;4443.600075993111;4465.151621191963;5098.1842905135;5099.796008159707;5105.897882042338;5109.846704598794;5116.590672746172;4268.701190916606;4400.581944715247;4413.6248418884115;4425.977870110629;4434.13534360803;2645.7486538778785;2678.1028355501126;2701.405690748032;2707.9593806092926;2709.214327844942;4853.805847766121;4863.7324947128245;4871.80512779492;4893.241547560134;4900.117978763786;4940.950590494121;5192.091384007859;5225.555827754607;5263.473652634706;5272.888995492601;4832.9275060874115;4856.660033797671;4874.756262186947;4880.804767809248;4893.657443978887;5114.718690471911;5132.5124113209185;5141.380465153614;5174.844754657366;5198.844034678966;4841.733704646137;4999.65002449825;5025.673331233458;5056.418511871182;5091.898162036812;4836.258946779227;4850.902981940412;4852.199387101089;4859.198232291632;4859.246816743411;3582.659647333499;3596;3596.5144705464427;3626.5829429615933;3626.9455958161175;4985.5762260208285;5091.567216786615;5154.922676159786;5173.275741396133;5210.843674689765;4981.178105612534;4984.576311013604;4991.326170966873;4998.225275082368;5003.824866129668;4993;5030.8239211627415;5038.546530812245;5046.646734728533;5057.266696329085;4636.188666983197;4887.926681099858;4938.358013458371;4945.777440015136;4947.381577302837;4747.952520474751;4836.081144582518;4919.434265059564;4958.330625365674;5003.174476211384;4856.615864478606;4859.4654587996;4866.197077482176;4887.291342755351;4898.804047838046 14:49:54 INFO - PROCESS | 20941 | |5;yui.html;615.5260449453921;637.5282291104584;669.1969636436272;672.6132473827547;726.4878260826118;12155.513779448822;12823.61529154127;12967.935160324198;13003.934980325084;13100.934495327521;13571;14034.929825350859;14145;14214.147151170937;14363.569092927202;766.9731559395408;785.4305628419407;788.5465857132143;788.846174995876;789.6920201121567;633.8003528888408;650.2262307853639;758.8671982403085;759.8252401947556;761.2805898425989;794.5629903553051;795.1690483444814;795.2723258218723;802.9598520074002;812.975610731676;793.7936136604495;794.2811755361407;794.3565711773482;795.4551132474273;797.5613412623034;488.96577239593245;496.52829811678686;579.1949190625035;583.766493402638;586.0681516388962;12143.392830358534;12609.621711348675;12680.936595317056;12717.745645087047;12800;11886.167968242227;12182.329971851545;12335.691607709789;12397.380130993504;13240.86759132406;10425.426601536989;10455.68632941013;11692;11778.293302401798;12195.817062744067;3257.788243764148;3262.4943133814295;3323.96676033239;3373.662633736631;3503.1592417819793;58158;58307.70846145742;58509.41490585082;61164.330140191734;61543.99999999955;9450.57472413743;9491.810163796685;9545.570449329796;9752.171065459373;9877.209823214125;18126;18141.274349026156;18146.81853181451;18174;18229.361972330906;6697.598144111369;6853.485988550879;6884.621345826027;6893.138357705287;6903.275156108637;3830.578636349999;3858.401947698111;3941.5467221269346;3955.980220098881;3966.246413181544;2863.3414314707734;2952.6752057273684;2984.4031193761334;2990.0730773460295;2997.325601739591;469.7275580163497;477.33173557019757;479.6210993315312;479.7577223502109;489.54961435479447;560.7728869807735;566.1536003674534;588.8704485013291;619.0034045187244;624.4036944717784;7846.646900889359;8188.385871059694;8840.646374145092;8870.512121833232;8895.644174233088;597.1848426897254;618.9659568723673;626.283113606575;626.5927147354165;640.8910485217431;4119.19368974583;4147.668186545069;4222.662187025031;4304.634106100953;4372.191144638252;76717.61641191758;96368;99636.50181749045;106550;106550.46724766481;84725.57637211775;84731;86610;86677;87137.5643121793;47051.05897882092;60385;76519.61740191263;78023;78608;8088.312493438124;8232.50604963704;8410.789730256547;8490.23587877094;8506.532140732319;44500.55499444964;45943.77028114838;46600.06799863916;47321.526784731715;47681.761591191826;52151;58618.7069064669;65108.674456627414;66861;69218;11115.765118876643;11477.426128693698;11536;11599.6520104397;12120.696982575153;12696.619101426972;12844.614661560168;12969.481220751442;13202.669933251746;14030.508932187324;11631.47658355359;12117.394130293625;12164;12427.813582796447;12721.109522333349;10370.481475926023;11622.593209237973;12146.331951742739;12575.559855405018;12763.489460421479;11795.764084718428;11946.940265298617;11992.340421276913;12218.738838842557;12920.095593308379;10041.196704263788;10353.844692329772;10642.308249963728;10745.892541074802;11178.552857885594;9418.293627977791;9856.85214721794;10478.161747060369;10609.9469502652;10681.305715128492 14:49:54 INFO - PROCESS | 20941 | __end_tp_report 14:49:54 INFO - PROCESS | 20941 | __start_cc_report 14:49:54 INFO - PROCESS | 20941 | _x_x_mozilla_cycle_collect,1139 14:49:54 INFO - PROCESS | 20941 | __end_cc_report 14:49:54 INFO - PROCESS | 20941 | __startTimestamp1475185794220__endTimestamp 14:49:54 INFO - PROCESS | 20941 | 14:49:54 INFO - PROCESS | 20941 | ------- Summary: start ------- 14:49:54 INFO - PROCESS | 20941 | Number of tests: 6 14:49:54 INFO - PROCESS | 20941 | 14:49:54 INFO - PROCESS | 20941 | [#0] dojo.html Cycles:165 Average:4540.82 Median:4671.98 stddev:465.69 (10.0%) stddev-sans-first:439.40 14:49:54 INFO - PROCESS | 20941 | Values: 2523.3 2544.2 2570.4 2575.9 2596.9 4473.7 4556.7 4564.3 4565.3 4570.3 4519.2 4550.2 4551.5 4582.2 4587.4 4205.4 4240.8 4242.4 4245.6 4342.5 4263.1 4322.4 4323.7 4343.5 4357.7 4095.9 4114.5 4115.6 4233.1 4290.7 4227.2 4240.8 4241.5 4243.6 4244.3 4154.5 4167.2 4229.9 4238.0 4283.6 4482.7 4529.8 4553.6 4560.4 4613.8 4881.3 4890.4 4894.2 4900.6 4948.2 4782.5 4822.7 4894.4 4947.6 4954.4 4555.1 4606.5 4607.6 4611.8 4669.3 5014.7 5029.0 5030.4 5034.6 5089.1 4715.0 4782.0 4784.7 4837.1 4840.6 4889.7 4922.2 4923.3 4925.2 4929.0 4846.2 4876.6 4883.1 4900.1 4904.0 4771.2 4821.9 4825.9 4881.9 4908.0 4199.6 4244.4 4249.4 4250.9 4253.2 3624.4 3667.4 3701.4 3704.3 3726.5 4180.2 4246.6 4247.4 4248.4 4304.6 4890.0 4896.6 4904.1 4905.6 4906.0 4146.8 4205.0 4236.7 4267.4 4295.8 4446.5 4455.3 4504.5 4515.3 4516.2 4637.1 4647.0 4651.2 4701.9 4704.0 4772.3 4828.5 4909.9 4910.4 4912.1 4607.6 4629.3 4663.8 4672.0 4728.8 4854.8 4855.6 4864.1 4875.9 4893.2 4747.1 4919.5 4928.7 4934.4 4995.6 4737.7 4743.0 4785.4 4802.4 4850.8 4798.7 4802.4 4805.2 4808.1 4863.3 4713.6 4739.1 4741.5 4751.6 4790.9 4615.5 4691.8 4736.9 4764.0 4813.4 4714.9 4722.8 4722.9 4743.2 4780.2 14:49:54 INFO - PROCESS | 20941 | 14:49:54 INFO - PROCESS | 20941 | [#1] ext.html Cycles:180 Average:43086.86 Median:18706.91 stddev:81086.30 (433.5%) stddev-sans-first:81250.87 14:49:54 INFO - PROCESS | 20941 | Values: 546.4 557.5 558.1 567.6 569.9 27741.7 28776.9 30788.2 37264.8 38586.8 39656.2 40144.2 40163.2 40168.8 40255.0 7572.3 7731.0 7737.1 7739.9 7743.0 7538.1 7611.6 7612.5 7621.3 7628.3 7630.8 7674.0 7681.2 7681.6 7684.2 7589.5 7613.4 7619.6 7620.1 7622.9 7564.4 7624.2 7633.2 7635.6 7637.7 36781.8 37120.4 37120.8 37145.0 37152.6 3086.7 3139.0 3149.4 3406.4 3462.6 27860.3 27963.3 28307.4 28408.9 28576.3 3186.9 3221.1 3324.0 3380.6 3396.0 176428.8 179330.1 179465.0 180031.0 180362.0 29725.9 49763.0 50280.5 50315.2 50319.0 30638.4 32778.5 32790.3 32793.3 32795.2 12695.8 12871.4 12872.5 12874.8 12877.9 10193.4 10200.1 10213.4 10217.5 10218.5 7631.8 7640.3 7746.1 7752.3 7756.0 3014.6 3024.0 3042.2 3052.7 3076.2 876.3 900.8 901.4 916.4 964.9 26372.3 27051.0 27106.1 27981.3 28488.0 933.2 942.7 955.4 981.7 1000.5 13278.6 14226.1 14336.9 14407.0 14646.8 394646.0 397612.0 398750.0 399415.0 400904.0 46344.8 46781.5 46828.0 46892.0 46907.3 1048.4 1078.9 1111.6 1119.7 1137.5 25266.5 28320.2 28814.4 28865.3 28888.0 40188.8 40783.8 40840.0 40868.8 40889.2 297972.0 300011.0 300568.0 301208.0 301906.5 21367.8 21690.9 23290.3 23446.0 24185.0 37637.2 38342.0 38453.2 38501.8 38645.4 33476.0 33903.0 34369.7 34384.8 34416.8 33101.0 33526.3 33782.7 34017.8 34424.7 33085.5 33753.7 33760.5 34063.0 34093.7 30300.2 30549.4 31026.4 31301.5 31358.2 23871.6 24056.0 24183.2 24268.8 24395.3 14:49:54 INFO - PROCESS | 20941 | 14:49:54 INFO - PROCESS | 20941 | [#2] jquery.html Cycles:180 Average:22785.32 Median:26489.87 stddev:58665.05 (221.5%) stddev-sans-first:58805.42 14:49:54 INFO - PROCESS | 20941 | Values: 341.1 348.2 361.6 363.5 380.5 12428.4 15438.7 16022.2 16226.3 16357.8 15311.7 15508.8 15509.3 15763.5 15987.0 3671.3 4492.6 4618.9 4624.7 5102.9 4954.2 4990.8 5020.9 5036.3 5043.1 4842.4 5012.9 5023.4 5027.4 5028.2 5049.8 5058.5 5064.3 5065.1 5074.7 4466.9 4526.0 4577.7 4579.7 4582.8 18976.7 19397.9 19447.9 19689.9 19708.7 1806.2 1858.2 1878.9 2111.7 2308.8 8384.8 8803.1 9060.6 9167.1 9272.0 1587.9 1657.6 1663.4 1674.2 1736.3 65770.0 68216.0 68426.7 69186.7 70344.6 9327.9 9407.8 9498.3 9678.0 9732.3 12938.7 12997.7 13053.2 13066.7 13090.6 6267.7 6370.9 6384.7 6390.0 6416.9 5864.1 6161.1 6307.9 6311.5 6318.7 3903.4 3940.7 3990.1 4071.1 4145.4 1679.3 1736.1 1736.9 1757.2 1762.4 823.6 828.3 837.7 905.6 934.1 16007.8 16261.6 16309.2 16411.8 16981.7 849.0 866.4 870.2 879.0 910.1 8866.2 9416.2 9418.9 9456.2 9557.8 348680.0 353041.0 355656.0 355748.0 355912.0 71795.0 76016.0 76590.0 77346.2 77356.6 881.5 884.3 890.0 903.6 908.4 14264.1 14285.9 14404.7 14416.0 15066.2 34624.5 34916.5 35565.6 35839.3 36156.7 48355.0 48528.2 48719.0 49029.0 49404.3 7189.3 7334.6 7372.2 7413.7 7672.1 10741.3 11234.3 11537.9 11653.2 11674.2 9507.2 9934.3 9972.7 9990.3 10409.1 9710.3 10152.1 10207.9 10301.9 10342.1 9735.8 9940.8 10364.0 10508.9 10527.9 7387.8 7405.2 7477.6 7512.2 7976.4 9863.3 10046.2 10249.3 10265.6 10842.9 14:49:54 INFO - PROCESS | 20941 | 14:49:54 INFO - PROCESS | 20941 | [#3] mootools.html Cycles:180 Average:4844.68 Median:5094.95 stddev:2703.30 (53.1%) stddev-sans-first:2697.29 14:49:54 INFO - PROCESS | 20941 | Values: 1236.8 1316.0 1346.0 1384.6 1643.2 6445.3 6908.2 6929.2 7246.8 7247.7 7107.5 7442.8 7458.9 7468.1 7495.2 2034.1 2066.3 2066.6 2073.9 2076.8 2025.1 2055.0 2063.7 2070.4 2075.3 2055.5 2065.1 2076.7 2077.2 2078.3 1999.8 2009.2 2012.7 2017.2 2020.1 1980.6 1987.8 2018.6 2020.0 2024.3 6993.5 7227.6 7260.4 7332.2 7346.0 4190.7 4387.8 4394.8 4406.1 4407.7 2683.8 2760.3 2807.5 2815.0 2816.9 868.1 873.3 884.9 887.9 899.5 9825.4 10033.4 10038.2 10040.4 10043.1 3727.3 3864.5 3989.2 4027.1 4033.1 8509.7 8600.1 8625.1 8637.6 8639.3 4397.4 4446.8 4470.6 4472.0 4473.2 3546.4 3678.8 3940.1 4101.7 4101.7 3402.5 3427.1 3534.9 3558.6 3559.3 1160.4 1185.8 1186.6 1199.7 1206.5 738.9 761.1 762.5 780.5 781.6 4600.2 4644.5 4869.9 5188.8 5249.7 787.0 857.0 858.8 862.5 874.7 3122.9 3162.2 3221.0 3238.3 3532.4 8988.6 9017.6 9125.1 9209.7 9231.8 9119.7 9125.7 9153.7 9164.3 9172.9 6750.7 7009.0 7061.3 7062.5 7075.4 4924.9 4997.8 5065.1 5074.0 5115.9 7972.4 8252.8 8448.8 8450.3 8460.5 8145.2 8301.2 8341.6 8439.5 8460.6 6262.7 6439.5 6801.0 7128.8 7136.7 6743.4 6913.5 6950.2 7151.5 7158.5 6263.7 6298.3 6381.8 6387.6 6426.6 6232.7 6239.2 6362.1 6423.5 6534.5 5746.9 5879.1 5881.8 5883.0 5891.5 4237.2 4286.8 4287.2 4339.8 4392.4 4258.0 4295.1 4307.3 4396.5 4457.9 14:49:54 INFO - PROCESS | 20941 | 14:49:54 INFO - PROCESS | 20941 | [#4] prototype.html Cycles:180 Average:4121.49 Median:4683.60 stddev:1207.32 (25.8%) stddev-sans-first:1175.83 14:49:54 INFO - PROCESS | 20941 | Values: 283.5 283.8 291.3 291.6 292.1 4669.1 4698.1 4740.8 4745.3 4763.4 4438.1 4535.0 4560.7 4595.3 4699.1 3597.1 3608.7 3704.0 3711.5 3730.5 3705.6 3715.8 3720.6 3734.6 3738.8 3605.8 3697.5 3705.9 3712.4 3714.5 3661.5 3719.1 3725.1 3727.5 3747.8 3289.6 3289.7 3291.2 3294.9 3305.5 4610.3 4615.6 4631.4 4638.2 4639.0 4102.1 4174.7 4229.3 4252.9 4271.0 4898.9 4904.5 4908.0 4914.7 4923.6 3553.1 3556.5 3556.7 3558.0 3595.0 4940.3 5211.4 5226.0 5229.5 5239.7 3526.7 3543.1 3551.6 3555.2 3561.3 3604.5 3610.4 3616.2 3616.6 3617.0 4163.3 4187.9 4190.1 4197.3 4202.3 4843.8 4958.0 4984.4 5044.2 5066.9 1232.9 1247.5 1248.1 1249.2 1250.4 760.5 779.8 781.3 782.5 786.1 4263.5 4278.6 4408.4 4443.6 4465.2 5098.2 5099.8 5105.9 5109.8 5116.6 4268.7 4400.6 4413.6 4426.0 4434.1 2645.7 2678.1 2701.4 2708.0 2709.2 4853.8 4863.7 4871.8 4893.2 4900.1 4941.0 5192.1 5225.6 5263.5 5272.9 4832.9 4856.7 4874.8 4880.8 4893.7 5114.7 5132.5 5141.4 5174.8 5198.8 4841.7 4999.7 5025.7 5056.4 5091.9 4836.3 4850.9 4852.2 4859.2 4859.2 3582.7 3596.0 3596.5 3626.6 3626.9 4985.6 5091.6 5154.9 5173.3 5210.8 4981.2 4984.6 4991.3 4998.2 5003.8 4993.0 5030.8 5038.5 5046.6 5057.3 4636.2 4887.9 4938.4 4945.8 4947.4 4748.0 4836.1 4919.4 4958.3 5003.2 4856.6 4859.5 4866.2 4887.3 4898.8 14:49:54 INFO - PROCESS | 20941 | 14:49:54 INFO - PROCESS | 20941 | [#5] yui.html Cycles:180 Average:17681.45 Median:47501.64 stddev:25106.16 (52.9%) stddev-sans-first:25143.89 14:49:54 INFO - PROCESS | 20941 | Values: 615.5 637.5 669.2 672.6 726.5 12155.5 12823.6 12967.9 13003.9 13100.9 13571.0 14034.9 14145.0 14214.1 14363.6 767.0 785.4 788.5 788.8 789.7 633.8 650.2 758.9 759.8 761.3 794.6 795.2 795.3 803.0 813.0 793.8 794.3 794.4 795.5 797.6 489.0 496.5 579.2 583.8 586.1 12143.4 12609.6 12680.9 12717.7 12800.0 11886.2 12182.3 12335.7 12397.4 13240.9 10425.4 10455.7 11692.0 11778.3 12195.8 3257.8 3262.5 3324.0 3373.7 3503.2 58158.0 58307.7 58509.4 61164.3 61544.0 9450.6 9491.8 9545.6 9752.2 9877.2 18126.0 18141.3 18146.8 18174.0 18229.4 6697.6 6853.5 6884.6 6893.1 6903.3 3830.6 3858.4 3941.5 3956.0 3966.2 2863.3 2952.7 2984.4 2990.1 2997.3 469.7 477.3 479.6 479.8 489.5 560.8 566.2 588.9 619.0 624.4 7846.6 8188.4 8840.6 8870.5 8895.6 597.2 619.0 626.3 626.6 640.9 4119.2 4147.7 4222.7 4304.6 4372.2 76717.6 96368.0 99636.5 106550.0 106550.5 84725.6 84731.0 86610.0 86677.0 87137.6 47051.1 60385.0 76519.6 78023.0 78608.0 8088.3 8232.5 8410.8 8490.2 8506.5 44500.6 45943.8 46600.1 47321.5 47681.8 52151.0 58618.7 65108.7 66861.0 69218.0 11115.8 11477.4 11536.0 11599.7 12120.7 12696.6 12844.6 12969.5 13202.7 14030.5 11631.5 12117.4 12164.0 12427.8 12721.1 10370.5 11622.6 12146.3 12575.6 12763.5 11795.8 11946.9 11992.3 12218.7 12920.1 10041.2 10353.8 10642.3 10745.9 11178.6 9418.3 9856.9 10478.2 10609.9 10681.3 14:49:54 INFO - PROCESS | 20941 | -------- Summary: end -------- 14:49:54 INFO - PROCESS | 20941 | 14:49:55 INFO - TEST-INFO | 20941: exit 0 14:49:55 INFO - TEST-OK | dromaeo_css | took 1121514ms 14:49:55 INFO - TEST-START | kraken 14:49:55 INFO - operating with platform_type : linux_ 14:49:55 INFO - Initialising browser for kraken test... 14:49:55 INFO - TEST-INFO | started process 21257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHcxrYt/profile http://localhost:59416/getInfo.html) 14:50:00 INFO - PROCESS | 21257 | __metrics Screen width/height:1600/1200 14:50:00 INFO - PROCESS | 21257 | colorDepth:24 14:50:00 INFO - PROCESS | 21257 | Browser inner width/height: 1024/697 14:50:00 INFO - PROCESS | 21257 | __metrics 14:50:00 INFO - PROCESS | 21257 | 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" 14:50:00 INFO - PROCESS | 21257 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:50:01 INFO - PROCESS | 21257 | console.error: PushService: 14:50:01 INFO - PROCESS | 21257 | stateChangeProcessEnqueue: Error transitioning state 14:50:01 INFO - PROCESS | 21257 | UnknownError 14:50:02 INFO - TEST-INFO | 21257: exit 0 14:50:02 INFO - Browser initialized. 14:50:02 INFO - Running cycle 1/1 for kraken test... 14:50:02 INFO - TEST-INFO | started process 21338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHcxrYt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:50:14 INFO - PROCESS | 21338 | RSS: Main: 175558656 14:50:14 INFO - PROCESS | 21338 | 14:50:17 INFO - PROCESS | 21338 | Cycle 1(1): loaded http://localhost:59416/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59416/tests/kraken/driver.html?testName=audio-beat-detection) 14:50:18 INFO - PROCESS | 21338 | RSS: Main: 233738240 14:50:18 INFO - PROCESS | 21338 | 14:50:20 INFO - PROCESS | 21338 | Cycle 1(1): loaded http://localhost:59416/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59416/tests/kraken/driver.html?testName=audio-dft) 14:50:21 INFO - PROCESS | 21338 | RSS: Main: 218853376 14:50:21 INFO - PROCESS | 21338 | 14:50:24 INFO - PROCESS | 21338 | Cycle 1(1): loaded http://localhost:59416/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59416/tests/kraken/driver.html?testName=audio-fft) 14:50:25 INFO - PROCESS | 21338 | RSS: Main: 300896256 14:50:25 INFO - PROCESS | 21338 | 14:50:27 INFO - PROCESS | 21338 | Cycle 1(1): loaded http://localhost:59416/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59416/tests/kraken/driver.html?testName=audio-oscillator) 14:50:28 INFO - PROCESS | 21338 | RSS: Main: 210432000 14:50:28 INFO - PROCESS | 21338 | 14:50:30 INFO - PROCESS | 21338 | Cycle 1(1): loaded http://localhost:59416/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59416/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:50:30 INFO - PROCESS | 21338 | RSS: Main: 214339584 14:50:30 INFO - PROCESS | 21338 | 14:50:34 INFO - PROCESS | 21338 | Cycle 1(1): loaded http://localhost:59416/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59416/tests/kraken/driver.html?testName=imaging-darkroom) 14:50:34 INFO - PROCESS | 21338 | RSS: Main: 249978880 14:50:34 INFO - PROCESS | 21338 | 14:50:38 INFO - PROCESS | 21338 | Cycle 1(1): loaded http://localhost:59416/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59416/tests/kraken/driver.html?testName=imaging-desaturate) 14:50:38 INFO - PROCESS | 21338 | RSS: Main: 250748928 14:50:38 INFO - PROCESS | 21338 | 14:50:41 INFO - PROCESS | 21338 | Cycle 1(1): loaded http://localhost:59416/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59416/tests/kraken/driver.html?testName=json-parse-financial) 14:50:42 INFO - PROCESS | 21338 | RSS: Main: 249872384 14:50:42 INFO - PROCESS | 21338 | 14:50:44 INFO - PROCESS | 21338 | Cycle 1(1): loaded http://localhost:59416/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59416/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:50:44 INFO - PROCESS | 21338 | RSS: Main: 212283392 14:50:44 INFO - PROCESS | 21338 | 14:50:46 INFO - PROCESS | 21338 | Cycle 1(1): loaded http://localhost:59416/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59416/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:50:47 INFO - PROCESS | 21338 | RSS: Main: 219361280 14:50:47 INFO - PROCESS | 21338 | 14:50:49 INFO - PROCESS | 21338 | Cycle 1(1): loaded http://localhost:59416/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59416/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:50:50 INFO - PROCESS | 21338 | RSS: Main: 223551488 14:50:50 INFO - PROCESS | 21338 | 14:50:52 INFO - PROCESS | 21338 | Cycle 1(1): loaded http://localhost:59416/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:50:53 INFO - PROCESS | 21338 | RSS: Main: 224657408 14:50:53 INFO - PROCESS | 21338 | 14:50:56 INFO - PROCESS | 21338 | Cycle 1(1): loaded http://localhost:59416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:50:57 INFO - PROCESS | 21338 | RSS: Main: 222674944 14:50:57 INFO - PROCESS | 21338 | 14:50:58 INFO - PROCESS | 21338 | Cycle 1(1): loaded http://localhost:59416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59416/tests/kraken/driver.html?testName=ai-astar) 14:50:59 INFO - PROCESS | 21338 | RSS: Main: 273301504 14:50:59 INFO - PROCESS | 21338 | 14:50:59 INFO - PROCESS | 21338 | __start_tp_report 14:50:59 INFO - PROCESS | 21338 | _x_x_mozilla_page_load 14:50:59 INFO - PROCESS | 21338 | _x_x_mozilla_page_load_details 14:50:59 INFO - PROCESS | 21338 | |i|pagename|runs| 14:50:59 INFO - PROCESS | 21338 | |0;ai-astar;113;116;116;115;117;114;114;118;115;114 14:50:59 INFO - PROCESS | 21338 | |1;audio-beat-detection;150;127;122;178;123;125;125;126;160;129 14:50:59 INFO - PROCESS | 21338 | |2;audio-dft;163;162;163;164;161;162;161;160;161;160 14:50:59 INFO - PROCESS | 21338 | |3;audio-fft;76;78;77;103;76;79;80;77;108;78 14:50:59 INFO - PROCESS | 21338 | |4;audio-oscillator;84;85;130;83;84;84;107;86;86;110 14:50:59 INFO - PROCESS | 21338 | |5;imaging-gaussian-blur;117;117;117;117;116;118;117;117;117;117 14:50:59 INFO - PROCESS | 21338 | |6;imaging-darkroom;147;147;147;146;146;148;146;146;146;147 14:50:59 INFO - PROCESS | 21338 | |7;imaging-desaturate;95;96;95;96;96;95;96;95;95;95 14:50:59 INFO - PROCESS | 21338 | |8;json-parse-financial;64;71;62;62;64;63;63;63;63;63 14:50:59 INFO - PROCESS | 21338 | |9;json-stringify-tinderbox;66;66;67;66;66;66;65;67;66;67 14:50:59 INFO - PROCESS | 21338 | |10;stanford-crypto-aes;83;92;82;86;83;83;82;88;83;83 14:50:59 INFO - PROCESS | 21338 | |11;stanford-crypto-ccm;139;144;134;134;133;135;132;136;174;140 14:50:59 INFO - PROCESS | 21338 | |12;stanford-crypto-pbkdf2;173;175;172;176;173;174;171;176;178;174 14:50:59 INFO - PROCESS | 21338 | |13;stanford-crypto-sha256-iterative;69;68;70;70;72;72;69;68;68;66 14:50:59 INFO - PROCESS | 21338 | __end_tp_report 14:50:59 INFO - PROCESS | 21338 | __start_cc_report 14:50:59 INFO - PROCESS | 21338 | _x_x_mozilla_cycle_collect,1926 14:50:59 INFO - PROCESS | 21338 | __end_cc_report 14:50:59 INFO - PROCESS | 21338 | __startTimestamp1475185859159__endTimestamp 14:50:59 INFO - PROCESS | 21338 | 14:50:59 INFO - PROCESS | 21338 | ------- Summary: start ------- 14:50:59 INFO - PROCESS | 21338 | Number of tests: 14 14:50:59 INFO - PROCESS | 21338 | 14:50:59 INFO - PROCESS | 21338 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.50 stddev:1.55 (1.3%) stddev-sans-first:1.42 14:50:59 INFO - PROCESS | 21338 | Values: 113.0 116.0 116.0 115.0 117.0 114.0 114.0 118.0 115.0 114.0 14:50:59 INFO - PROCESS | 21338 | 14:50:59 INFO - PROCESS | 21338 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:128.00 stddev:19.35 (15.1%) stddev-sans-first:19.90 14:50:59 INFO - PROCESS | 21338 | Values: 150.0 127.0 122.0 178.0 123.0 125.0 125.0 126.0 160.0 129.0 14:50:59 INFO - PROCESS | 21338 | 14:50:59 INFO - PROCESS | 21338 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.34 (0.8%) stddev-sans-first:1.33 14:50:59 INFO - PROCESS | 21338 | Values: 163.0 162.0 163.0 164.0 161.0 162.0 161.0 160.0 161.0 160.0 14:50:59 INFO - PROCESS | 21338 | 14:50:59 INFO - PROCESS | 21338 | [#3] audio-fft Cycles:10 Average:83.20 Median:77.50 stddev:11.88 (15.3%) stddev-sans-first:12.31 14:50:59 INFO - PROCESS | 21338 | Values: 76.0 78.0 77.0 103.0 76.0 79.0 80.0 77.0 108.0 78.0 14:50:59 INFO - PROCESS | 21338 | 14:50:59 INFO - PROCESS | 21338 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:84.00 stddev:16.16 (19.2%) stddev-sans-first:16.74 14:50:59 INFO - PROCESS | 21338 | Values: 84.0 85.0 130.0 83.0 84.0 84.0 107.0 86.0 86.0 110.0 14:50:59 INFO - PROCESS | 21338 | 14:50:59 INFO - PROCESS | 21338 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 14:50:59 INFO - PROCESS | 21338 | Values: 117.0 117.0 117.0 117.0 116.0 118.0 117.0 117.0 117.0 117.0 14:50:59 INFO - PROCESS | 21338 | 14:50:59 INFO - PROCESS | 21338 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 14:50:59 INFO - PROCESS | 21338 | Values: 147.0 147.0 147.0 146.0 146.0 148.0 146.0 146.0 146.0 147.0 14:50:59 INFO - PROCESS | 21338 | 14:50:59 INFO - PROCESS | 21338 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:50:59 INFO - PROCESS | 21338 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 14:50:59 INFO - PROCESS | 21338 | 14:50:59 INFO - PROCESS | 21338 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:63.00 stddev:2.62 (4.2%) stddev-sans-first:2.77 14:50:59 INFO - PROCESS | 21338 | Values: 64.0 71.0 62.0 62.0 64.0 63.0 63.0 63.0 63.0 63.0 14:50:59 INFO - PROCESS | 21338 | 14:50:59 INFO - PROCESS | 21338 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 14:50:59 INFO - PROCESS | 21338 | Values: 66.0 66.0 67.0 66.0 66.0 66.0 65.0 67.0 66.0 67.0 14:50:59 INFO - PROCESS | 21338 | 14:50:59 INFO - PROCESS | 21338 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:83.00 stddev:3.24 (3.9%) stddev-sans-first:3.39 14:50:59 INFO - PROCESS | 21338 | Values: 83.0 92.0 82.0 86.0 83.0 83.0 82.0 88.0 83.0 83.0 14:50:59 INFO - PROCESS | 21338 | 14:50:59 INFO - PROCESS | 21338 | [#11] stanford-crypto-ccm Cycles:10 Average:140.10 Median:137.50 stddev:12.47 (9.1%) stddev-sans-first:13.22 14:50:59 INFO - PROCESS | 21338 | Values: 139.0 144.0 134.0 134.0 133.0 135.0 132.0 136.0 174.0 140.0 14:50:59 INFO - PROCESS | 21338 | 14:50:59 INFO - PROCESS | 21338 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:174.50 stddev:2.10 (1.2%) stddev-sans-first:2.18 14:50:59 INFO - PROCESS | 21338 | Values: 173.0 175.0 172.0 176.0 173.0 174.0 171.0 176.0 178.0 174.0 14:50:59 INFO - PROCESS | 21338 | 14:50:59 INFO - PROCESS | 21338 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.87 (2.7%) stddev-sans-first:1.99 14:50:59 INFO - PROCESS | 21338 | Values: 69.0 68.0 70.0 70.0 72.0 72.0 69.0 68.0 68.0 66.0 14:50:59 INFO - PROCESS | 21338 | -------- Summary: end -------- 14:50:59 INFO - PROCESS | 21338 | 14:51:00 INFO - TEST-INFO | 21338: exit 0 14:51:00 INFO - TEST-OK | kraken | took 65312ms 14:51:00 INFO - SUITE-END | took 1186s 14:51:00 INFO - Completed test suite (00:19:47) 14:51:00 INFO - javascript benchmark 14:51:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2523.2808649534886, 2544.2112944987043, 2570.3702592864747, 2575.9484810303793, 2596.909108181214, 4473.66447516436, 4556.749378784166, 4564.338170965208, 4565.2923796811465, 4570.268756998881, 4519.163954668388, 4550.180967425862, 4551.522090180525, 4582.198115329812, 4587.42657167854, 4205.432266644009, 4240.787960601973, 4242.406063151161, 4245.596668316505, 4342.544032876534, 4263.126059157865, 4322.373255877896, 4323.654107671378, 4343.543927887558, 4357.716748411359, 4095.9180816383505, 4114.506259248909, 4115.609017143366, 4233.1322078973735, 4290.678199135077, 4227.154569086164, 4240.830366785325, 4241.49102107746, 4243.596858298457, 4244.257254980397, 4154.5222299435645, 4167.249895018896, 4229.936550951707, 4238.046439551076, 4283.571642835723, 4482.731036137842, 4529.818807247706, 4553.590176884097, 4560.361549383089, 4613.76931153441, 4881.316615673809, 4890.413150421937, 4894.1679914414635, 4900.607951363882, 4948.233023881304, 4782.473927867932, 4822.71063736177, 4894.4371397289415, 4947.604191664658, 4954.43024052235, 4555.111753208159, 4606.516315786827, 4607.562281583244, 4611.792469338888, 4669.2996050592, 5014.674046186986, 5029.044481548567, 5030.4215015272985, 5034.622403319766, 5089.083964886356, 4715.0, 4781.95218047822, 4784.6889952153, 4837.129316723023, 4840.636952228527, 4889.657723959289, 4922.163232250526, 4923.310736496894, 4925.236588328815, 4929.0388374267395, 4846.224604063404, 4876.634252431082, 4883.121038213156, 4900.117978763786, 4903.975480122576, 4771.188897887368, 4821.879453013703, 4825.879353016133, 4881.902361952741, 4907.975460122677, 4199.643030342455, 4244.3633454982, 4249.3625956106835, 4250.936235956463, 4253.191893540217, 3624.3657359961903, 3667.431548110047, 3701.3892707703467, 3704.333220020368, 3726.4596633488536, 4180.16396720651, 4246.554111818276, 4247.362895565628, 4248.383984322256, 4304.634106100953, 4889.951100489021, 4896.608271338285, 4904.141775189399, 4905.558499735041, 4906.0, 4146.771927544014, 4204.978975105105, 4236.661067114624, 4267.445232119804, 4295.785210739513, 4446.466424029137, 4455.331700244924, 4504.527024662429, 4515.277555591089, 4516.187086324428, 4637.095766325534, 4646.97676511622, 4651.209294419957, 4701.858944231679, 4704.035672687022, 4772.284157376422, 4828.5412885775795, 4909.852704418873, 4910.43529994041, 4912.091263116335, 4607.562281583244, 4629.328747331685, 4663.790129444115, 4671.976640116914, 4728.810847566197, 4854.805807767791, 4855.587275081658, 4864.148773964613, 4875.853724388274, 4893.192623217129, 4747.112940861755, 4919.4834542373965, 4928.654994150375, 4934.383202099738, 4995.550400463976, 4737.715737055788, 4742.976285118552, 4785.425748910153, 4802.423709154924, 4850.7817148227705, 4798.664093513421, 4802.399700037496, 4805.207140821725, 4808.110499557593, 4863.294822250825, 4713.599344055794, 4739.075880203465, 4741.454732705645, 4751.619870410428, 4790.880227994328, 4615.515370886009, 4691.835785747482, 4736.881577960578, 4763.952360476351, 4813.3983252093485, 4714.892000379977, 4722.7874745635845, 4722.858314250578, 4743.169945259635, 4780.211265141352], "value": 4511.445976805381, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.3907742866702, 557.5261028126096, 558.0540983033757, 567.5658121537025, 569.9259096317479, 27741.722582774193, 28776.85611571942, 30788.230294242654, 37264.81367593158, 38586.8070659647, 39656.20687586254, 40144.19711605766, 40163.19673606526, 40168.79915600418, 40255.0, 7572.318491335779, 7731.0, 7737.110232323271, 7739.922600774004, 7743.0, 7538.133114691798, 7611.619419029026, 7612.505187162845, 7621.314081732643, 7628.313451789338, 7630.7710768677025, 7673.9616301918695, 7681.155072941972, 7681.57751323677, 7684.231576842327, 7589.468737188399, 7613.42899282556, 7619.5809230492305, 7620.08558972924, 7622.923770762277, 7564.394848412169, 7624.199459056775, 7633.198514155989, 7635.580043097628, 7637.732679356196, 36781.816090919376, 37120.44319335212, 37120.814395927846, 37145.0, 37152.62847371546, 3086.722195002438, 3139.0425920094362, 3149.4173577888164, 3406.42090844557, 3462.6018007928906, 27860.303492412648, 27963.300917477227, 28307.433851323065, 28408.85795571009, 28576.28559286014, 3186.888458903927, 3221.1463962050075, 3323.9501407478906, 3380.6281309055985, 3396.0, 176428.82499112468, 179330.10334948372, 179465.0, 180031.0, 180362.0, 29725.946589079907, 49763.0, 50280.497195028314, 50315.24527132023, 50319.0, 30638.38723225523, 32778.508322375186, 32790.34419311648, 32793.34413311721, 32795.1801204967, 12695.809562856564, 12871.42078606465, 12872.485100596059, 12874.806877896839, 12877.871221287667, 10193.388396696222, 10200.132988696045, 10213.387196768217, 10217.540210690537, 10218.489075546193, 7631.809204769814, 7640.274173953466, 7746.147923728386, 7752.26353496417, 7756.0, 3014.623172103487, 3023.9697603023687, 3042.2242328206607, 3052.664206937235, 3076.230942264434, 876.3427429427929, 900.8243392538392, 901.3555307954844, 916.3722849847876, 964.8793900762405, 26372.340691482867, 27051.0, 27106.087947573636, 27981.300467488476, 28488.0, 933.1974501928336, 942.6559305853314, 955.441066975813, 981.6613268422383, 1000.5242267655295, 13278.601641950758, 14226.14643121416, 14336.85663143376, 14407.0, 14646.780298295535, 394646.0, 397612.0, 398750.0, 399415.0, 400904.0, 46344.755867089654, 46781.5321846784, 46828.0, 46892.0, 46907.29639055417, 1048.3709774135305, 1078.8705355357408, 1111.627604752417, 1119.6864877834219, 1137.4881303413663, 25266.494670106862, 28320.15039548817, 28814.423711526073, 28865.278368040967, 28888.0, 40188.79905600454, 40783.796081019405, 40840.0, 40868.79565602153, 40889.18221635491, 297972.0, 300011.0, 300568.0, 301208.0, 301906.4904675463, 21367.786322137203, 21690.89154554217, 23290.3012909613, 23446.0, 24185.0, 37637.24725505529, 38342.0, 38453.230935380576, 38501.80749096349, 38645.420318695804, 33476.0, 33903.0, 34369.656303437645, 34384.82807585946, 34416.82791586026, 33101.0, 33526.329473410886, 33782.662173378936, 34017.82991085029, 34424.6641770526, 33085.50371744474, 33753.662463375054, 33760.49359259564, 34063.0, 34093.69266685671, 30300.242493936945, 30549.389012220076, 31026.379472409975, 31301.530477042408, 31358.216044599067, 23871.641925370786, 24056.0, 24183.15358962428, 24268.75731242665, 24395.26814195577], "value": 15677.358530363923, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.1011983423678, 348.16614208969503, 361.6401680328073, 363.5201533975153, 380.46544604830206, 12428.440720167591, 15438.691226175484, 16022.19889005551, 16226.269817858196, 16357.83642163578, 15311.69376612467, 15508.767368489454, 15509.302081406335, 15763.527094187193, 15987.0, 3671.3391589513876, 4492.640588752892, 4618.930716039262, 4624.745638989854, 5102.897942041157, 4954.207326827708, 4990.750462476862, 5020.924686129711, 5036.269740887569, 5043.142665746814, 4842.418909730837, 5012.899742005157, 5023.422306434771, 5027.371578552681, 5028.170351891952, 5049.8485045448515, 5058.494150584949, 5064.341635587369, 5065.11360511909, 5074.695518268879, 4466.9106617867465, 4526.0495295987885, 4577.702449340783, 4579.7252164870215, 4582.793774280165, 18976.715349269773, 19397.903010485, 19447.90276048625, 19689.901550492155, 19708.70436943447, 1806.223323970692, 1858.1823997441084, 1878.8966606836618, 2111.7125691511437, 2308.8225005247277, 8384.813352780438, 8803.119688031209, 9060.637574497012, 9167.083291670846, 9272.0, 1587.8809089318231, 1657.5690320516753, 1663.3679201903321, 1674.196385734842, 1736.3488691740597, 65770.0, 68216.0, 68426.65786671084, 69186.65406672934, 70344.6482767588, 9327.860082098638, 9407.764805879908, 9498.287628427757, 9678.0, 9732.318737688436, 12938.741225175443, 12997.740045199043, 13053.216806991612, 13066.738665226832, 13090.607281781562, 6267.655278959701, 6370.904436433457, 6384.744610215539, 6389.968050159812, 6416.903746443807, 5864.091065884794, 6161.137440758297, 6307.9369206308265, 6311.526635502356, 6318.652474113968, 3903.375459926398, 3940.7241493095207, 3990.144582768968, 4071.0840060986634, 4145.3781932709735, 1679.2695177597784, 1736.0798776648396, 1736.9044702541482, 1757.1829099468807, 1762.3919747687028, 823.555280148713, 828.3125006244802, 837.6691206973211, 905.6151135767273, 934.0566028311455, 16007.759883601755, 16261.59346016359, 16309.18454077315, 16411.753823692656, 16981.745273820903, 848.9830203395898, 866.3545658484469, 870.2211520688948, 878.9780255493536, 910.1126401758232, 8866.246369058703, 9416.152546270732, 9418.905810941802, 9456.196223320958, 9557.808843823224, 348680.0, 353041.0, 355656.0, 355748.0, 355912.0, 71795.0, 76016.0, 76590.0, 77346.2265377339, 77356.61321693356, 881.4789701453836, 884.2616415293173, 889.9777505562413, 903.5572569441058, 908.3641450984337, 14264.144151350953, 14285.857141428452, 14404.711905761616, 14416.044710834045, 15066.246687665793, 34624.48063279002, 34916.47625285674, 35565.644343557266, 35839.283214335046, 36156.74589286977, 48355.0, 48528.206051153575, 48719.0, 49029.0, 49404.258936116705, 7189.281071892978, 7334.596597187206, 7372.189059203376, 7413.66638501258, 7672.117706463605, 10741.301815381976, 11234.269772464764, 11537.884621154017, 11653.242539234923, 11674.241174323643, 9507.191888689538, 9934.254930880357, 9972.700818975442, 9990.250731195334, 10409.115225205942, 9710.320277580502, 10152.137068348977, 10207.948960255448, 10301.9484902575, 10342.069213770797, 9735.756606084904, 9940.801183976424, 10363.962380065206, 10508.894911050791, 10527.894721052691, 7387.783664900616, 7405.222451642716, 7477.588732619541, 7512.173660897188, 7976.361891048586, 9863.260255480724, 10046.246531510313, 10249.282550221413, 10265.640702575673, 10842.945785271024], "value": 7815.789386647399, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1236.758832027755, 1316.019565423759, 1345.9528916487923, 1384.5569417786312, 1643.1948345310802, 6445.323241059686, 6908.171019477657, 6929.168499780028, 7246.7825965221, 7247.710091596343, 7107.502474826764, 7442.813929651761, 7458.88811667824, 7468.141163766169, 7495.175530691633, 2034.128601686452, 2066.2561477867957, 2066.6486697261503, 2073.9170433182653, 2076.802703743142, 2025.1291944463874, 2055.0238636647623, 2063.7420322459693, 2070.420282320945, 2075.335892514396, 2055.4553043443498, 2065.09135980169, 2076.6677331626943, 2077.1898959405844, 2078.251829341436, 1999.8100180482832, 2009.1762377425187, 2012.738344015276, 2017.2334512885157, 2020.0606717876112, 1980.6137803128395, 1987.7515310586177, 2018.6164628720496, 2019.9596008079757, 2024.2914979757115, 6993.545419547713, 7227.638618069128, 7260.38286745622, 7332.156801967789, 7346.0, 4190.706650534464, 4387.846425375096, 4394.758288294142, 4406.09675016624, 4407.713498622579, 2683.8121331506804, 2760.30992251937, 2807.4806160860308, 2814.957775633367, 2816.887324507017, 868.1362044765499, 873.2882700598991, 884.920357167858, 887.8756974023642, 899.4603238057178, 9825.361351512129, 10033.448160351178, 10038.196944244515, 10040.447775372351, 10043.14633256174, 3727.2731817295366, 3864.4589757433982, 3989.2420440116284, 4027.0536423940935, 4033.1328764315813, 8509.70216042448, 8600.096989816104, 8625.0943650917, 8637.611307491177, 8639.265662418638, 4397.384366188736, 4446.755428451466, 4470.575295346936, 4471.977640111779, 4473.217186992329, 3546.4325707886615, 3678.8160591970295, 3940.133170702441, 4101.666958238585, 4101.692373072032, 3402.4556071028514, 3427.074689833731, 3534.8688419705963, 3558.6085530591613, 3559.341521818472, 1160.3560024186656, 1185.8221266810046, 1186.5609724402027, 1199.6940780101017, 1206.4631239098692, 738.8854727517244, 761.1437133225122, 762.4967521435826, 780.4536824223067, 781.5935713428985, 4600.171969045537, 4644.489106198315, 4869.902601947942, 5188.818391356284, 5249.685018898878, 786.9960650196826, 857.0443954990266, 858.8368210040197, 862.5040601654074, 874.7157173918501, 3122.859471323796, 3162.2094476380903, 3221.0, 3238.2875767331147, 3532.434810430319, 8988.595513201792, 9017.63929442828, 9125.133112354315, 9209.677661281823, 9231.815363692689, 9119.726408207764, 9125.726228213165, 9153.725388238363, 9164.266858651292, 9172.908270917338, 6750.662466876636, 7009.0, 7061.258567850302, 7062.470314726416, 7075.363217310364, 4924.852254432372, 4997.825076122318, 5065.062963351792, 5073.974630126826, 5115.9232611510115, 7972.441929064909, 8252.752417427488, 8448.788780280296, 8450.281726053354, 8460.492370457792, 8145.185481451807, 8301.169883011651, 8341.624626891684, 8439.451435656663, 8460.619272132892, 6262.655553944577, 6439.517036222396, 6800.965995169992, 7128.786136415916, 7136.6788494518905, 6743.393094621508, 6913.516053876381, 6950.165980082423, 7151.53515021522, 7158.463115266271, 6263.749450021948, 6298.307186209605, 6381.776637817654, 6387.648679322682, 6426.582272152295, 6232.719527621177, 6239.1577137085915, 6362.109304697438, 6423.518236132215, 6534.509911756732, 5746.885062298814, 5879.059350503899, 5881.7647294107755, 5882.970585147047, 5891.528677705859, 4237.216115018731, 4286.80709368073, 4287.185434767384, 4339.761313127682, 4392.363107349481, 4257.957420425756, 4295.076558539929, 4307.310830267143, 4396.49440314368, 4457.866264012085], "value": 3910.367545740508, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.52084976389887, 283.76872848628363, 291.2529362185994, 291.58740382358957, 292.14838745058154, 4669.089527542131, 4698.107359601673, 4740.834070807522, 4745.288206768986, 4763.356946812175, 4438.134563760068, 4534.954650453495, 4560.696848091718, 4595.3107033944925, 4699.0865663288805, 3597.136687195074, 3608.747387682863, 3703.9814800925956, 3711.498947642074, 3730.5150330457004, 3705.5738590062083, 3715.814209289538, 3720.6465385788442, 3734.5705243897028, 3738.7943663098517, 3605.801680907549, 3697.482352470656, 3705.907352316187, 3712.350338690732, 3714.53568303962, 3661.4873917651416, 3719.1260053887313, 3725.068732816796, 3727.5340582427198, 3747.8126093695478, 3289.5559099521497, 3289.7039266465895, 3291.1607540077366, 3294.8682052717863, 3305.520699498559, 4610.331501932201, 4615.630749540029, 4631.3516107744945, 4638.165130276549, 4639.025804581042, 4102.138550904314, 4174.749515029078, 4229.302165142779, 4252.893677658052, 4270.957290427087, 4898.926516102261, 4904.53406926345, 4907.975460122712, 4914.68054576455, 4923.606111511071, 3553.1472446612884, 3556.5020897074173, 3556.715462762973, 3557.964420355789, 3595.0, 4940.2709051831935, 5211.436569029314, 5225.973870130663, 5229.50319719626, 5239.711815850127, 3526.7480044584318, 3543.114221444639, 3551.614870200624, 3555.2000799819834, 3561.3411518869093, 3604.540161234704, 3610.3681855675677, 3616.240589476187, 3616.553378648509, 3616.9819150904605, 4163.333866581333, 4187.91624167515, 4190.078182799779, 4197.286461301525, 4202.306619407825, 4843.75781210938, 4957.958828645953, 4984.42679091909, 5044.192929131322, 5066.949330506648, 1232.9198602090835, 1247.5197049136148, 1248.076423446661, 1249.2254802022621, 1250.3748125937032, 760.5360729954723, 779.8167430653792, 781.2773184804147, 782.5383024015858, 786.1352512236494, 4263.488381394252, 4278.593533614302, 4408.404865343137, 4443.600075993111, 4465.151621191963, 5098.1842905135, 5099.796008159707, 5105.897882042338, 5109.846704598794, 5116.590672746172, 4268.701190916606, 4400.581944715247, 4413.6248418884115, 4425.977870110629, 4434.13534360803, 2645.7486538778785, 2678.1028355501126, 2701.405690748032, 2707.9593806092926, 2709.214327844942, 4853.805847766121, 4863.7324947128245, 4871.80512779492, 4893.241547560134, 4900.117978763786, 4940.950590494121, 5192.091384007859, 5225.555827754607, 5263.473652634706, 5272.888995492601, 4832.9275060874115, 4856.660033797671, 4874.756262186947, 4880.804767809248, 4893.657443978887, 5114.718690471911, 5132.5124113209185, 5141.380465153614, 5174.844754657366, 5198.844034678966, 4841.733704646137, 4999.65002449825, 5025.673331233458, 5056.418511871182, 5091.898162036812, 4836.258946779227, 4850.902981940412, 4852.199387101089, 4859.198232291632, 4859.246816743411, 3582.659647333499, 3596.0, 3596.5144705464427, 3626.5829429615933, 3626.9455958161175, 4985.5762260208285, 5091.567216786615, 5154.922676159786, 5173.275741396133, 5210.843674689765, 4981.178105612534, 4984.576311013604, 4991.326170966873, 4998.225275082368, 5003.824866129668, 4993.0, 5030.8239211627415, 5038.546530812245, 5046.646734728533, 5057.266696329085, 4636.188666983197, 4887.926681099858, 4938.358013458371, 4945.777440015136, 4947.381577302837, 4747.952520474751, 4836.081144582518, 4919.434265059564, 4958.330625365674, 5003.174476211384, 4856.615864478606, 4859.4654587996, 4866.197077482176, 4887.291342755351, 4898.804047838046], "value": 3730.5071653945765, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.5260449453921, 637.5282291104584, 669.1969636436272, 672.6132473827547, 726.4878260826118, 12155.513779448822, 12823.61529154127, 12967.935160324198, 13003.934980325084, 13100.934495327521, 13571.0, 14034.929825350859, 14145.0, 14214.147151170937, 14363.569092927202, 766.9731559395408, 785.4305628419407, 788.5465857132143, 788.846174995876, 789.6920201121567, 633.8003528888408, 650.2262307853639, 758.8671982403085, 759.8252401947556, 761.2805898425989, 794.5629903553051, 795.1690483444814, 795.2723258218723, 802.9598520074002, 812.975610731676, 793.7936136604495, 794.2811755361407, 794.3565711773482, 795.4551132474273, 797.5613412623034, 488.96577239593245, 496.52829811678686, 579.1949190625035, 583.766493402638, 586.0681516388962, 12143.392830358534, 12609.621711348675, 12680.936595317056, 12717.745645087047, 12800.0, 11886.167968242227, 12182.329971851545, 12335.691607709789, 12397.380130993504, 13240.86759132406, 10425.426601536989, 10455.68632941013, 11692.0, 11778.293302401798, 12195.817062744067, 3257.788243764148, 3262.4943133814295, 3323.96676033239, 3373.662633736631, 3503.1592417819793, 58158.0, 58307.70846145742, 58509.41490585082, 61164.330140191734, 61543.99999999955, 9450.57472413743, 9491.810163796685, 9545.570449329796, 9752.171065459373, 9877.209823214125, 18126.0, 18141.274349026156, 18146.81853181451, 18174.0, 18229.361972330906, 6697.598144111369, 6853.485988550879, 6884.621345826027, 6893.138357705287, 6903.275156108637, 3830.578636349999, 3858.401947698111, 3941.5467221269346, 3955.980220098881, 3966.246413181544, 2863.3414314707734, 2952.6752057273684, 2984.4031193761334, 2990.0730773460295, 2997.325601739591, 469.7275580163497, 477.33173557019757, 479.6210993315312, 479.7577223502109, 489.54961435479447, 560.7728869807735, 566.1536003674534, 588.8704485013291, 619.0034045187244, 624.4036944717784, 7846.646900889359, 8188.385871059694, 8840.646374145092, 8870.512121833232, 8895.644174233088, 597.1848426897254, 618.9659568723673, 626.283113606575, 626.5927147354165, 640.8910485217431, 4119.19368974583, 4147.668186545069, 4222.662187025031, 4304.634106100953, 4372.191144638252, 76717.61641191758, 96368.0, 99636.50181749045, 106550.0, 106550.46724766481, 84725.57637211775, 84731.0, 86610.0, 86677.0, 87137.5643121793, 47051.05897882092, 60385.0, 76519.61740191263, 78023.0, 78608.0, 8088.312493438124, 8232.50604963704, 8410.789730256547, 8490.23587877094, 8506.532140732319, 44500.55499444964, 45943.77028114838, 46600.06799863916, 47321.526784731715, 47681.761591191826, 52151.0, 58618.7069064669, 65108.674456627414, 66861.0, 69218.0, 11115.765118876643, 11477.426128693698, 11536.0, 11599.6520104397, 12120.696982575153, 12696.619101426972, 12844.614661560168, 12969.481220751442, 13202.669933251746, 14030.508932187324, 11631.47658355359, 12117.394130293625, 12164.0, 12427.813582796447, 12721.109522333349, 10370.481475926023, 11622.593209237973, 12146.331951742739, 12575.559855405018, 12763.489460421479, 11795.764084718428, 11946.940265298617, 11992.340421276913, 12218.738838842557, 12920.095593308379, 10041.196704263788, 10353.844692329772, 10642.308249963728, 10745.892541074802, 11178.552857885594, 9418.293627977791, 9856.85214721794, 10478.161747060369, 10609.9469502652, 10681.305715128492], "value": 6583.873744643339, "unit": "score"}], "name": "dromaeo_css", "value": 6130.737621273155, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 116.0, 115.0, 117.0, 114.0, 114.0, 118.0, 115.0, 114.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 127.0, 122.0, 178.0, 123.0, 125.0, 125.0, 126.0, 160.0, 129.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 164.0, 161.0, 162.0, 161.0, 160.0, 161.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 103.0, 76.0, 79.0, 80.0, 77.0, 108.0, 78.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 130.0, 83.0, 84.0, 84.0, 107.0, 86.0, 86.0, 110.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 62.0, 62.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 65.0, 67.0, 66.0, 67.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 92.0, 82.0, 86.0, 83.0, 83.0, 82.0, 88.0, 83.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 144.0, 134.0, 134.0, 133.0, 135.0, 132.0, 136.0, 174.0, 140.0], "value": 140.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 172.0, 176.0, 173.0, 174.0, 171.0, 176.0, 178.0, 174.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 70.0, 70.0, 72.0, 72.0, 69.0, 68.0, 68.0, 66.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1547.5, "alertThreshold": 2.0}]} 14:51:00 INFO - Return code: 0 14:51:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:51:00 INFO - # TBPL SUCCESS # 14:51:00 INFO - Running post-action listener: _resource_record_post_action 14:51:00 INFO - [mozharness: 2016-09-29 21:51:00.988339Z] Finished run-tests step (success) 14:51:00 INFO - Running post-run listener: _resource_record_post_run 14:51:01 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401166336; Read time: 12; Write time: 197428 14:51:01 INFO - TinderboxPrint: CPU usage
13.0% 14:51:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:51:01 INFO - TinderboxPrint: I/O write bytes / time
401,166,336 / 197,428 14:51:01 INFO - TinderboxPrint: CPU idle
8,351.0 (87.0%) 14:51:01 INFO - TinderboxPrint: CPU user
1,199.8 (12.5%) 14:51:01 INFO - TinderboxPrint: Swap in / out
0 / 0 14:51:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110489600; Read time: 0; Write time: 49608 14:51:01 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 289533952; Read time: 0; Write time: 147796 14:51:01 INFO - Running post-run listener: _upload_blobber_files 14:51:01 INFO - Blob upload gear active. 14:51:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:51:01 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 14:51:01 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'] 14:51:01 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 14:51:02 INFO - (blobuploader) - INFO - Open directory for files ... 14:51:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:51:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:51:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:03 INFO - (blobuploader) - INFO - Done attempting. 14:51:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:51:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:51:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:08 INFO - (blobuploader) - INFO - Done attempting. 14:51:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:51:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:51:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:09 INFO - (blobuploader) - INFO - Done attempting. 14:51:09 INFO - (blobuploader) - INFO - Iteration through files over. 14:51:09 INFO - Return code: 0 14:51:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:51:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:51:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/501835ebe998c07628ee22e5a65504232ac4a62a0f99355576de15ff09eafc6380b0262a82d2976d46fe8e14180795e9c7da86525b3d0560b46b0be6dff55916", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/696b92855a7a1bd9d0afbe495e18e2c09529957657810a381ab1e55faabfe05a3570706d14b926173378e1a72f893974ca0e1b86e09efb022cdd3109cb46b3f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cf5ef26b5d6b82981d7c8d3ccd1be58ebcd2d1e1b6e7ae7fde4c6a2c3426bf43050274e96c19602f096fa6e92d3101f80a606029ce923c59ef9381f1d6d1e1ae"} 14:51:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:51:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:51:09 INFO - Contents: 14:51:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/501835ebe998c07628ee22e5a65504232ac4a62a0f99355576de15ff09eafc6380b0262a82d2976d46fe8e14180795e9c7da86525b3d0560b46b0be6dff55916", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/696b92855a7a1bd9d0afbe495e18e2c09529957657810a381ab1e55faabfe05a3570706d14b926173378e1a72f893974ca0e1b86e09efb022cdd3109cb46b3f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cf5ef26b5d6b82981d7c8d3ccd1be58ebcd2d1e1b6e7ae7fde4c6a2c3426bf43050274e96c19602f096fa6e92d3101f80a606029ce923c59ef9381f1d6d1e1ae"} 14:51:09 INFO - Running post-run listener: copy_logs_to_upload_dir 14:51:09 INFO - Copying logs to upload dir... 14:51:09 INFO - mkdir: /builds/slave/test/build/upload/logs 14:51:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.859542 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-29 14:51:08.447727) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 14:51:08.451117) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489 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/501835ebe998c07628ee22e5a65504232ac4a62a0f99355576de15ff09eafc6380b0262a82d2976d46fe8e14180795e9c7da86525b3d0560b46b0be6dff55916", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/696b92855a7a1bd9d0afbe495e18e2c09529957657810a381ab1e55faabfe05a3570706d14b926173378e1a72f893974ca0e1b86e09efb022cdd3109cb46b3f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cf5ef26b5d6b82981d7c8d3ccd1be58ebcd2d1e1b6e7ae7fde4c6a2c3426bf43050274e96c19602f096fa6e92d3101f80a606029ce923c59ef9381f1d6d1e1ae"} build_url:https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011183 build_url: 'https://queue.taskcluster.net/v1/task/OICit1p9Q2mHldHrzJlp-Q/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/501835ebe998c07628ee22e5a65504232ac4a62a0f99355576de15ff09eafc6380b0262a82d2976d46fe8e14180795e9c7da86525b3d0560b46b0be6dff55916", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/696b92855a7a1bd9d0afbe495e18e2c09529957657810a381ab1e55faabfe05a3570706d14b926173378e1a72f893974ca0e1b86e09efb022cdd3109cb46b3f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cf5ef26b5d6b82981d7c8d3ccd1be58ebcd2d1e1b6e7ae7fde4c6a2c3426bf43050274e96c19602f096fa6e92d3101f80a606029ce923c59ef9381f1d6d1e1ae"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 14:51:08.482157) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 14:51:08.482501) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1475183185.347601-32917489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 14:51:08.563335) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 14:51:08.563692) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 14:51:08.564009) ========= ========= Total master_lag: 0.17 =========