builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1475114883.99 results: success (0) buildid: 20160928174719 builduid: 78cd8ca03bdb4d37ab60714e862570cf revision: e7680c5fead3325a37924862967322c080b74ee7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 19:08:03.994800) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 19:08:03.995276) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 19:08:03.995556) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 19:08:04.010312) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:08:04.010623) ========= 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=df17445c3590ff7897617a0e00000225-1475114568.319352-921956573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 19:08:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-09-28 19:08:04 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.068312 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:08:04.092644) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:08:04.092979) ========= 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=df17445c3590ff7897617a0e00000225-1475114568.319352-921956573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014070 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:08:04.142576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:08:04.142951) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e7680c5fead3325a37924862967322c080b74ee7 --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 e7680c5fead3325a37924862967322c080b74ee7 --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=df17445c3590ff7897617a0e00000225-1475114568.319352-921956573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 19:08:04,734 truncating revision to first 12 chars 2016-09-28 19:08:04,734 Setting DEBUG logging. 2016-09-28 19:08:04,735 attempt 1/10 2016-09-28 19:08:04,735 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e7680c5fead3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 19:08:05,053 unpacking tar archive at: autoland-e7680c5fead3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663685 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:08:04.820199) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 19:08:04.820507) ========= script_repo_revision: e7680c5fead3325a37924862967322c080b74ee7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 19:08:04.820894) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 19:08:04.821235) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 19:08:04.831692) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-28 19:08:04.831974) ========= /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=df17445c3590ff7897617a0e00000225-1475114568.319352-921956573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:08:05 INFO - MultiFileLogger online at 20160928 19:08:05 in /builds/slave/test 19:08:05 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 19:08:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:08:05 INFO - {'append_to_log': False, 19:08:05 INFO - 'base_work_dir': '/builds/slave/test', 19:08:05 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 19:08:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:08:05 INFO - 'branch': 'Autoland-Non-PGO', 19:08:05 INFO - 'buildbot_json_path': 'buildprops.json', 19:08:05 INFO - 'config_files': ('talos/linux_config.py',), 19:08:05 INFO - 'default_actions': ('clobber', 19:08:05 INFO - 'read-buildbot-config', 19:08:05 INFO - 'download-and-extract', 19:08:05 INFO - 'populate-webroot', 19:08:05 INFO - 'create-virtualenv', 19:08:05 INFO - 'install', 19:08:05 INFO - 'run-tests'), 19:08:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:08:05 INFO - 'download_minidump_stackwalk': True, 19:08:05 INFO - 'download_symbols': 'ondemand', 19:08:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:08:05 INFO - 'tooltool.py': '/tools/tooltool.py', 19:08:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:08:05 INFO - '/tools/misc-python/virtualenv.py')}, 19:08:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:08:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:08:05 INFO - 'installer_path': 'installer.exe', 19:08:05 INFO - 'log_level': 'info', 19:08:05 INFO - 'log_name': 'talos', 19:08:05 INFO - 'log_to_console': True, 19:08:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:08:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:08:05 INFO - 'opt_config_files': (), 19:08:05 INFO - 'pip_index': False, 19:08:05 INFO - 'sps_profile': False, 19:08:05 INFO - 'sps_profile_interval': 0, 19:08:05 INFO - 'suite': 'dromaeojs', 19:08:05 INFO - 'system_bits': '32', 19:08:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:08:05 INFO - 'title': 'talos-linux64-ix-021', 19:08:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:08:05 INFO - 'use_talos_json': True, 19:08:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:08:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:08:05 INFO - 'work_dir': 'build'} 19:08:05 INFO - [mozharness: 2016-09-29 02:08:05.520388Z] Running clobber step. 19:08:05 INFO - Running pre-action listener: _resource_record_pre_action 19:08:05 INFO - Running main action method: clobber 19:08:05 INFO - rmtree: /builds/slave/test/build 19:08:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:08:06 INFO - Running post-action listener: _resource_record_post_action 19:08:06 INFO - [mozharness: 2016-09-29 02:08:06.499046Z] Finished clobber step (success) 19:08:06 INFO - [mozharness: 2016-09-29 02:08:06.499145Z] Running read-buildbot-config step. 19:08:06 INFO - Running pre-action listener: _resource_record_pre_action 19:08:06 INFO - Running main action method: read_buildbot_config 19:08:06 INFO - Using buildbot properties: 19:08:06 INFO - { 19:08:06 INFO - "project": "", 19:08:06 INFO - "product": "firefox", 19:08:06 INFO - "script_repo_revision": "production", 19:08:06 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 19:08:06 INFO - "repository": "", 19:08:06 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 19:08:06 INFO - "buildid": "20160928174719", 19:08:06 INFO - "pgo_build": "False", 19:08:06 INFO - "basedir": "/builds/slave/test", 19:08:06 INFO - "buildnumber": 563, 19:08:06 INFO - "slavename": "talos-linux64-ix-021", 19:08:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:08:06 INFO - "platform": "ubuntu64_hw", 19:08:06 INFO - "scheduler": "tests-autoland-linux64-talos", 19:08:06 INFO - "branch": "autoland", 19:08:06 INFO - "repo_path": "integration/autoland", 19:08:06 INFO - "revision": "e7680c5fead3325a37924862967322c080b74ee7", 19:08:06 INFO - "stage_platform": "linux64", 19:08:06 INFO - "builduid": "78cd8ca03bdb4d37ab60714e862570cf", 19:08:06 INFO - "slavebuilddir": "test" 19:08:06 INFO - } 19:08:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 19:08:06 INFO - Running post-action listener: _resource_record_post_action 19:08:06 INFO - [mozharness: 2016-09-29 02:08:06.501585Z] Finished read-buildbot-config step (success) 19:08:06 INFO - [mozharness: 2016-09-29 02:08:06.501674Z] Running download-and-extract step. 19:08:06 INFO - Running pre-action listener: _resource_record_pre_action 19:08:06 INFO - Running main action method: download_and_extract 19:08:06 INFO - mkdir: /builds/slave/test/build/tests 19:08:06 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')]} 19:08:06 INFO - trying https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:08:06 INFO - Downloading https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/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 19:08:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/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 19:08:07 INFO - Downloaded 1361 bytes. 19:08:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:08:07 INFO - Using the following test package requirements: 19:08:07 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:08:07 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:08:07 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:08:07 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:07 INFO - u'jsshell-linux-x86_64.zip'], 19:08:07 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:08:07 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:08:07 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:08:07 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:08:07 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:08:07 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:08:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:08:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:08:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:08:07 INFO - Fetch https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:08:07 INFO - Http code: 200 19:08:07 INFO - Content-Encoding: None 19:08:07 INFO - Content-Type: application/zip 19:08:07 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 19:08:07 INFO - x-amz-cf-id: u7Ye-mIvQCWL5JLGC0xDDiDFFVRpjFoU1LAWZpXS5u89EbPc_saoaQ== 19:08:07 INFO - x-amz-version-id: VikKTZMFAmRfkB0rSrgsb1ja4219lvOY 19:08:07 INFO - x-cache: Hit from cloudfront 19:08:07 INFO - Expected file size: 20415697 19:08:07 INFO - Obtained file size: 20415697 19:08:12 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 19:08:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:08:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:08:12 INFO - Fetch https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:08:12 INFO - Http code: 200 19:08:12 INFO - Content-Encoding: None 19:08:12 INFO - Content-Type: application/zip 19:08:12 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 19:08:12 INFO - x-amz-cf-id: LI7LySecpdGv1oIFsr5jnYZChTM7Iq9cel6AxvgnkS8NojW8HtS-cQ== 19:08:12 INFO - x-amz-version-id: VikKTZMFAmRfkB0rSrgsb1ja4219lvOY 19:08:12 INFO - x-cache: Hit from cloudfront 19:08:12 INFO - Expected file size: 20415697 19:08:12 INFO - Obtained file size: 20415697 19:08:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 19:08:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:08:17 INFO - Fetch https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 19:08:17 INFO - Http code: 200 19:08:17 INFO - Content-Encoding: None 19:08:17 INFO - Content-Type: application/zip 19:08:17 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 19:08:17 INFO - x-amz-cf-id: -Ai-Yk_mV4XGzmRFHbrBTZb2VCWKnjDBNYOluwqvV6yCUcUfu40ZvQ== 19:08:17 INFO - x-amz-version-id: SatkXY1Ke4sfpAj4tQ4JVWWgwqvtYQsZ 19:08:17 INFO - x-cache: Hit from cloudfront 19:08:18 INFO - Expected file size: 14414067 19:08:18 INFO - Obtained file size: 14414067 19:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:18 INFO - trying https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:08:18 INFO - Downloading https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/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 19:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/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 19:08:19 INFO - Downloaded 55748559 bytes. 19:08:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:08:19 INFO - mkdir: /builds/slave/test/properties 19:08:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:08:19 INFO - Writing to file /builds/slave/test/properties/build_url 19:08:19 INFO - Contents: 19:08:19 INFO - build_url:https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:08:20 INFO - Running post-action listener: _resource_record_post_action 19:08:20 INFO - Running post-action listener: set_extra_try_arguments 19:08:20 INFO - [mozharness: 2016-09-29 02:08:20.232669Z] Finished download-and-extract step (success) 19:08:20 INFO - [mozharness: 2016-09-29 02:08:20.232895Z] Running populate-webroot step. 19:08:20 INFO - Running pre-action listener: _resource_record_pre_action 19:08:20 INFO - Running main action method: populate_webroot 19:08:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:08:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:08:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:08:20 INFO - '--tppagecycles', 19:08:20 INFO - '7'], 19:08:20 INFO - 'tests': ['tsvgm']}}, 19:08:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:08:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:08:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:08:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:08:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:08:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:08:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:20 INFO - 'talos_options': ['--disable-e10s'], 19:08:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:20 INFO - 'talos_options': ['--disable-e10s'], 19:08:20 INFO - 'tests': ['damp', 'tps']}, 19:08:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:20 INFO - 'tests': ['damp', 'tps']}, 19:08:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:08:20 INFO - 'tests': ['dromaeo_dom']}, 19:08:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:08:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:08:20 INFO - 'tests': ['basic_compositor_video']}, 19:08:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:08:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:08:20 INFO - 'tests': ['a11yr', 19:08:20 INFO - 'ts_paint', 19:08:20 INFO - 'tpaint', 19:08:20 INFO - 'sessionrestore', 19:08:20 INFO - 'sessionrestore_no_auto_restore', 19:08:20 INFO - 'tabpaint']}, 19:08:20 INFO - 'other-e10s': {'tests': ['a11yr', 19:08:20 INFO - 'ts_paint', 19:08:20 INFO - 'tpaint', 19:08:20 INFO - 'sessionrestore', 19:08:20 INFO - 'sessionrestore_no_auto_restore', 19:08:20 INFO - 'tabpaint']}, 19:08:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:08:20 INFO - 'ts_paint', 19:08:20 INFO - 'tpaint', 19:08:20 INFO - 'sessionrestore', 19:08:20 INFO - 'sessionrestore_no_auto_restore', 19:08:20 INFO - 'tabpaint']}, 19:08:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:08:20 INFO - 'ts_paint', 19:08:20 INFO - 'tpaint', 19:08:20 INFO - 'sessionrestore', 19:08:20 INFO - 'sessionrestore_no_auto_restore', 19:08:20 INFO - 'tabpaint']}, 19:08:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:08:20 INFO - 'tests': ['a11yr', 19:08:20 INFO - 'ts_paint', 19:08:20 INFO - 'tpaint', 19:08:20 INFO - 'sessionrestore', 19:08:20 INFO - 'sessionrestore_no_auto_restore', 19:08:20 INFO - 'tabpaint']}, 19:08:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:08:20 INFO - 'tests': ['a11yr', 19:08:20 INFO - 'ts_paint', 19:08:20 INFO - 'tpaint', 19:08:20 INFO - 'sessionrestore', 19:08:20 INFO - 'sessionrestore_no_auto_restore', 19:08:20 INFO - 'tabpaint']}, 19:08:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:08:20 INFO - 'tests': ['tsvgx', 19:08:20 INFO - 'tsvgr_opacity', 19:08:20 INFO - 'tart', 19:08:20 INFO - 'tscrollx', 19:08:20 INFO - 'cart']}, 19:08:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:08:20 INFO - 'tsvgr_opacity', 19:08:20 INFO - 'tart', 19:08:20 INFO - 'tscrollx', 19:08:20 INFO - 'cart']}, 19:08:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:20 INFO - 'talos_options': ['--disable-e10s'], 19:08:20 INFO - 'tests': ['tp5o']}, 19:08:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:20 INFO - 'tests': ['tp5o']}, 19:08:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:20 INFO - 'talos_options': ['--disable-e10s', 19:08:20 INFO - '--xperf_path', 19:08:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:20 INFO - 'tests': ['tp5n']}, 19:08:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:20 INFO - 'talos_options': ['--xperf_path', 19:08:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:20 INFO - 'tests': ['tp5n']}}, 19:08:20 INFO - 'talos.zip': {'path': '', 19:08:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:08:20 INFO - Running post-action listener: _resource_record_post_action 19:08:20 INFO - [mozharness: 2016-09-29 02:08:20.250852Z] Finished populate-webroot step (success) 19:08:20 INFO - [mozharness: 2016-09-29 02:08:20.250940Z] Running create-virtualenv step. 19:08:20 INFO - Running pre-action listener: _resource_record_pre_action 19:08:20 INFO - Running main action method: create_virtualenv 19:08:20 INFO - Creating virtualenv /builds/slave/test/build/venv 19:08:20 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 19:08:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:08:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:08:20 INFO - Using real prefix '/usr' 19:08:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:08:20 INFO - Installing distribute.............................................................................................................................................................................................done. 19:08:22 INFO - Installing pip.................done. 19:08:22 INFO - Return code: 0 19:08:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:08:23 INFO - Reading from file tmpfile_stdout 19:08:23 INFO - Output received: 19:08:23 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) 19:08:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0fcdcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1df60>, '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 0xd1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd1f1d0>, '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': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', '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 19:08:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:08:23 INFO - Using env: {'DISPLAY': ':0', 19:08:23 INFO - 'HOME': '/home/cltbld', 19:08:23 INFO - 'LANG': 'en_US.UTF-8', 19:08:23 INFO - 'LANGUAGE': 'en_US:en', 19:08:23 INFO - 'LOGNAME': 'cltbld', 19:08:23 INFO - 'MAIL': '/var/mail/cltbld', 19:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:23 INFO - 'MOZ_NO_REMOTE': '1', 19:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:23 INFO - 'NO_EM_RESTART': '1', 19:08:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:23 INFO - 'PWD': '/builds/slave/test', 19:08:23 INFO - 'SHELL': '/bin/bash', 19:08:23 INFO - 'SHLVL': '1', 19:08:23 INFO - 'TERM': 'linux', 19:08:23 INFO - 'TMOUT': '86400', 19:08:23 INFO - 'USER': 'cltbld', 19:08:23 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', 19:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:23 INFO - '_': '/tools/buildbot/bin/python'} 19:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:23 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 19:08:23 INFO - Cleaning up... 19:08:23 INFO - Return code: 0 19:08:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff0fcdcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1df60>, '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 0xd1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd1f1d0>, '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': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', '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 19:08:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:08:23 INFO - Using env: {'DISPLAY': ':0', 19:08:23 INFO - 'HOME': '/home/cltbld', 19:08:23 INFO - 'LANG': 'en_US.UTF-8', 19:08:23 INFO - 'LANGUAGE': 'en_US:en', 19:08:23 INFO - 'LOGNAME': 'cltbld', 19:08:23 INFO - 'MAIL': '/var/mail/cltbld', 19:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:23 INFO - 'MOZ_NO_REMOTE': '1', 19:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:23 INFO - 'NO_EM_RESTART': '1', 19:08:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:23 INFO - 'PWD': '/builds/slave/test', 19:08:23 INFO - 'SHELL': '/bin/bash', 19:08:23 INFO - 'SHLVL': '1', 19:08:23 INFO - 'TERM': 'linux', 19:08:23 INFO - 'TMOUT': '86400', 19:08:23 INFO - 'USER': 'cltbld', 19:08:23 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', 19:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:23 INFO - '_': '/tools/buildbot/bin/python'} 19:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:23 INFO - Downloading/unpacking psutil>=3.1.1 19:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:08:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:25 INFO - Installing collected packages: psutil 19:08:25 INFO - Running setup.py install for psutil 19:08:25 INFO - building 'psutil._psutil_linux' extension 19:08:25 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 19:08:25 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 19:08:25 INFO - building 'psutil._psutil_posix' extension 19:08:25 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 19:08:25 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 19:08:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:25 INFO - Successfully installed psutil 19:08:25 INFO - Cleaning up... 19:08:26 INFO - Return code: 0 19:08:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:26 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 0x7ff0fcdcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1df60>, '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 0xd1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd1f1d0>, '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': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', '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 19:08:26 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 19:08:26 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 19:08:26 INFO - Using env: {'DISPLAY': ':0', 19:08:26 INFO - 'HOME': '/home/cltbld', 19:08:26 INFO - 'LANG': 'en_US.UTF-8', 19:08:26 INFO - 'LANGUAGE': 'en_US:en', 19:08:26 INFO - 'LOGNAME': 'cltbld', 19:08:26 INFO - 'MAIL': '/var/mail/cltbld', 19:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:26 INFO - 'MOZ_NO_REMOTE': '1', 19:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:26 INFO - 'NO_EM_RESTART': '1', 19:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:26 INFO - 'PWD': '/builds/slave/test', 19:08:26 INFO - 'SHELL': '/bin/bash', 19:08:26 INFO - 'SHLVL': '1', 19:08:26 INFO - 'TERM': 'linux', 19:08:26 INFO - 'TMOUT': '86400', 19:08:26 INFO - 'USER': 'cltbld', 19:08:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', 19:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:26 INFO - '_': '/tools/buildbot/bin/python'} 19:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:08:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:08:28 INFO - Installing collected packages: mozsystemmonitor 19:08:28 INFO - Running setup.py install for mozsystemmonitor 19:08:28 INFO - Successfully installed mozsystemmonitor 19:08:28 INFO - Cleaning up... 19:08:28 INFO - Return code: 0 19:08:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0fcdcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1df60>, '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 0xd1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd1f1d0>, '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': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', '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 19:08:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:08:28 INFO - Using env: {'DISPLAY': ':0', 19:08:28 INFO - 'HOME': '/home/cltbld', 19:08:28 INFO - 'LANG': 'en_US.UTF-8', 19:08:28 INFO - 'LANGUAGE': 'en_US:en', 19:08:28 INFO - 'LOGNAME': 'cltbld', 19:08:28 INFO - 'MAIL': '/var/mail/cltbld', 19:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:28 INFO - 'MOZ_NO_REMOTE': '1', 19:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:28 INFO - 'NO_EM_RESTART': '1', 19:08:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:28 INFO - 'PWD': '/builds/slave/test', 19:08:28 INFO - 'SHELL': '/bin/bash', 19:08:28 INFO - 'SHLVL': '1', 19:08:28 INFO - 'TERM': 'linux', 19:08:28 INFO - 'TMOUT': '86400', 19:08:28 INFO - 'USER': 'cltbld', 19:08:28 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', 19:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:28 INFO - '_': '/tools/buildbot/bin/python'} 19:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:28 INFO - Downloading/unpacking jsonschema==2.5.1 19:08:28 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 19:08:28 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 19:08:28 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 19:08:28 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 19:08:28 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 19:08:28 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 19:08:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:08:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:30 INFO - Downloading functools32-3.2.3-2.tar.gz 19:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:08:30 INFO - warning: no files found matching '*.txt' 19:08:30 INFO - no previously-included directories found matching 'build' 19:08:30 INFO - no previously-included directories found matching 'dist' 19:08:30 INFO - no previously-included directories found matching '.git*' 19:08:30 INFO - Installing collected packages: jsonschema, functools32 19:08:30 INFO - Running setup.py install for functools32 19:08:30 INFO - warning: no files found matching '*.txt' 19:08:30 INFO - no previously-included directories found matching 'build' 19:08:30 INFO - no previously-included directories found matching 'dist' 19:08:30 INFO - no previously-included directories found matching '.git*' 19:08:30 INFO - Successfully installed jsonschema functools32 19:08:30 INFO - Cleaning up... 19:08:30 INFO - Return code: 0 19:08:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:30 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 0x7ff0fcdcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1df60>, '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 0xd1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd1f1d0>, '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': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', '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 19:08:30 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 19:08:30 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 19:08:30 INFO - Using env: {'DISPLAY': ':0', 19:08:30 INFO - 'HOME': '/home/cltbld', 19:08:30 INFO - 'LANG': 'en_US.UTF-8', 19:08:30 INFO - 'LANGUAGE': 'en_US:en', 19:08:30 INFO - 'LOGNAME': 'cltbld', 19:08:30 INFO - 'MAIL': '/var/mail/cltbld', 19:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:30 INFO - 'MOZ_NO_REMOTE': '1', 19:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:30 INFO - 'NO_EM_RESTART': '1', 19:08:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:30 INFO - 'PWD': '/builds/slave/test', 19:08:30 INFO - 'SHELL': '/bin/bash', 19:08:30 INFO - 'SHLVL': '1', 19:08:30 INFO - 'TERM': 'linux', 19:08:30 INFO - 'TMOUT': '86400', 19:08:30 INFO - 'USER': 'cltbld', 19:08:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', 19:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:30 INFO - '_': '/tools/buildbot/bin/python'} 19:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:08:31 INFO - Cleaning up... 19:08:31 INFO - Return code: 0 19:08:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:31 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 0x7ff0fcdcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1df60>, '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 0xd1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd1f1d0>, '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': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', '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 19:08:31 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 19:08:31 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 19:08:31 INFO - Using env: {'DISPLAY': ':0', 19:08:31 INFO - 'HOME': '/home/cltbld', 19:08:31 INFO - 'LANG': 'en_US.UTF-8', 19:08:31 INFO - 'LANGUAGE': 'en_US:en', 19:08:31 INFO - 'LOGNAME': 'cltbld', 19:08:31 INFO - 'MAIL': '/var/mail/cltbld', 19:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:31 INFO - 'MOZ_NO_REMOTE': '1', 19:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:31 INFO - 'NO_EM_RESTART': '1', 19:08:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:31 INFO - 'PWD': '/builds/slave/test', 19:08:31 INFO - 'SHELL': '/bin/bash', 19:08:31 INFO - 'SHLVL': '1', 19:08:31 INFO - 'TERM': 'linux', 19:08:31 INFO - 'TMOUT': '86400', 19:08:31 INFO - 'USER': 'cltbld', 19:08:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', 19:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:31 INFO - '_': '/tools/buildbot/bin/python'} 19:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:31 INFO - Downloading/unpacking blobuploader==1.2.4 19:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:33 INFO - Downloading blobuploader-1.2.4.tar.gz 19:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:08:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:08:33 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 19:08:33 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 19:08:33 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 19:08:33 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 19:08:33 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 19:08:33 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 19:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:08:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:08:33 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 19:08:33 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 19:08:33 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 19:08:33 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 19:08:33 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 19:08:33 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 19:08:34 INFO - Downloading docopt-0.6.1.tar.gz 19:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:08:34 INFO - Installing collected packages: blobuploader, requests, docopt 19:08:34 INFO - Running setup.py install for blobuploader 19:08:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:08:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:08:34 INFO - Running setup.py install for requests 19:08:34 INFO - Running setup.py install for docopt 19:08:34 INFO - Successfully installed blobuploader requests docopt 19:08:34 INFO - Cleaning up... 19:08:34 INFO - Return code: 0 19:08:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:34 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 0x7ff0fcdcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1df60>, '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 0xd1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd1f1d0>, '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': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', '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 19:08:34 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 19:08:34 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 19:08:34 INFO - Using env: {'DISPLAY': ':0', 19:08:34 INFO - 'HOME': '/home/cltbld', 19:08:34 INFO - 'LANG': 'en_US.UTF-8', 19:08:34 INFO - 'LANGUAGE': 'en_US:en', 19:08:34 INFO - 'LOGNAME': 'cltbld', 19:08:34 INFO - 'MAIL': '/var/mail/cltbld', 19:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:34 INFO - 'MOZ_NO_REMOTE': '1', 19:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:34 INFO - 'NO_EM_RESTART': '1', 19:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:34 INFO - 'PWD': '/builds/slave/test', 19:08:34 INFO - 'SHELL': '/bin/bash', 19:08:34 INFO - 'SHLVL': '1', 19:08:34 INFO - 'TERM': 'linux', 19:08:34 INFO - 'TMOUT': '86400', 19:08:34 INFO - 'USER': 'cltbld', 19:08:34 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', 19:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:34 INFO - '_': '/tools/buildbot/bin/python'} 19:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:34 INFO - Running setup.py (path:/tmp/pip-huqDbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:35 INFO - Running setup.py (path:/tmp/pip-ptXNXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:35 INFO - Running setup.py (path:/tmp/pip-pOXbKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:35 INFO - Running setup.py (path:/tmp/pip-XcMenC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:35 INFO - Running setup.py (path:/tmp/pip-LcSIQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:35 INFO - Running setup.py (path:/tmp/pip-YpN1r6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:35 INFO - Running setup.py (path:/tmp/pip-NAvfM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:35 INFO - Running setup.py (path:/tmp/pip-aF2Fwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:35 INFO - Running setup.py (path:/tmp/pip-zUqWsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:35 INFO - Running setup.py (path:/tmp/pip-zHiViM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:35 INFO - Running setup.py (path:/tmp/pip-23D4W7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:35 INFO - Running setup.py (path:/tmp/pip-R2hJBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:35 INFO - Running setup.py (path:/tmp/pip-95V7Xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:35 INFO - Running setup.py (path:/tmp/pip-Utq4T_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:35 INFO - Running setup.py (path:/tmp/pip-9GeboR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:36 INFO - Running setup.py (path:/tmp/pip-2NqNva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:36 INFO - Running setup.py (path:/tmp/pip-MVdGrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:08:36 INFO - Running setup.py install for manifestparser 19:08:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:08:36 INFO - Running setup.py install for mozcrash 19:08:36 INFO - Running setup.py install for mozdebug 19:08:36 INFO - Running setup.py install for mozdevice 19:08:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:08:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:08:36 INFO - Running setup.py install for mozfile 19:08:36 INFO - Running setup.py install for mozhttpd 19:08:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:08:36 INFO - Running setup.py install for mozinfo 19:08:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:08:36 INFO - Running setup.py install for mozInstall 19:08:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:08:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:08:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:08:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Running setup.py install for mozleak 19:08:37 INFO - Running setup.py install for mozlog 19:08:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Running setup.py install for moznetwork 19:08:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Running setup.py install for mozprocess 19:08:37 INFO - Running setup.py install for mozprofile 19:08:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Running setup.py install for mozrunner 19:08:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Running setup.py install for mozscreenshot 19:08:37 INFO - Running setup.py install for moztest 19:08:37 INFO - Running setup.py install for mozversion 19:08:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:08:37 INFO - Cleaning up... 19:08:38 INFO - Return code: 0 19:08:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:38 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 0x7ff0fcdcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1df60>, '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 0xd1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd1f1d0>, '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': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', '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 19:08:38 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 19:08:38 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 19:08:38 INFO - Using env: {'DISPLAY': ':0', 19:08:38 INFO - 'HOME': '/home/cltbld', 19:08:38 INFO - 'LANG': 'en_US.UTF-8', 19:08:38 INFO - 'LANGUAGE': 'en_US:en', 19:08:38 INFO - 'LOGNAME': 'cltbld', 19:08:38 INFO - 'MAIL': '/var/mail/cltbld', 19:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:38 INFO - 'MOZ_NO_REMOTE': '1', 19:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:38 INFO - 'NO_EM_RESTART': '1', 19:08:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:38 INFO - 'PWD': '/builds/slave/test', 19:08:38 INFO - 'SHELL': '/bin/bash', 19:08:38 INFO - 'SHLVL': '1', 19:08:38 INFO - 'TERM': 'linux', 19:08:38 INFO - 'TMOUT': '86400', 19:08:38 INFO - 'USER': 'cltbld', 19:08:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', 19:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:38 INFO - '_': '/tools/buildbot/bin/python'} 19:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:38 INFO - Running setup.py (path:/tmp/pip-I2fIFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:38 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)) 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:38 INFO - Running setup.py (path:/tmp/pip-8H4aiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:38 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)) 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:38 INFO - Running setup.py (path:/tmp/pip-FqQstH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:38 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)) 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:38 INFO - Running setup.py (path:/tmp/pip-SL63xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:38 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)) 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:38 INFO - Running setup.py (path:/tmp/pip-AUaoWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:38 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)) 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:38 INFO - Running setup.py (path:/tmp/pip-HdBH_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:38 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)) 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:38 INFO - Running setup.py (path:/tmp/pip-ET_NAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:38 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)) 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:38 INFO - Running setup.py (path:/tmp/pip-yB4114-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:38 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)) 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:38 INFO - Running setup.py (path:/tmp/pip-kneh36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:38 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)) 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:38 INFO - Running setup.py (path:/tmp/pip-N0D40Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:38 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)) 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:38 INFO - Running setup.py (path:/tmp/pip-vTsF0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:39 INFO - Running setup.py (path:/tmp/pip-kSaU8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:39 INFO - Running setup.py (path:/tmp/pip-LsScwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:39 INFO - Running setup.py (path:/tmp/pip-mxXRnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:39 INFO - Running setup.py (path:/tmp/pip-oGvw0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:39 INFO - Running setup.py (path:/tmp/pip-cwiHAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:39 INFO - Running setup.py (path:/tmp/pip-rW48kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:39 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)) 19:08:39 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)) 19:08:39 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)) 19:08:39 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)) 19:08:39 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)) 19:08:39 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)) 19:08:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:08:39 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 19:08:39 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 19:08:39 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 19:08:39 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 19:08:39 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 19:08:39 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 19:08:41 INFO - Downloading blessings-1.6.tar.gz 19:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:08:41 INFO - Installing collected packages: blessings 19:08:41 INFO - Running setup.py install for blessings 19:08:41 INFO - Successfully installed blessings 19:08:41 INFO - Cleaning up... 19:08:41 INFO - Return code: 0 19:08:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:08:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:41 INFO - Reading from file tmpfile_stdout 19:08:41 INFO - Current package versions: 19:08:41 INFO - argparse == 1.2.1 19:08:41 INFO - blessings == 1.6 19:08:41 INFO - blobuploader == 1.2.4 19:08:41 INFO - docopt == 0.6.1 19:08:41 INFO - functools32 == 3.2.3-2 19:08:41 INFO - jsonschema == 2.5.1 19:08:41 INFO - manifestparser == 1.1 19:08:41 INFO - mozInstall == 1.12 19:08:41 INFO - mozcrash == 0.17 19:08:41 INFO - mozdebug == 0.1 19:08:41 INFO - mozdevice == 0.48 19:08:41 INFO - mozfile == 1.2 19:08:41 INFO - mozhttpd == 0.7 19:08:41 INFO - mozinfo == 0.9 19:08:41 INFO - mozleak == 0.1 19:08:41 INFO - mozlog == 3.4 19:08:41 INFO - moznetwork == 0.27 19:08:41 INFO - mozprocess == 0.23 19:08:41 INFO - mozprofile == 0.28 19:08:41 INFO - mozrunner == 6.12 19:08:41 INFO - mozscreenshot == 0.1 19:08:41 INFO - mozsystemmonitor == 0.3 19:08:41 INFO - moztest == 0.7 19:08:41 INFO - mozversion == 1.4 19:08:41 INFO - psutil == 3.1.1 19:08:41 INFO - requests == 1.2.3 19:08:41 INFO - wsgiref == 0.1.2 19:08:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:41 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')]} 19:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:41 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')]} 19:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:41 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 0x7ff0fcdcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1df60>, '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 0xd1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd1f1d0>, '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': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', '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 19:08:41 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 19:08:41 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 19:08:41 INFO - Using env: {'DISPLAY': ':0', 19:08:41 INFO - 'HOME': '/home/cltbld', 19:08:41 INFO - 'LANG': 'en_US.UTF-8', 19:08:41 INFO - 'LANGUAGE': 'en_US:en', 19:08:41 INFO - 'LOGNAME': 'cltbld', 19:08:41 INFO - 'MAIL': '/var/mail/cltbld', 19:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:41 INFO - 'MOZ_NO_REMOTE': '1', 19:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:41 INFO - 'NO_EM_RESTART': '1', 19:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:41 INFO - 'PWD': '/builds/slave/test', 19:08:41 INFO - 'SHELL': '/bin/bash', 19:08:41 INFO - 'SHLVL': '1', 19:08:41 INFO - 'TERM': 'linux', 19:08:41 INFO - 'TMOUT': '86400', 19:08:41 INFO - 'USER': 'cltbld', 19:08:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', 19:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:41 INFO - '_': '/tools/buildbot/bin/python'} 19:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 INFO - Cleaning up... 19:08:42 INFO - Return code: 0 19:08:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0fcdcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1df60>, '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 0xd1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd1f1d0>, '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': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', '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 19:08:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:08:42 INFO - Using env: {'DISPLAY': ':0', 19:08:42 INFO - 'HOME': '/home/cltbld', 19:08:42 INFO - 'LANG': 'en_US.UTF-8', 19:08:42 INFO - 'LANGUAGE': 'en_US:en', 19:08:42 INFO - 'LOGNAME': 'cltbld', 19:08:42 INFO - 'MAIL': '/var/mail/cltbld', 19:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:42 INFO - 'MOZ_NO_REMOTE': '1', 19:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:42 INFO - 'NO_EM_RESTART': '1', 19:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:42 INFO - 'PWD': '/builds/slave/test', 19:08:42 INFO - 'SHELL': '/bin/bash', 19:08:42 INFO - 'SHLVL': '1', 19:08:42 INFO - 'TERM': 'linux', 19:08:42 INFO - 'TMOUT': '86400', 19:08:42 INFO - 'USER': 'cltbld', 19:08:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', 19:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:42 INFO - '_': '/tools/buildbot/bin/python'} 19:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:08:42 INFO - Cleaning up... 19:08:42 INFO - Return code: 0 19:08:42 INFO - Running post-action listener: _resource_record_post_action 19:08:42 INFO - Running post-action listener: _start_resource_monitoring 19:08:42 INFO - Starting resource monitoring. 19:08:42 INFO - [mozharness: 2016-09-29 02:08:42.371895Z] Finished create-virtualenv step (success) 19:08:42 INFO - [mozharness: 2016-09-29 02:08:42.372395Z] Running install step. 19:08:42 INFO - Running pre-action listener: _resource_record_pre_action 19:08:42 INFO - Running main action method: install 19:08:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:42 INFO - Reading from file tmpfile_stdout 19:08:42 INFO - Detecting whether we're running mozinstall >=1.0... 19:08:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:08:42 INFO - Reading from file tmpfile_stdout 19:08:42 INFO - Output received: 19:08:42 INFO - Usage: mozinstall [options] installer 19:08:42 INFO - Options: 19:08:42 INFO - -h, --help show this help message and exit 19:08:42 INFO - -d DEST, --destination=DEST 19:08:42 INFO - Directory to install application into. [default: 19:08:42 INFO - "/builds/slave/test"] 19:08:42 INFO - --app=APP Application being installed. [default: firefox] 19:08:42 INFO - mkdir: /builds/slave/test/build/application 19:08:42 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'] 19:08:42 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 19:08:58 INFO - Reading from file tmpfile_stdout 19:08:58 INFO - Output received: 19:08:58 INFO - /builds/slave/test/build/application/firefox/firefox 19:08:58 INFO - Running post-action listener: _resource_record_post_action 19:08:58 INFO - [mozharness: 2016-09-29 02:08:58.781200Z] Finished install step (success) 19:08:58 INFO - [mozharness: 2016-09-29 02:08:58.781446Z] Running run-tests step. 19:08:58 INFO - Running pre-action listener: _resource_record_pre_action 19:08:58 INFO - Running main action method: run_tests 19:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:08:58 INFO - Python 2.7.3 19:08:58 INFO - Return code: 0 19:08:58 INFO - grabbing minidump binary from tooltool 19:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:58 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 0xd1df60>, '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 0xd1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd1f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:08:58 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 19:08:58 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 19:08:58 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 19:08:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:08:58 INFO - Return code: 0 19:08:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:08:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:08:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:08:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:08:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:08:58 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/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 19:08:58 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/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 19:08:58 INFO - Using env: {'DISPLAY': ':0', 19:08:58 INFO - 'HOME': '/home/cltbld', 19:08:58 INFO - 'LANG': 'en_US.UTF-8', 19:08:58 INFO - 'LANGUAGE': 'en_US:en', 19:08:58 INFO - 'LOGNAME': 'cltbld', 19:08:58 INFO - 'MAIL': '/var/mail/cltbld', 19:08:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:08:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:58 INFO - 'MOZ_NO_REMOTE': '1', 19:08:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:58 INFO - 'NO_EM_RESTART': '1', 19:08:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:58 INFO - 'PWD': '/builds/slave/test', 19:08:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:08:58 INFO - 'SHELL': '/bin/bash', 19:08:58 INFO - 'SHLVL': '1', 19:08:58 INFO - 'TERM': 'linux', 19:08:58 INFO - 'TMOUT': '86400', 19:08:58 INFO - 'USER': 'cltbld', 19:08:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1475114568.319352-921956573', 19:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:58 INFO - '_': '/tools/buildbot/bin/python'} 19:08:58 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/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 19:08:59 INFO - mozversion application_buildid: 20160928174719 19:08:59 INFO - mozversion application_changeset: e7680c5fead3325a37924862967322c080b74ee7 19:08:59 INFO - mozversion application_display_name: Nightly 19:08:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:08:59 INFO - mozversion application_name: Firefox 19:08:59 INFO - mozversion application_remotingname: firefox 19:08:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 19:08:59 INFO - mozversion application_vendor: Mozilla 19:08:59 INFO - mozversion application_version: 52.0a1 19:08:59 INFO - mozversion platform_buildid: 20160928174719 19:08:59 INFO - mozversion platform_changeset: e7680c5fead3325a37924862967322c080b74ee7 19:08:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 19:08:59 INFO - mozversion platform_version: 52.0a1 19:08:59 INFO - using testdate: 1475114939 19:08:59 INFO - actual date: 1475114939 19:08:59 INFO - starting webserver on 'localhost:60508' 19:08:59 INFO - SUITE-START | Running 2 tests 19:08:59 INFO - TEST-START | dromaeo_css 19:08:59 INFO - operating with platform_type : linux_ 19:08:59 INFO - Initialising browser for dromaeo_css test... 19:08:59 INFO - TEST-INFO | started process 6652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDy28k1/profile http://localhost:60508/getInfo.html) 19:09:04 INFO - PROCESS | 6652 | __metrics Screen width/height:1600/1200 19:09:04 INFO - PROCESS | 6652 | colorDepth:24 19:09:04 INFO - PROCESS | 6652 | Browser inner width/height: 1024/697 19:09:04 INFO - PROCESS | 6652 | __metrics 19:09:04 INFO - PROCESS | 6652 | 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" 19:09:04 INFO - PROCESS | 6652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:09:05 INFO - PROCESS | 6652 | console.error: PushService: 19:09:05 INFO - PROCESS | 6652 | stateChangeProcessEnqueue: Error transitioning state 19:09:05 INFO - PROCESS | 6652 | UnknownError 19:09:06 INFO - TEST-INFO | 6652: exit 0 19:09:06 INFO - Browser initialized. 19:09:06 INFO - Running cycle 1/1 for dromaeo_css test... 19:09:06 INFO - TEST-INFO | started process 6735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDy28k1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:09:18 INFO - PROCESS | 6735 | RSS: Main: 174886912 19:09:18 INFO - PROCESS | 6735 | 19:10:10 INFO - PROCESS | 6735 | 1475115010233 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] 19:12:22 INFO - PROCESS | 6735 | Cycle 1(1): loaded http://localhost:60508/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60508/tests/dromaeo/cssquery-ext.html) 19:12:23 INFO - PROCESS | 6735 | RSS: Main: 268705792 19:12:23 INFO - PROCESS | 6735 | 19:15:26 INFO - PROCESS | 6735 | Cycle 1(1): loaded http://localhost:60508/tests/dromaeo/cssquery-ext.html (next: http://localhost:60508/tests/dromaeo/cssquery-jquery.html) 19:15:27 INFO - PROCESS | 6735 | RSS: Main: 276570112 19:15:27 INFO - PROCESS | 6735 | 19:18:29 INFO - PROCESS | 6735 | Cycle 1(1): loaded http://localhost:60508/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60508/tests/dromaeo/cssquery-mootools.html) 19:18:30 INFO - PROCESS | 6735 | RSS: Main: 255397888 19:18:30 INFO - PROCESS | 6735 | 19:21:32 INFO - PROCESS | 6735 | Cycle 1(1): loaded http://localhost:60508/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60508/tests/dromaeo/cssquery-prototype.html) 19:21:32 INFO - PROCESS | 6735 | RSS: Main: 214532096 19:21:32 INFO - PROCESS | 6735 | 19:24:36 INFO - PROCESS | 6735 | Cycle 1(1): loaded http://localhost:60508/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60508/tests/dromaeo/cssquery-yui.html) 19:24:36 INFO - PROCESS | 6735 | RSS: Main: 216715264 19:24:36 INFO - PROCESS | 6735 | 19:27:39 INFO - PROCESS | 6735 | Cycle 1(1): loaded http://localhost:60508/tests/dromaeo/cssquery-yui.html (next: http://localhost:60508/tests/dromaeo/cssquery-dojo.html) 19:27:39 INFO - PROCESS | 6735 | RSS: Main: 305434624 19:27:39 INFO - PROCESS | 6735 | 19:27:39 INFO - PROCESS | 6735 | __start_tp_report 19:27:39 INFO - PROCESS | 6735 | _x_x_mozilla_page_load 19:27:39 INFO - PROCESS | 6735 | _x_x_mozilla_page_load_details 19:27:39 INFO - PROCESS | 6735 | |i|pagename|runs| 19:27:39 INFO - PROCESS | 6735 | |0;dojo.html;2563.1413476485377;2583.677040369954;2611.9216423507296;2619.122593931033;2634.012245407971;4640.141573808839;4698.412698412699;4704.835330763424;4720.69315494493;4738.241881298993;4691.413573303337;4719.1033703596295;4720.740359280238;4741.359916411284;4825;4366.8034938427845;4367.08291258836;4390.517043125254;4419.690621656486;4430.313301438282;4243.002894319832;4305.138972205556;4312.805923733439;4340.175366680336;4406.801693923781;4347.739135651871;4354.825806967718;4372.234858899696;4411.492678341983;4424.336349547561;4275.40144379787;4292.828286868522;4301.354796780477;4305.547917468683;4315.007548263886;4314.331278651814;4324.6972711910175;4359.0192206753545;4360.258756011485;4373.890652733707;4647.3958385410015;4649.837255696035;4660.930086048678;4683.110209060268;4812.518748125194;5034.622403319729;5041.72270525121;5046.041252162077;5048.3941926969;5114.462981386975;4878.975605121987;4932.087563800673;5061.16490779021;5096.847094587169;5161.922571161435;4732.503087175797;4740.834070807505;4744.952550474451;4790.185668436374;4803.5916947059895;5184.585233181412;5212.035773381936;5213.791448342024;5216.504432078947;5225.608079394061;4823.421189457287;4862.149123903303;4862.80548778052;4958.380202474691;5049.671771334852;5095.923561146586;5151.793928242903;5152.046871328816;5153.948460515422;5155.278261043457;5050.671706339076;5053.823116190915;5064.037832811754;5111.309973153577;5114.156164232934;5019.623528235324;5026.572741317029;5030;5033.6224783141415;5087.771050302746;4117.279476091732;4180.038591124058;4181.226473102425;4187.1625674865145;4263.296556068214;3681.3005528949416;3702.5371828521434;3732.5894151643297;3749.456328832304;3798.1074447504816;4288.656907447459;4336.848210312624;4353.06409122034;4355.08543205924;4406.603405693503;4932.802687892516;4968.0312339093525;5032;5053.0651829410945;5099.4390617032095;4288.056627541936;4318.330658747899;4325.437693099877;4337.783110844445;4407.118576284756;4510.458744950627;4519.638428925678;4522.525134860858;4560.566746159109;4585.518520555361;4721.055788842176;4726.291056341507;4727.929081063718;4751.121042607128;4809.927851082307;4930.13722598551;4973.626977976739;5064.41759197697;5076.18780995039;5103.642745007963;4761.023990082094;4772.260299653559;4779.545943135397;4831.057943700945;4838.298446725275;5043.218301163325;5044.571211446922;5045.7981680732355;5052.545270925634;5111.207762796773;4960.47914968923;4982.352294201731;5017.096922553976;5082.1106306395495;5163.845084647466;4867.075255701406;4888.560029597354;4890.657653964331;4940.950590494049;4946.307516947702;4884.169691152441;4884.92672609904;4886.853394398174;4898.632602554894;4920.114379411741;4724.858254252378;4812.735299558558;4839.975800120977;4846.806127754991;4897.90204195907;4928.457869634266;4933.432655244693;4957.429895562056;4958.355413796184;5021.171506701354;4801.327814105958;4846.539578740014;4848.0546293472435;4850.757462126809;4906.190478571139 19:27:39 INFO - PROCESS | 6735 | |1;ext.html;526.5419085395706;560.980365687201;563.5378989228832;575.2378099018802;577.9393163717809;27119.72880271197;29775.55336669949;37554.55895366799;38653.22693546127;38759.418608720895;39121.608783912154;39494;39549.802250988774;39656.405153922715;39730.205395892066;7298.854022919539;7708.57602831844;7844.215578442138;7847.372210223169;7858.29275365217;7266.3460288574015;7506.512076715024;7507.774766757006;9874.950625246864;10144.54349554268;10173.796524069514;10215.591376344975;10235.283530152892;10237.488125593727;10239.948800255988;10164.949175254113;10260.948695256477;10271.486425678686;10273.48632568376;10276.794464110713;9941.403515789076;9960.800783984352;10003.89996100037;10011.199104071657;10014.098731114234;37356.25287494235;37429;37658.43512347317;37677.24645507102;37707.24585508302;3155;3196.8881089162;3372.4772660237704;3441.380551500729;3650.981745091284;27171.1848644539;27440.725592744016;27481.45037099267;27589.31026724328;28930.13209603694;3394.7114495267933;3404.871325807714;3470.23654795947;3480.6345333739846;3482.8258587070545;243260;243926;244603;245347.99999999822;245703;29747.85126074356;50297.49702503001;50574.49425505772;50606.98786024259;50684.239736403986;31289.530657040163;33492.1626959328;33557.16107097342;33640.831795840866;33672.49491257633;12569.811452828215;12694.492220311084;12700.555480558322;12718.554850580185;12718.809217861555;10341.276110672181;10347.172226221885;10389.220808439397;10415.177343964928;10417.5832966682;7149.14210294768;7342.486025978237;7521.9247807522315;7693.076830780342;7743.5353878767455;3045.4061458015917;3052.420040192401;3061.2959019425657;3094.3656550407113;3138.074268090919;848.1984524624294;848.6435697007272;852.4373913217247;886.5035580075179;952.8189643967762;26339.47321053568;27583.86208068947;27727.445451090865;27819.443611127663;27921.16236512867;882.0958517519465;910.8679241509944;922.7231830450838;952.4618590496348;986.935849169816;14462;14539.854601454063;14663.19352435605;14725.410983560538;14932.70134597302;364204;365209;367544;368657;371761;45965.310520342224;46312.5368746315;46800;47139.528604713516;47769.28346074812;1120.7086157599083;1148.179051977823;1152.7233463968587;1156.8727439981594;1163.5229555882047;27076;28040.027191298588;28603.427931440838;28967.275818104717;29150.854245728635;41713.58286417097;42148.57851421447;42155.15689686251;42171.57828421799;42266.1546769069;368145;386582;386700;609922;615582;34165.89608377337;34171.31657366888;34363.14092147716;34443.4833477493;34729;40898.79550602228;41333.37999929943;42555;44562;45671.543284568055;34890.12774680653;34956.30087398289;35039.299214016086;35044.12389690278;35497.112572184866;35233.1191720209;35273.823630881685;35322.47016294809;35622;35672.464913025804;34422.65577344195;35055.82472087623;35149.29701406009;35331.47002795011;35643.46534802032;30928.69071309258;32920.341593167526;33040;33131.50302745509;33402.66597333996;24855.751442485343;25205.369865752768;25510.596148760633;25760;25917.352066198495 19:27:39 INFO - PROCESS | 6735 | |2;jquery.html;348.83953381444536;361.90409541471513;365.73484223937646;370.4165938646631;391.03414566021934;12224.44989975451;12378.304546203091;13873.375698093585;14156.575302740908;17023.23395447205;15793.60515987098;15801.762973555406;15820.208989550534;15899.84100158998;16384.67230655386;4897;4934.475655989725;5062.519060689228;5129.717865517395;5138.6146039047035;3717.3866312058476;3909.2963266612;5041.798328066873;5147.073526765181;5147.507222905353;5730.283714535683;5992.370801065891;6006.669633170174;6019.157317975487;6026.758929642809;5787.160861675034;5788;5811.535077193815;5952.375000624916;5975.25309336333;5067.9239811402485;5208;5211.114110601206;5211.348581427322;5214.947850521484;19608.70586941197;20036.599268014557;20144.395668129833;20155.798442015537;20439.693404598944;1920.8175223353899;1937.447827369207;2003.8196562309463;2023.5345870449733;2450.8161887858305;12078.577249796303;13195.868041319656;13516.918646508257;13709.520166794115;13716.65708357289;1715.5282297368199;1732.3503686117706;1778.1731494854955;1782.6523827853573;1795.4793109998216;58584.70707646434;67799.9999999995;70162;70642.2935770646;71282.64358678226;9647.842258928973;9694.321397502106;9759.658411955548;9869.939839142604;9996.250281228937;13894.791578126336;13980.86019139816;13995.720085598232;14077.507287244896;14093.647658808612;6812.352826481477;6962.617056061864;7060;7173.354398104196;7178.5692858428665;6517.283098859121;6530.575512591667;6596.708987147283;6690.397864192246;6767.898481522781;4273.700840941105;4336.501302350207;4372.497162826252;4397.494288156839;4458.264386376211;1642.7207374746322;1668.17425374438;1694.898306101638;1710.6578684263197;1725.4306078993902;815.2377527012262;818.9181081891763;835.4569529805675;836.4855613797592;869.7738587967174;15732.68534629301;17360.82639173592;17534.03562804058;18598.907005464887;18775.436736897915;787.4802630263998;819.8934138562068;821.4578378270313;865.1262225152641;912.7170577121113;9461.19579835708;9568.665096721581;9944.80110397788;9949.850752238723;10115.44365059914;378546;381684;391207;393640;394979;49814;82182;84726.576367119;85281.57359213164;85415.14584854196;852.5055467828645;887.627196577439;887.6360692116201;890.1632465482426;893.1648908270918;15819.920900395424;16083.839161608234;16460.506184814476;16594.917025414794;16862.494125176265;25049;26400.603990939766;35474.64525354713;37086.44370334501;38176.618233818415;50548.24177637265;51800.222996654324;52191.2171317423;53496.4650353507;54252.45747542474;7641.2740789624895;7668.769936901902;7795.4543181976715;7899.68401263943;7984.602694528318;10250.179985600986;11587.362695051854;11799.882001179878;11814.704632384259;12134.453949572115;10008.299419040597;10084.14284785772;10216.387016779017;10697.251192416456;11191.440427978405;10238.846417303597;10356.032353852745;10441.164706823283;10647.041766241075;10673.292273236246;10333.586656533655;10345.534450949575;10444.216683748597;10524.42115683614;10585.206109541661;7516.774496765106;7800.297973182441;7849.215078492105;7902.288794008567;7910.129885712682;9328.720138395858;9534.952325238606;9719.562619682272;9980.550875210778;10706.625268115578 19:27:39 INFO - PROCESS | 6735 | |3;mootools.html;1247.2578815604722;1346.1115663661978;1360.809486671866;1410.929453527324;1687.0261793701368;6956.408705260053;7461.738839140631;7483.438742094344;7779.260970207835;7784;7805.6097195140155;7910;7916.920830791691;7917.247861453153;7917.643706033228;2150.9139634414605;2182.7598964114013;2182.8253739700785;2183.159483598818;2184.377452426051;2133.4133113393787;2136.6688163334707;2156.611809874222;2156.751973523041;2176.5320456101936;2157.913683452668;2169.8047175754177;2170.392290158758;2177.77133400993;2198.8236293582936;2120.68189771534;2168.5229249565073;2169.1215057901495;2173.217641649005;2173.2936795541514;2115.777843326444;2147.795959383856;2150.4408853697996;2151.3223334649692;2152.7416709994745;7680.462367634268;7793.298603125746;7881.448298619099;7922.762317130495;7987.640556174986;4497.887552811173;4708.599769019637;4717.174494463455;4719.764011799396;4722.693024953367;2851.8431486268246;2990.7308342249303;2999.505081661523;3010.32267739759;3021.531662592302;938.2447130060299;939.976500587484;946.2004606107897;956.5934477846887;958.7459323279337;10776.299540529919;10833.29583577065;10862.782744345148;10894.782104357948;10925.890741092568;3982;4041.2725709372007;4072.083781149218;4112.362583799516;4129.236091323115;8591.183837535424;8611.870821937677;8615.095414981337;8626.654933802703;8632.223099921037;4614.492405835355;4614.76926153691;4616.884577885579;4618.51505591908;4620.353150558924;3744.850205991784;3823.8661646842784;4012.478377810866;4296.140771845643;4297.914041719148;3627.782333060025;3634.945475817865;3736.682381997506;3780.3762379207124;3802.296575133609;1191.118572256524;1224.650974472289;1229.7540491901655;1232.1128787273149;1234.4691782533596;781.8084569280562;782.5383024015745;787.2049230277461;807.6204184033495;815.2744057788573;4909.705417674951;4997.375328083989;5119.0017946500075;5166.276721259027;5236.396827207873;368.3976698098628;370.7719752352284;374.0629722545007;376.4654191048717;377.66010590468795;3419.7005138047384;3454.9481757773656;3461.13471632092;3524.6122926478065;3651.799151046665;9464.90535094654;9889.554970026365;9891.258155638356;9891.802163956681;9908.603655853685;9837.80324393508;9848.113669769755;9919.206463482904;9920.751981200383;9930.05664461875;7123.786286411416;7348.338649521462;7376.151742549569;7426.2945020223;7431.739889103964;4945.1346014448045;4953.851384458472;5081.796728130834;5109.565686916654;5176.6844449771215;8772.78068048304;8917.866232006396;9037.09629037091;9061.864072038792;9063.320250981335;8983.730488085368;9157.542122893696;9169;9274.350795444525;9311.813763724824;6150.876982460415;6346.301906790157;6869.313068693091;6976.407005404598;6982.895256571257;7273.3453989141235;7464.365528929885;7513.774586762406;7707.730229441942;7709.383249340151;6744.156980377453;6752.054712340178;6863.622500762306;6992.685329160302;7054.541454805421;6771.966140169267;6799.422049125879;6910.343517365842;6953.513254072166;7014.859702806018;5980.1328807321825;6060.575759696779;6070.453659170696;6070.817875463743;6073.331933487401;4308.956910430856;4373.978130109456;4374.803133858921;4438.178936896685;4505.662075344297;4177.12280421115;4326.091520780546;4329.22501774271;4434.312681534368;4487.147441986012 19:27:39 INFO - PROCESS | 6735 | |4;prototype.html;297.88829189054104;304.4687021148097;310.4536016610765;310.538849808035;314.0891414896798;4819.204831202852;4837.443693975194;4838.661293709437;4857.809836590031;4865.464798872121;4759.381280433538;4783.760811959397;4789.257665061912;4800.303955926389;4809;3855.942160867582;3864.516935383077;3866.5940076292004;3871.477350557681;3877.922441551167;3721.3487639663085;3797.126660868002;3800.5477288988623;3878.4764056852246;3886.8833934981994;3786.659200671939;3792.772433653976;3793.5827059023486;3802.1065049713297;3803.5166285148816;3786.280606684721;3788.166603347273;3788.5264341957395;3802.258559580883;3803.4104713769134;3149.2599239178776;3210.871565137392;3249.4313495138495;3341.198112453018;3353.6814002669707;4564.612007979325;4584.6561507887045;4591.931121033187;4599.908001839978;4601.401817763669;4277.572242775697;4278.465191851019;4301.37630043645;4308.562180953622;4323.762193079379;4675.2052151134385;4767.856964291077;4820.831270905502;4885.902281954341;4899.951000489985;3596.3166998270244;3599.2441587266703;3606.747527673064;3606.747527673064;3612.638736126393;5221.138512145491;5235.869103272411;5243.659162154448;5259.737013149365;5277.9472205278225;3642.3807952648112;3676.7058635309113;3702.315071711742;3721.497597824259;3724.255148970217;3757.1170774867883;3774.3960966245268;3776.2817917847315;3799.373103437957;3800.7339486235696;4297.78511074445;4305.892352691145;4318.265894797892;4323.373110898965;4327.17783621111;4899.701579081546;5013.824516141917;5018.498150185025;5033.421156566968;5042.218456139304;1310.6395741171254;1322.2397121655088;1324.1128443942582;1327.734453109382;1335.5192130832893;833.1168960901464;853.9316854651613;873.0004145253649;876.6055275126218;878.2578720980761;3952.8536724350192;3959.940600890989;3962.484876965976;4002.239574480839;4011.277969965376;4507.5267096955;4513.616342610915;4517.954820451819;4545.431821022372;4545.909081818411;3927.8428862845167;3931.292367373843;3968.2261958917734;4006.8397264109694;4011.1777085697363;2241.4396400899777;2393.628987506939;2404.953845077397;2407.205622144688;2590.9765642571456;4585.79363928624;4700.341952126705;4744.1934871072;4751.311059896296;4770.689905156154;5198.844034678966;5205.401378841481;5218.504242096995;5226.242194881721;5227.3988491323225;4572.702774319659;4784.832530861473;4788.497207793202;4793.664443488992;4799.856004319876;5208.166693329049;5219.347581552306;5223.5559977402345;5228.20291144236;5241.97781432617;5105.285260063668;5121.590272778243;5121.61587880903;5132.255822905732;5140.46025167367;4592.609628181642;4823.5658790709;4896.6327525436445;4922.744700101594;4938.111139994692;3627.8367473464286;3630.219502806909;3651.8356673949206;3659.7438179328256;3674.3018826422895;5180.818671346485;5188.832512684616;5256.684598924076;5260.685298468661;5264.447233040629;4922.483139270325;4982.377202849644;5094.5669618082875;5098.623371689549;5118;5024.522670346311;5027.170516864822;5036.622253330942;5054;5054.873628159326;4949.579285760607;4950.183219768698;4980.377452818398;4995.2507123930245;5006.3992320921725;4901.9264711028645;5063.620228482805;5075.695458272516;5089.506141990472;5094.15946368845;4896.314515967839;4911.877203069952;4912.557869791736;4922.8769280768265;4993.900121997613 19:27:39 INFO - PROCESS | 6735 | |5;yui.html;647.1425361396151;657;657.4346062386348;713.0619076386756;745.2994185465661;12414.627561173167;13704.794428083587;13713.108647937877;13715.039947203688;13720.58838234852;12907.096503244777;13043.21740695559;13069.869301306984;13072.411741471633;13079.346032698375;611.1443978430189;627.8304857688421;740.648192108748;749.1459735901077;763.5495057915829;753.8303881626645;771.2711487644178;772.4438404348859;772.9033870766154;773.2383602151876;826.3100311240091;828.1304630138361;828.6146941672122;828.6643909216747;828.7389472316231;657.2376043789181;672.2571558427965;783.7335305995932;824.6083110522484;824.789678631951;584.0334246821517;587.6973358720262;587.8060240120793;588.3116753398534;588.3968931844851;13026.153300035563;13026.80459793104;13041.413136408884;13044.54344097952;13048.151870128411;12031.81952270708;12140.45367958444;12829.16610420329;13209.273489958048;13282.136661116996;10811.459427028696;10928.562857485691;11158.553657853758;11274;11320.433978301053;3964.5044369453817;3999.320115580329;4046.4941882264716;4051.8379264829373;4086.897827554335;60457;62510;62537.37462625361;62588.37411625871;65724.34275657278;10210.846837297446;10302.690919272434;10400.167986561057;10561.841572376421;10751.193660475496;18970.14634341458;19101.2359505621;19102.71345929812;19109.522261943563;19113.139908704143;6856.040154378391;6869.656517174121;6885.173779146535;6924.515283930076;7189.209186989427;3602.5496812898386;3611.7832930024283;3676.7977761222855;3682.3187710273687;3694.9815250923575;2737.685166205872;2832.1928250448523;2834.744872961402;2840.928976775597;2843.360243945137;489.3271751341905;500.89982003599425;502.90444815484943;509.1497199676549;517.3894804131162;478.45934094473023;516.3184596332804;528.7303475227585;531.8909623527168;535.1704857470904;7152.821179470555;7468.850622987618;7537.2085930977555;7730.497517661334;7897.17079706634;437.1213860141076;481.0715319433527;493.437481271351;539.3473896585176;544.5262621519224;3340.1315657928626;3564.590072141737;3592.1539011884392;3617.131888346778;3889.086064774776;102351;102617;104320.47839760753;104975;105368.94631053592;50528.74735626298;61985;78860;87271.56364218138;87762.56118719494;46934;62885.68557157185;77283.84074238891;78104.60947695225;78130;6822.761203357859;8303.916960830315;8310.667573297;8506.574671266288;8939.390909636328;31336.529952051194;36728.449073263386;37616;40922;42291.36562951496;58302.4169758297;58364.4163558359;59822.70088649529;61757;61952.380476196464;10324.22568307365;10430.16558675289;10451.21615878797;10660.73348166271;11313.377764223047;11670;11898.167128301282;11901.702457438634;12140.696482588006;12654.620361389174;10817.242793004729;11190.720231993939;11221.382823944761;11613.709657258636;11948.581799636971;11671.416429178676;12022;12089.455974481345;12091.637250882488;12102.213356131822;10394.428306442916;11047.502862371373;11248.550057997589;11619;12037.518499259932;9464.337496375463;9578.760530986503;9602.90397096048;10014.849777253201;10086.092251697382;9348.95325523368;9444.197243234403;9802.16681582045;9921.206303495559;9977.653016842632 19:27:39 INFO - PROCESS | 6735 | __end_tp_report 19:27:39 INFO - PROCESS | 6735 | __start_cc_report 19:27:39 INFO - PROCESS | 6735 | _x_x_mozilla_cycle_collect,858 19:27:39 INFO - PROCESS | 6735 | __end_cc_report 19:27:39 INFO - PROCESS | 6735 | __startTimestamp1475116059895__endTimestamp 19:27:39 INFO - PROCESS | 6735 | 19:27:39 INFO - PROCESS | 6735 | ------- Summary: start ------- 19:27:39 INFO - PROCESS | 6735 | Number of tests: 6 19:27:39 INFO - PROCESS | 6735 | 19:27:39 INFO - PROCESS | 6735 | [#0] dojo.html Cycles:165 Average:4665.85 Median:4809.93 stddev:499.51 (10.4%) stddev-sans-first:473.02 19:27:39 INFO - PROCESS | 6735 | Values: 2563.1 2583.7 2611.9 2619.1 2634.0 4640.1 4698.4 4704.8 4720.7 4738.2 4691.4 4719.1 4720.7 4741.4 4825.0 4366.8 4367.1 4390.5 4419.7 4430.3 4243.0 4305.1 4312.8 4340.2 4406.8 4347.7 4354.8 4372.2 4411.5 4424.3 4275.4 4292.8 4301.4 4305.5 4315.0 4314.3 4324.7 4359.0 4360.3 4373.9 4647.4 4649.8 4660.9 4683.1 4812.5 5034.6 5041.7 5046.0 5048.4 5114.5 4879.0 4932.1 5061.2 5096.8 5161.9 4732.5 4740.8 4745.0 4790.2 4803.6 5184.6 5212.0 5213.8 5216.5 5225.6 4823.4 4862.1 4862.8 4958.4 5049.7 5095.9 5151.8 5152.0 5153.9 5155.3 5050.7 5053.8 5064.0 5111.3 5114.2 5019.6 5026.6 5030.0 5033.6 5087.8 4117.3 4180.0 4181.2 4187.2 4263.3 3681.3 3702.5 3732.6 3749.5 3798.1 4288.7 4336.8 4353.1 4355.1 4406.6 4932.8 4968.0 5032.0 5053.1 5099.4 4288.1 4318.3 4325.4 4337.8 4407.1 4510.5 4519.6 4522.5 4560.6 4585.5 4721.1 4726.3 4727.9 4751.1 4809.9 4930.1 4973.6 5064.4 5076.2 5103.6 4761.0 4772.3 4779.5 4831.1 4838.3 5043.2 5044.6 5045.8 5052.5 5111.2 4960.5 4982.4 5017.1 5082.1 5163.8 4867.1 4888.6 4890.7 4941.0 4946.3 4884.2 4884.9 4886.9 4898.6 4920.1 4724.9 4812.7 4840.0 4846.8 4897.9 4928.5 4933.4 4957.4 4958.4 5021.2 4801.3 4846.5 4848.1 4850.8 4906.2 19:27:39 INFO - PROCESS | 6735 | 19:27:39 INFO - PROCESS | 6735 | [#1] ext.html Cycles:180 Average:49867.84 Median:3481.73 stddev:101070.21 (2902.9%) stddev-sans-first:101285.84 19:27:39 INFO - PROCESS | 6735 | Values: 526.5 561.0 563.5 575.2 577.9 27119.7 29775.6 37554.6 38653.2 38759.4 39121.6 39494.0 39549.8 39656.4 39730.2 7298.9 7708.6 7844.2 7847.4 7858.3 7266.3 7506.5 7507.8 9875.0 10144.5 10173.8 10215.6 10235.3 10237.5 10239.9 10164.9 10260.9 10271.5 10273.5 10276.8 9941.4 9960.8 10003.9 10011.2 10014.1 37356.3 37429.0 37658.4 37677.2 37707.2 3155.0 3196.9 3372.5 3441.4 3651.0 27171.2 27440.7 27481.5 27589.3 28930.1 3394.7 3404.9 3470.2 3480.6 3482.8 243260.0 243926.0 244603.0 245348.0 245703.0 29747.9 50297.5 50574.5 50607.0 50684.2 31289.5 33492.2 33557.2 33640.8 33672.5 12569.8 12694.5 12700.6 12718.6 12718.8 10341.3 10347.2 10389.2 10415.2 10417.6 7149.1 7342.5 7521.9 7693.1 7743.5 3045.4 3052.4 3061.3 3094.4 3138.1 848.2 848.6 852.4 886.5 952.8 26339.5 27583.9 27727.4 27819.4 27921.2 882.1 910.9 922.7 952.5 986.9 14462.0 14539.9 14663.2 14725.4 14932.7 364204.0 365209.0 367544.0 368657.0 371761.0 45965.3 46312.5 46800.0 47139.5 47769.3 1120.7 1148.2 1152.7 1156.9 1163.5 27076.0 28040.0 28603.4 28967.3 29150.9 41713.6 42148.6 42155.2 42171.6 42266.2 368145.0 386582.0 386700.0 609922.0 615582.0 34165.9 34171.3 34363.1 34443.5 34729.0 40898.8 41333.4 42555.0 44562.0 45671.5 34890.1 34956.3 35039.3 35044.1 35497.1 35233.1 35273.8 35322.5 35622.0 35672.5 34422.7 35055.8 35149.3 35331.5 35643.5 30928.7 32920.3 33040.0 33131.5 33402.7 24855.8 25205.4 25510.6 25760.0 25917.4 19:27:39 INFO - PROCESS | 6735 | 19:27:39 INFO - PROCESS | 6735 | [#2] jquery.html Cycles:180 Average:24174.10 Median:4354.50 stddev:64110.30 (1472.3%) stddev-sans-first:64265.19 19:27:39 INFO - PROCESS | 6735 | Values: 348.8 361.9 365.7 370.4 391.0 12224.4 12378.3 13873.4 14156.6 17023.2 15793.6 15801.8 15820.2 15899.8 16384.7 4897.0 4934.5 5062.5 5129.7 5138.6 3717.4 3909.3 5041.8 5147.1 5147.5 5730.3 5992.4 6006.7 6019.2 6026.8 5787.2 5788.0 5811.5 5952.4 5975.3 5067.9 5208.0 5211.1 5211.3 5214.9 19608.7 20036.6 20144.4 20155.8 20439.7 1920.8 1937.4 2003.8 2023.5 2450.8 12078.6 13195.9 13516.9 13709.5 13716.7 1715.5 1732.4 1778.2 1782.7 1795.5 58584.7 67800.0 70162.0 70642.3 71282.6 9647.8 9694.3 9759.7 9869.9 9996.3 13894.8 13980.9 13995.7 14077.5 14093.6 6812.4 6962.6 7060.0 7173.4 7178.6 6517.3 6530.6 6596.7 6690.4 6767.9 4273.7 4336.5 4372.5 4397.5 4458.3 1642.7 1668.2 1694.9 1710.7 1725.4 815.2 818.9 835.5 836.5 869.8 15732.7 17360.8 17534.0 18598.9 18775.4 787.5 819.9 821.5 865.1 912.7 9461.2 9568.7 9944.8 9949.9 10115.4 378546.0 381684.0 391207.0 393640.0 394979.0 49814.0 82182.0 84726.6 85281.6 85415.1 852.5 887.6 887.6 890.2 893.2 15819.9 16083.8 16460.5 16594.9 16862.5 25049.0 26400.6 35474.6 37086.4 38176.6 50548.2 51800.2 52191.2 53496.5 54252.5 7641.3 7668.8 7795.5 7899.7 7984.6 10250.2 11587.4 11799.9 11814.7 12134.5 10008.3 10084.1 10216.4 10697.3 11191.4 10238.8 10356.0 10441.2 10647.0 10673.3 10333.6 10345.5 10444.2 10524.4 10585.2 7516.8 7800.3 7849.2 7902.3 7910.1 9328.7 9535.0 9719.6 9980.6 10706.6 19:27:39 INFO - PROCESS | 6735 | 19:27:39 INFO - PROCESS | 6735 | [#3] mootools.html Cycles:180 Average:5110.02 Median:4927.42 stddev:2929.02 (59.4%) stddev-sans-first:2922.85 19:27:39 INFO - PROCESS | 6735 | Values: 1247.3 1346.1 1360.8 1410.9 1687.0 6956.4 7461.7 7483.4 7779.3 7784.0 7805.6 7910.0 7916.9 7917.2 7917.6 2150.9 2182.8 2182.8 2183.2 2184.4 2133.4 2136.7 2156.6 2156.8 2176.5 2157.9 2169.8 2170.4 2177.8 2198.8 2120.7 2168.5 2169.1 2173.2 2173.3 2115.8 2147.8 2150.4 2151.3 2152.7 7680.5 7793.3 7881.4 7922.8 7987.6 4497.9 4708.6 4717.2 4719.8 4722.7 2851.8 2990.7 2999.5 3010.3 3021.5 938.2 940.0 946.2 956.6 958.7 10776.3 10833.3 10862.8 10894.8 10925.9 3982.0 4041.3 4072.1 4112.4 4129.2 8591.2 8611.9 8615.1 8626.7 8632.2 4614.5 4614.8 4616.9 4618.5 4620.4 3744.9 3823.9 4012.5 4296.1 4297.9 3627.8 3634.9 3736.7 3780.4 3802.3 1191.1 1224.7 1229.8 1232.1 1234.5 781.8 782.5 787.2 807.6 815.3 4909.7 4997.4 5119.0 5166.3 5236.4 368.4 370.8 374.1 376.5 377.7 3419.7 3454.9 3461.1 3524.6 3651.8 9464.9 9889.6 9891.3 9891.8 9908.6 9837.8 9848.1 9919.2 9920.8 9930.1 7123.8 7348.3 7376.2 7426.3 7431.7 4945.1 4953.9 5081.8 5109.6 5176.7 8772.8 8917.9 9037.1 9061.9 9063.3 8983.7 9157.5 9169.0 9274.4 9311.8 6150.9 6346.3 6869.3 6976.4 6982.9 7273.3 7464.4 7513.8 7707.7 7709.4 6744.2 6752.1 6863.6 6992.7 7054.5 6772.0 6799.4 6910.3 6953.5 7014.9 5980.1 6060.6 6070.5 6070.8 6073.3 4309.0 4374.0 4374.8 4438.2 4505.7 4177.1 4326.1 4329.2 4434.3 4487.1 19:27:39 INFO - PROCESS | 6735 | 19:27:39 INFO - PROCESS | 6735 | [#4] prototype.html Cycles:180 Average:4129.13 Median:4596.26 stddev:1201.78 (26.1%) stddev-sans-first:1170.24 19:27:39 INFO - PROCESS | 6735 | Values: 297.9 304.5 310.5 310.5 314.1 4819.2 4837.4 4838.7 4857.8 4865.5 4759.4 4783.8 4789.3 4800.3 4809.0 3855.9 3864.5 3866.6 3871.5 3877.9 3721.3 3797.1 3800.5 3878.5 3886.9 3786.7 3792.8 3793.6 3802.1 3803.5 3786.3 3788.2 3788.5 3802.3 3803.4 3149.3 3210.9 3249.4 3341.2 3353.7 4564.6 4584.7 4591.9 4599.9 4601.4 4277.6 4278.5 4301.4 4308.6 4323.8 4675.2 4767.9 4820.8 4885.9 4900.0 3596.3 3599.2 3606.7 3606.7 3612.6 5221.1 5235.9 5243.7 5259.7 5277.9 3642.4 3676.7 3702.3 3721.5 3724.3 3757.1 3774.4 3776.3 3799.4 3800.7 4297.8 4305.9 4318.3 4323.4 4327.2 4899.7 5013.8 5018.5 5033.4 5042.2 1310.6 1322.2 1324.1 1327.7 1335.5 833.1 853.9 873.0 876.6 878.3 3952.9 3959.9 3962.5 4002.2 4011.3 4507.5 4513.6 4518.0 4545.4 4545.9 3927.8 3931.3 3968.2 4006.8 4011.2 2241.4 2393.6 2405.0 2407.2 2591.0 4585.8 4700.3 4744.2 4751.3 4770.7 5198.8 5205.4 5218.5 5226.2 5227.4 4572.7 4784.8 4788.5 4793.7 4799.9 5208.2 5219.3 5223.6 5228.2 5242.0 5105.3 5121.6 5121.6 5132.3 5140.5 4592.6 4823.6 4896.6 4922.7 4938.1 3627.8 3630.2 3651.8 3659.7 3674.3 5180.8 5188.8 5256.7 5260.7 5264.4 4922.5 4982.4 5094.6 5098.6 5118.0 5024.5 5027.2 5036.6 5054.0 5054.9 4949.6 4950.2 4980.4 4995.3 5006.4 4901.9 5063.6 5075.7 5089.5 5094.2 4896.3 4911.9 4912.6 4922.9 4993.9 19:27:39 INFO - PROCESS | 6735 | 19:27:39 INFO - PROCESS | 6735 | [#5] yui.html Cycles:180 Average:17185.73 Median:41606.68 stddev:24772.10 (59.5%) stddev-sans-first:24810.47 19:27:39 INFO - PROCESS | 6735 | Values: 647.1 657.0 657.4 713.1 745.3 12414.6 13704.8 13713.1 13715.0 13720.6 12907.1 13043.2 13069.9 13072.4 13079.3 611.1 627.8 740.6 749.1 763.5 753.8 771.3 772.4 772.9 773.2 826.3 828.1 828.6 828.7 828.7 657.2 672.3 783.7 824.6 824.8 584.0 587.7 587.8 588.3 588.4 13026.2 13026.8 13041.4 13044.5 13048.2 12031.8 12140.5 12829.2 13209.3 13282.1 10811.5 10928.6 11158.6 11274.0 11320.4 3964.5 3999.3 4046.5 4051.8 4086.9 60457.0 62510.0 62537.4 62588.4 65724.3 10210.8 10302.7 10400.2 10561.8 10751.2 18970.1 19101.2 19102.7 19109.5 19113.1 6856.0 6869.7 6885.2 6924.5 7189.2 3602.5 3611.8 3676.8 3682.3 3695.0 2737.7 2832.2 2834.7 2840.9 2843.4 489.3 500.9 502.9 509.1 517.4 478.5 516.3 528.7 531.9 535.2 7152.8 7468.9 7537.2 7730.5 7897.2 437.1 481.1 493.4 539.3 544.5 3340.1 3564.6 3592.2 3617.1 3889.1 102351.0 102617.0 104320.5 104975.0 105368.9 50528.7 61985.0 78860.0 87271.6 87762.6 46934.0 62885.7 77283.8 78104.6 78130.0 6822.8 8303.9 8310.7 8506.6 8939.4 31336.5 36728.4 37616.0 40922.0 42291.4 58302.4 58364.4 59822.7 61757.0 61952.4 10324.2 10430.2 10451.2 10660.7 11313.4 11670.0 11898.2 11901.7 12140.7 12654.6 10817.2 11190.7 11221.4 11613.7 11948.6 11671.4 12022.0 12089.5 12091.6 12102.2 10394.4 11047.5 11248.6 11619.0 12037.5 9464.3 9578.8 9602.9 10014.8 10086.1 9349.0 9444.2 9802.2 9921.2 9977.7 19:27:39 INFO - PROCESS | 6735 | -------- Summary: end -------- 19:27:39 INFO - PROCESS | 6735 | 19:27:40 INFO - TEST-INFO | 6735: exit 0 19:27:40 INFO - TEST-OK | dromaeo_css | took 1121876ms 19:27:40 INFO - TEST-START | kraken 19:27:40 INFO - operating with platform_type : linux_ 19:27:40 INFO - Initialising browser for kraken test... 19:27:40 INFO - TEST-INFO | started process 7041 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjclT0w/profile http://localhost:60508/getInfo.html) 19:27:46 INFO - PROCESS | 7041 | __metrics Screen width/height:1600/1200 19:27:46 INFO - PROCESS | 7041 | colorDepth:24 19:27:46 INFO - PROCESS | 7041 | Browser inner width/height: 1024/697 19:27:46 INFO - PROCESS | 7041 | __metrics 19:27:46 INFO - PROCESS | 7041 | 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" 19:27:46 INFO - PROCESS | 7041 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:27:47 INFO - PROCESS | 7041 | console.error: PushService: 19:27:47 INFO - PROCESS | 7041 | stateChangeProcessEnqueue: Error transitioning state 19:27:47 INFO - PROCESS | 7041 | UnknownError 19:27:48 INFO - TEST-INFO | 7041: exit 0 19:27:48 INFO - Browser initialized. 19:27:48 INFO - Running cycle 1/1 for kraken test... 19:27:48 INFO - TEST-INFO | started process 7122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjclT0w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:28:00 INFO - PROCESS | 7122 | RSS: Main: 174829568 19:28:00 INFO - PROCESS | 7122 | 19:28:03 INFO - PROCESS | 7122 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60508/tests/kraken/driver.html?testName=audio-beat-detection) 19:28:04 INFO - PROCESS | 7122 | RSS: Main: 233897984 19:28:04 INFO - PROCESS | 7122 | 19:28:07 INFO - PROCESS | 7122 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60508/tests/kraken/driver.html?testName=audio-dft) 19:28:07 INFO - PROCESS | 7122 | RSS: Main: 218124288 19:28:07 INFO - PROCESS | 7122 | 19:28:10 INFO - PROCESS | 7122 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60508/tests/kraken/driver.html?testName=audio-fft) 19:28:11 INFO - PROCESS | 7122 | RSS: Main: 300417024 19:28:11 INFO - PROCESS | 7122 | 19:28:13 INFO - PROCESS | 7122 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60508/tests/kraken/driver.html?testName=audio-oscillator) 19:28:14 INFO - PROCESS | 7122 | RSS: Main: 209883136 19:28:14 INFO - PROCESS | 7122 | 19:28:16 INFO - PROCESS | 7122 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60508/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:28:17 INFO - PROCESS | 7122 | RSS: Main: 213811200 19:28:17 INFO - PROCESS | 7122 | 19:28:20 INFO - PROCESS | 7122 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60508/tests/kraken/driver.html?testName=imaging-darkroom) 19:28:20 INFO - PROCESS | 7122 | RSS: Main: 249757696 19:28:20 INFO - PROCESS | 7122 | 19:28:24 INFO - PROCESS | 7122 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60508/tests/kraken/driver.html?testName=imaging-desaturate) 19:28:24 INFO - PROCESS | 7122 | RSS: Main: 244387840 19:28:24 INFO - PROCESS | 7122 | 19:28:27 INFO - PROCESS | 7122 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60508/tests/kraken/driver.html?testName=json-parse-financial) 19:28:28 INFO - PROCESS | 7122 | RSS: Main: 247382016 19:28:28 INFO - PROCESS | 7122 | 19:28:30 INFO - PROCESS | 7122 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60508/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:28:30 INFO - PROCESS | 7122 | RSS: Main: 210853888 19:28:30 INFO - PROCESS | 7122 | 19:28:32 INFO - PROCESS | 7122 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60508/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:28:33 INFO - PROCESS | 7122 | RSS: Main: 218099712 19:28:33 INFO - PROCESS | 7122 | 19:28:35 INFO - PROCESS | 7122 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60508/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:28:36 INFO - PROCESS | 7122 | RSS: Main: 222793728 19:28:36 INFO - PROCESS | 7122 | 19:28:39 INFO - PROCESS | 7122 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60508/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:28:39 INFO - PROCESS | 7122 | RSS: Main: 223006720 19:28:39 INFO - PROCESS | 7122 | 19:28:42 INFO - PROCESS | 7122 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60508/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:28:43 INFO - PROCESS | 7122 | RSS: Main: 221736960 19:28:43 INFO - PROCESS | 7122 | 19:28:44 INFO - PROCESS | 7122 | Cycle 1(1): loaded http://localhost:60508/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60508/tests/kraken/driver.html?testName=ai-astar) 19:28:45 INFO - PROCESS | 7122 | RSS: Main: 272748544 19:28:45 INFO - PROCESS | 7122 | 19:28:45 INFO - PROCESS | 7122 | __start_tp_report 19:28:45 INFO - PROCESS | 7122 | _x_x_mozilla_page_load 19:28:45 INFO - PROCESS | 7122 | _x_x_mozilla_page_load_details 19:28:45 INFO - PROCESS | 7122 | |i|pagename|runs| 19:28:45 INFO - PROCESS | 7122 | |0;ai-astar;112;117;116;114;115;116;114;115;114;113 19:28:45 INFO - PROCESS | 7122 | |1;audio-beat-detection;154;127;129;169;129;129;122;125;166;125 19:28:45 INFO - PROCESS | 7122 | |2;audio-dft;161;161;162;163;163;161;162;163;164;163 19:28:45 INFO - PROCESS | 7122 | |3;audio-fft;77;76;77;107;76;79;78;76;98;78 19:28:45 INFO - PROCESS | 7122 | |4;audio-oscillator;83;84;113;83;84;84;107;83;84;116 19:28:45 INFO - PROCESS | 7122 | |5;imaging-gaussian-blur;117;117;117;117;118;117;120;117;118;117 19:28:45 INFO - PROCESS | 7122 | |6;imaging-darkroom;147;147;147;147;147;147;148;147;147;146 19:28:45 INFO - PROCESS | 7122 | |7;imaging-desaturate;97;96;96;97;96;95;95;95;95;95 19:28:45 INFO - PROCESS | 7122 | |8;json-parse-financial;63;64;62;63;63;66;65;64;63;65 19:28:45 INFO - PROCESS | 7122 | |9;json-stringify-tinderbox;66;67;66;67;67;66;71;66;67;67 19:28:45 INFO - PROCESS | 7122 | |10;stanford-crypto-aes;83;82;82;83;84;82;82;82;82;82 19:28:45 INFO - PROCESS | 7122 | |11;stanford-crypto-ccm;143;132;133;136;133;137;133;136;174;137 19:28:45 INFO - PROCESS | 7122 | |12;stanford-crypto-pbkdf2;181;176;174;179;173;173;172;174;174;173 19:28:45 INFO - PROCESS | 7122 | |13;stanford-crypto-sha256-iterative;69;69;71;72;67;67;69;70;67;68 19:28:45 INFO - PROCESS | 7122 | __end_tp_report 19:28:45 INFO - PROCESS | 7122 | __start_cc_report 19:28:45 INFO - PROCESS | 7122 | _x_x_mozilla_cycle_collect,1892 19:28:45 INFO - PROCESS | 7122 | __end_cc_report 19:28:45 INFO - PROCESS | 7122 | __startTimestamp1475116125248__endTimestamp 19:28:45 INFO - PROCESS | 7122 | 19:28:45 INFO - PROCESS | 7122 | ------- Summary: start ------- 19:28:45 INFO - PROCESS | 7122 | Number of tests: 14 19:28:45 INFO - PROCESS | 7122 | 19:28:45 INFO - PROCESS | 7122 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:1.51 (1.3%) stddev-sans-first:1.27 19:28:45 INFO - PROCESS | 7122 | Values: 112.0 117.0 116.0 114.0 115.0 116.0 114.0 115.0 114.0 113.0 19:28:45 INFO - PROCESS | 7122 | 19:28:45 INFO - PROCESS | 7122 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:129.00 stddev:18.12 (14.1%) stddev-sans-first:18.21 19:28:45 INFO - PROCESS | 7122 | Values: 154.0 127.0 129.0 169.0 129.0 129.0 122.0 125.0 166.0 125.0 19:28:45 INFO - PROCESS | 7122 | 19:28:45 INFO - PROCESS | 7122 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:1.01 19:28:45 INFO - PROCESS | 7122 | Values: 161.0 161.0 162.0 163.0 163.0 161.0 162.0 163.0 164.0 163.0 19:28:45 INFO - PROCESS | 7122 | 19:28:45 INFO - PROCESS | 7122 | [#3] audio-fft Cycles:10 Average:82.20 Median:77.50 stddev:10.95 (14.1%) stddev-sans-first:11.45 19:28:45 INFO - PROCESS | 7122 | Values: 77.0 76.0 77.0 107.0 76.0 79.0 78.0 76.0 98.0 78.0 19:28:45 INFO - PROCESS | 7122 | 19:28:45 INFO - PROCESS | 7122 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:83.50 stddev:13.91 (16.7%) stddev-sans-first:14.36 19:28:45 INFO - PROCESS | 7122 | Values: 83.0 84.0 113.0 83.0 84.0 84.0 107.0 83.0 84.0 116.0 19:28:45 INFO - PROCESS | 7122 | 19:28:45 INFO - PROCESS | 7122 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 19:28:45 INFO - PROCESS | 7122 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 120.0 117.0 118.0 117.0 19:28:45 INFO - PROCESS | 7122 | 19:28:45 INFO - PROCESS | 7122 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 19:28:45 INFO - PROCESS | 7122 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 146.0 19:28:45 INFO - PROCESS | 7122 | 19:28:45 INFO - PROCESS | 7122 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 19:28:45 INFO - PROCESS | 7122 | Values: 97.0 96.0 96.0 97.0 96.0 95.0 95.0 95.0 95.0 95.0 19:28:45 INFO - PROCESS | 7122 | 19:28:45 INFO - PROCESS | 7122 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.23 (1.9%) stddev-sans-first:1.27 19:28:45 INFO - PROCESS | 7122 | Values: 63.0 64.0 62.0 63.0 63.0 66.0 65.0 64.0 63.0 65.0 19:28:45 INFO - PROCESS | 7122 | 19:28:45 INFO - PROCESS | 7122 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:1.49 (2.2%) stddev-sans-first:1.54 19:28:45 INFO - PROCESS | 7122 | Values: 66.0 67.0 66.0 67.0 67.0 66.0 71.0 66.0 67.0 67.0 19:28:45 INFO - PROCESS | 7122 | 19:28:45 INFO - PROCESS | 7122 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:0.70 (0.9%) stddev-sans-first:0.71 19:28:45 INFO - PROCESS | 7122 | Values: 83.0 82.0 82.0 83.0 84.0 82.0 82.0 82.0 82.0 82.0 19:28:45 INFO - PROCESS | 7122 | 19:28:45 INFO - PROCESS | 7122 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:136.50 stddev:12.57 (9.2%) stddev-sans-first:13.27 19:28:45 INFO - PROCESS | 7122 | Values: 143.0 132.0 133.0 136.0 133.0 137.0 133.0 136.0 174.0 137.0 19:28:45 INFO - PROCESS | 7122 | 19:28:45 INFO - PROCESS | 7122 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:174.00 stddev:2.92 (1.7%) stddev-sans-first:2.11 19:28:45 INFO - PROCESS | 7122 | Values: 181.0 176.0 174.0 179.0 173.0 173.0 172.0 174.0 174.0 173.0 19:28:45 INFO - PROCESS | 7122 | 19:28:45 INFO - PROCESS | 7122 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.73 (2.5%) stddev-sans-first:1.83 19:28:45 INFO - PROCESS | 7122 | Values: 69.0 69.0 71.0 72.0 67.0 67.0 69.0 70.0 67.0 68.0 19:28:45 INFO - PROCESS | 7122 | -------- Summary: end -------- 19:28:45 INFO - PROCESS | 7122 | 19:28:46 INFO - TEST-INFO | 7122: exit 0 19:28:46 INFO - TEST-OK | kraken | took 65684ms 19:28:46 INFO - SUITE-END | took 1187s 19:28:46 INFO - Completed test suite (00:19:47) 19:28:46 INFO - javascript benchmark 19:28:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2563.1413476485377, 2583.677040369954, 2611.9216423507296, 2619.122593931033, 2634.012245407971, 4640.141573808839, 4698.412698412699, 4704.835330763424, 4720.69315494493, 4738.241881298993, 4691.413573303337, 4719.1033703596295, 4720.740359280238, 4741.359916411284, 4825.0, 4366.8034938427845, 4367.08291258836, 4390.517043125254, 4419.690621656486, 4430.313301438282, 4243.002894319832, 4305.138972205556, 4312.805923733439, 4340.175366680336, 4406.801693923781, 4347.739135651871, 4354.825806967718, 4372.234858899696, 4411.492678341983, 4424.336349547561, 4275.40144379787, 4292.828286868522, 4301.354796780477, 4305.547917468683, 4315.007548263886, 4314.331278651814, 4324.6972711910175, 4359.0192206753545, 4360.258756011485, 4373.890652733707, 4647.3958385410015, 4649.837255696035, 4660.930086048678, 4683.110209060268, 4812.518748125194, 5034.622403319729, 5041.72270525121, 5046.041252162077, 5048.3941926969, 5114.462981386975, 4878.975605121987, 4932.087563800673, 5061.16490779021, 5096.847094587169, 5161.922571161435, 4732.503087175797, 4740.834070807505, 4744.952550474451, 4790.185668436374, 4803.5916947059895, 5184.585233181412, 5212.035773381936, 5213.791448342024, 5216.504432078947, 5225.608079394061, 4823.421189457287, 4862.149123903303, 4862.80548778052, 4958.380202474691, 5049.671771334852, 5095.923561146586, 5151.793928242903, 5152.046871328816, 5153.948460515422, 5155.278261043457, 5050.671706339076, 5053.823116190915, 5064.037832811754, 5111.309973153577, 5114.156164232934, 5019.623528235324, 5026.572741317029, 5030.0, 5033.6224783141415, 5087.771050302746, 4117.279476091732, 4180.038591124058, 4181.226473102425, 4187.1625674865145, 4263.296556068214, 3681.3005528949416, 3702.5371828521434, 3732.5894151643297, 3749.456328832304, 3798.1074447504816, 4288.656907447459, 4336.848210312624, 4353.06409122034, 4355.08543205924, 4406.603405693503, 4932.802687892516, 4968.0312339093525, 5032.0, 5053.0651829410945, 5099.4390617032095, 4288.056627541936, 4318.330658747899, 4325.437693099877, 4337.783110844445, 4407.118576284756, 4510.458744950627, 4519.638428925678, 4522.525134860858, 4560.566746159109, 4585.518520555361, 4721.055788842176, 4726.291056341507, 4727.929081063718, 4751.121042607128, 4809.927851082307, 4930.13722598551, 4973.626977976739, 5064.41759197697, 5076.18780995039, 5103.642745007963, 4761.023990082094, 4772.260299653559, 4779.545943135397, 4831.057943700945, 4838.298446725275, 5043.218301163325, 5044.571211446922, 5045.7981680732355, 5052.545270925634, 5111.207762796773, 4960.47914968923, 4982.352294201731, 5017.096922553976, 5082.1106306395495, 5163.845084647466, 4867.075255701406, 4888.560029597354, 4890.657653964331, 4940.950590494049, 4946.307516947702, 4884.169691152441, 4884.92672609904, 4886.853394398174, 4898.632602554894, 4920.114379411741, 4724.858254252378, 4812.735299558558, 4839.975800120977, 4846.806127754991, 4897.90204195907, 4928.457869634266, 4933.432655244693, 4957.429895562056, 4958.355413796184, 5021.171506701354, 4801.327814105958, 4846.539578740014, 4848.0546293472435, 4850.757462126809, 4906.190478571139], "value": 4633.138519023561, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.5419085395706, 560.980365687201, 563.5378989228832, 575.2378099018802, 577.9393163717809, 27119.72880271197, 29775.55336669949, 37554.55895366799, 38653.22693546127, 38759.418608720895, 39121.608783912154, 39494.0, 39549.802250988774, 39656.405153922715, 39730.205395892066, 7298.854022919539, 7708.57602831844, 7844.215578442138, 7847.372210223169, 7858.29275365217, 7266.3460288574015, 7506.512076715024, 7507.774766757006, 9874.950625246864, 10144.54349554268, 10173.796524069514, 10215.591376344975, 10235.283530152892, 10237.488125593727, 10239.948800255988, 10164.949175254113, 10260.948695256477, 10271.486425678686, 10273.48632568376, 10276.794464110713, 9941.403515789076, 9960.800783984352, 10003.89996100037, 10011.199104071657, 10014.098731114234, 37356.25287494235, 37429.0, 37658.43512347317, 37677.24645507102, 37707.24585508302, 3155.0, 3196.8881089162, 3372.4772660237704, 3441.380551500729, 3650.981745091284, 27171.1848644539, 27440.725592744016, 27481.45037099267, 27589.31026724328, 28930.13209603694, 3394.7114495267933, 3404.871325807714, 3470.23654795947, 3480.6345333739846, 3482.8258587070545, 243260.0, 243926.0, 244603.0, 245347.99999999822, 245703.0, 29747.85126074356, 50297.49702503001, 50574.49425505772, 50606.98786024259, 50684.239736403986, 31289.530657040163, 33492.1626959328, 33557.16107097342, 33640.831795840866, 33672.49491257633, 12569.811452828215, 12694.492220311084, 12700.555480558322, 12718.554850580185, 12718.809217861555, 10341.276110672181, 10347.172226221885, 10389.220808439397, 10415.177343964928, 10417.5832966682, 7149.14210294768, 7342.486025978237, 7521.9247807522315, 7693.076830780342, 7743.5353878767455, 3045.4061458015917, 3052.420040192401, 3061.2959019425657, 3094.3656550407113, 3138.074268090919, 848.1984524624294, 848.6435697007272, 852.4373913217247, 886.5035580075179, 952.8189643967762, 26339.47321053568, 27583.86208068947, 27727.445451090865, 27819.443611127663, 27921.16236512867, 882.0958517519465, 910.8679241509944, 922.7231830450838, 952.4618590496348, 986.935849169816, 14462.0, 14539.854601454063, 14663.19352435605, 14725.410983560538, 14932.70134597302, 364204.0, 365209.0, 367544.0, 368657.0, 371761.0, 45965.310520342224, 46312.5368746315, 46800.0, 47139.528604713516, 47769.28346074812, 1120.7086157599083, 1148.179051977823, 1152.7233463968587, 1156.8727439981594, 1163.5229555882047, 27076.0, 28040.027191298588, 28603.427931440838, 28967.275818104717, 29150.854245728635, 41713.58286417097, 42148.57851421447, 42155.15689686251, 42171.57828421799, 42266.1546769069, 368145.0, 386582.0, 386700.0, 609922.0, 615582.0, 34165.89608377337, 34171.31657366888, 34363.14092147716, 34443.4833477493, 34729.0, 40898.79550602228, 41333.37999929943, 42555.0, 44562.0, 45671.543284568055, 34890.12774680653, 34956.30087398289, 35039.299214016086, 35044.12389690278, 35497.112572184866, 35233.1191720209, 35273.823630881685, 35322.47016294809, 35622.0, 35672.464913025804, 34422.65577344195, 35055.82472087623, 35149.29701406009, 35331.47002795011, 35643.46534802032, 30928.69071309258, 32920.341593167526, 33040.0, 33131.50302745509, 33402.66597333996, 24855.751442485343, 25205.369865752768, 25510.596148760633, 25760.0, 25917.352066198495], "value": 16844.132699844868, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.83953381444536, 361.90409541471513, 365.73484223937646, 370.4165938646631, 391.03414566021934, 12224.44989975451, 12378.304546203091, 13873.375698093585, 14156.575302740908, 17023.23395447205, 15793.60515987098, 15801.762973555406, 15820.208989550534, 15899.84100158998, 16384.67230655386, 4897.0, 4934.475655989725, 5062.519060689228, 5129.717865517395, 5138.6146039047035, 3717.3866312058476, 3909.2963266612, 5041.798328066873, 5147.073526765181, 5147.507222905353, 5730.283714535683, 5992.370801065891, 6006.669633170174, 6019.157317975487, 6026.758929642809, 5787.160861675034, 5788.0, 5811.535077193815, 5952.375000624916, 5975.25309336333, 5067.9239811402485, 5208.0, 5211.114110601206, 5211.348581427322, 5214.947850521484, 19608.70586941197, 20036.599268014557, 20144.395668129833, 20155.798442015537, 20439.693404598944, 1920.8175223353899, 1937.447827369207, 2003.8196562309463, 2023.5345870449733, 2450.8161887858305, 12078.577249796303, 13195.868041319656, 13516.918646508257, 13709.520166794115, 13716.65708357289, 1715.5282297368199, 1732.3503686117706, 1778.1731494854955, 1782.6523827853573, 1795.4793109998216, 58584.70707646434, 67799.9999999995, 70162.0, 70642.2935770646, 71282.64358678226, 9647.842258928973, 9694.321397502106, 9759.658411955548, 9869.939839142604, 9996.250281228937, 13894.791578126336, 13980.86019139816, 13995.720085598232, 14077.507287244896, 14093.647658808612, 6812.352826481477, 6962.617056061864, 7060.0, 7173.354398104196, 7178.5692858428665, 6517.283098859121, 6530.575512591667, 6596.708987147283, 6690.397864192246, 6767.898481522781, 4273.700840941105, 4336.501302350207, 4372.497162826252, 4397.494288156839, 4458.264386376211, 1642.7207374746322, 1668.17425374438, 1694.898306101638, 1710.6578684263197, 1725.4306078993902, 815.2377527012262, 818.9181081891763, 835.4569529805675, 836.4855613797592, 869.7738587967174, 15732.68534629301, 17360.82639173592, 17534.03562804058, 18598.907005464887, 18775.436736897915, 787.4802630263998, 819.8934138562068, 821.4578378270313, 865.1262225152641, 912.7170577121113, 9461.19579835708, 9568.665096721581, 9944.80110397788, 9949.850752238723, 10115.44365059914, 378546.0, 381684.0, 391207.0, 393640.0, 394979.0, 49814.0, 82182.0, 84726.576367119, 85281.57359213164, 85415.14584854196, 852.5055467828645, 887.627196577439, 887.6360692116201, 890.1632465482426, 893.1648908270918, 15819.920900395424, 16083.839161608234, 16460.506184814476, 16594.917025414794, 16862.494125176265, 25049.0, 26400.603990939766, 35474.64525354713, 37086.44370334501, 38176.618233818415, 50548.24177637265, 51800.222996654324, 52191.2171317423, 53496.4650353507, 54252.45747542474, 7641.2740789624895, 7668.769936901902, 7795.4543181976715, 7899.68401263943, 7984.602694528318, 10250.179985600986, 11587.362695051854, 11799.882001179878, 11814.704632384259, 12134.453949572115, 10008.299419040597, 10084.14284785772, 10216.387016779017, 10697.251192416456, 11191.440427978405, 10238.846417303597, 10356.032353852745, 10441.164706823283, 10647.041766241075, 10673.292273236246, 10333.586656533655, 10345.534450949575, 10444.216683748597, 10524.42115683614, 10585.206109541661, 7516.774496765106, 7800.297973182441, 7849.215078492105, 7902.288794008567, 7910.129885712682, 9328.720138395858, 9534.952325238606, 9719.562619682272, 9980.550875210778, 10706.625268115578], "value": 8188.021458163911, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1247.2578815604722, 1346.1115663661978, 1360.809486671866, 1410.929453527324, 1687.0261793701368, 6956.408705260053, 7461.738839140631, 7483.438742094344, 7779.260970207835, 7784.0, 7805.6097195140155, 7910.0, 7916.920830791691, 7917.247861453153, 7917.643706033228, 2150.9139634414605, 2182.7598964114013, 2182.8253739700785, 2183.159483598818, 2184.377452426051, 2133.4133113393787, 2136.6688163334707, 2156.611809874222, 2156.751973523041, 2176.5320456101936, 2157.913683452668, 2169.8047175754177, 2170.392290158758, 2177.77133400993, 2198.8236293582936, 2120.68189771534, 2168.5229249565073, 2169.1215057901495, 2173.217641649005, 2173.2936795541514, 2115.777843326444, 2147.795959383856, 2150.4408853697996, 2151.3223334649692, 2152.7416709994745, 7680.462367634268, 7793.298603125746, 7881.448298619099, 7922.762317130495, 7987.640556174986, 4497.887552811173, 4708.599769019637, 4717.174494463455, 4719.764011799396, 4722.693024953367, 2851.8431486268246, 2990.7308342249303, 2999.505081661523, 3010.32267739759, 3021.531662592302, 938.2447130060299, 939.976500587484, 946.2004606107897, 956.5934477846887, 958.7459323279337, 10776.299540529919, 10833.29583577065, 10862.782744345148, 10894.782104357948, 10925.890741092568, 3982.0, 4041.2725709372007, 4072.083781149218, 4112.362583799516, 4129.236091323115, 8591.183837535424, 8611.870821937677, 8615.095414981337, 8626.654933802703, 8632.223099921037, 4614.492405835355, 4614.76926153691, 4616.884577885579, 4618.51505591908, 4620.353150558924, 3744.850205991784, 3823.8661646842784, 4012.478377810866, 4296.140771845643, 4297.914041719148, 3627.782333060025, 3634.945475817865, 3736.682381997506, 3780.3762379207124, 3802.296575133609, 1191.118572256524, 1224.650974472289, 1229.7540491901655, 1232.1128787273149, 1234.4691782533596, 781.8084569280562, 782.5383024015745, 787.2049230277461, 807.6204184033495, 815.2744057788573, 4909.705417674951, 4997.375328083989, 5119.0017946500075, 5166.276721259027, 5236.396827207873, 368.3976698098628, 370.7719752352284, 374.0629722545007, 376.4654191048717, 377.66010590468795, 3419.7005138047384, 3454.9481757773656, 3461.13471632092, 3524.6122926478065, 3651.799151046665, 9464.90535094654, 9889.554970026365, 9891.258155638356, 9891.802163956681, 9908.603655853685, 9837.80324393508, 9848.113669769755, 9919.206463482904, 9920.751981200383, 9930.05664461875, 7123.786286411416, 7348.338649521462, 7376.151742549569, 7426.2945020223, 7431.739889103964, 4945.1346014448045, 4953.851384458472, 5081.796728130834, 5109.565686916654, 5176.6844449771215, 8772.78068048304, 8917.866232006396, 9037.09629037091, 9061.864072038792, 9063.320250981335, 8983.730488085368, 9157.542122893696, 9169.0, 9274.350795444525, 9311.813763724824, 6150.876982460415, 6346.301906790157, 6869.313068693091, 6976.407005404598, 6982.895256571257, 7273.3453989141235, 7464.365528929885, 7513.774586762406, 7707.730229441942, 7709.383249340151, 6744.156980377453, 6752.054712340178, 6863.622500762306, 6992.685329160302, 7054.541454805421, 6771.966140169267, 6799.422049125879, 6910.343517365842, 6953.513254072166, 7014.859702806018, 5980.1328807321825, 6060.575759696779, 6070.453659170696, 6070.817875463743, 6073.331933487401, 4308.956910430856, 4373.978130109456, 4374.803133858921, 4438.178936896685, 4505.662075344297, 4177.12280421115, 4326.091520780546, 4329.22501774271, 4434.312681534368, 4487.147441986012], "value": 4020.9114244536627, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.88829189054104, 304.4687021148097, 310.4536016610765, 310.538849808035, 314.0891414896798, 4819.204831202852, 4837.443693975194, 4838.661293709437, 4857.809836590031, 4865.464798872121, 4759.381280433538, 4783.760811959397, 4789.257665061912, 4800.303955926389, 4809.0, 3855.942160867582, 3864.516935383077, 3866.5940076292004, 3871.477350557681, 3877.922441551167, 3721.3487639663085, 3797.126660868002, 3800.5477288988623, 3878.4764056852246, 3886.8833934981994, 3786.659200671939, 3792.772433653976, 3793.5827059023486, 3802.1065049713297, 3803.5166285148816, 3786.280606684721, 3788.166603347273, 3788.5264341957395, 3802.258559580883, 3803.4104713769134, 3149.2599239178776, 3210.871565137392, 3249.4313495138495, 3341.198112453018, 3353.6814002669707, 4564.612007979325, 4584.6561507887045, 4591.931121033187, 4599.908001839978, 4601.401817763669, 4277.572242775697, 4278.465191851019, 4301.37630043645, 4308.562180953622, 4323.762193079379, 4675.2052151134385, 4767.856964291077, 4820.831270905502, 4885.902281954341, 4899.951000489985, 3596.3166998270244, 3599.2441587266703, 3606.747527673064, 3606.747527673064, 3612.638736126393, 5221.138512145491, 5235.869103272411, 5243.659162154448, 5259.737013149365, 5277.9472205278225, 3642.3807952648112, 3676.7058635309113, 3702.315071711742, 3721.497597824259, 3724.255148970217, 3757.1170774867883, 3774.3960966245268, 3776.2817917847315, 3799.373103437957, 3800.7339486235696, 4297.78511074445, 4305.892352691145, 4318.265894797892, 4323.373110898965, 4327.17783621111, 4899.701579081546, 5013.824516141917, 5018.498150185025, 5033.421156566968, 5042.218456139304, 1310.6395741171254, 1322.2397121655088, 1324.1128443942582, 1327.734453109382, 1335.5192130832893, 833.1168960901464, 853.9316854651613, 873.0004145253649, 876.6055275126218, 878.2578720980761, 3952.8536724350192, 3959.940600890989, 3962.484876965976, 4002.239574480839, 4011.277969965376, 4507.5267096955, 4513.616342610915, 4517.954820451819, 4545.431821022372, 4545.909081818411, 3927.8428862845167, 3931.292367373843, 3968.2261958917734, 4006.8397264109694, 4011.1777085697363, 2241.4396400899777, 2393.628987506939, 2404.953845077397, 2407.205622144688, 2590.9765642571456, 4585.79363928624, 4700.341952126705, 4744.1934871072, 4751.311059896296, 4770.689905156154, 5198.844034678966, 5205.401378841481, 5218.504242096995, 5226.242194881721, 5227.3988491323225, 4572.702774319659, 4784.832530861473, 4788.497207793202, 4793.664443488992, 4799.856004319876, 5208.166693329049, 5219.347581552306, 5223.5559977402345, 5228.20291144236, 5241.97781432617, 5105.285260063668, 5121.590272778243, 5121.61587880903, 5132.255822905732, 5140.46025167367, 4592.609628181642, 4823.5658790709, 4896.6327525436445, 4922.744700101594, 4938.111139994692, 3627.8367473464286, 3630.219502806909, 3651.8356673949206, 3659.7438179328256, 3674.3018826422895, 5180.818671346485, 5188.832512684616, 5256.684598924076, 5260.685298468661, 5264.447233040629, 4922.483139270325, 4982.377202849644, 5094.5669618082875, 5098.623371689549, 5118.0, 5024.522670346311, 5027.170516864822, 5036.622253330942, 5054.0, 5054.873628159326, 4949.579285760607, 4950.183219768698, 4980.377452818398, 4995.2507123930245, 5006.3992320921725, 4901.9264711028645, 5063.620228482805, 5075.695458272516, 5089.506141990472, 5094.15946368845, 4896.314515967839, 4911.877203069952, 4912.557869791736, 4922.8769280768265, 4993.900121997613], "value": 3753.327974041998, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.1425361396151, 657.0, 657.4346062386348, 713.0619076386756, 745.2994185465661, 12414.627561173167, 13704.794428083587, 13713.108647937877, 13715.039947203688, 13720.58838234852, 12907.096503244777, 13043.21740695559, 13069.869301306984, 13072.411741471633, 13079.346032698375, 611.1443978430189, 627.8304857688421, 740.648192108748, 749.1459735901077, 763.5495057915829, 753.8303881626645, 771.2711487644178, 772.4438404348859, 772.9033870766154, 773.2383602151876, 826.3100311240091, 828.1304630138361, 828.6146941672122, 828.6643909216747, 828.7389472316231, 657.2376043789181, 672.2571558427965, 783.7335305995932, 824.6083110522484, 824.789678631951, 584.0334246821517, 587.6973358720262, 587.8060240120793, 588.3116753398534, 588.3968931844851, 13026.153300035563, 13026.80459793104, 13041.413136408884, 13044.54344097952, 13048.151870128411, 12031.81952270708, 12140.45367958444, 12829.16610420329, 13209.273489958048, 13282.136661116996, 10811.459427028696, 10928.562857485691, 11158.553657853758, 11274.0, 11320.433978301053, 3964.5044369453817, 3999.320115580329, 4046.4941882264716, 4051.8379264829373, 4086.897827554335, 60457.0, 62510.0, 62537.37462625361, 62588.37411625871, 65724.34275657278, 10210.846837297446, 10302.690919272434, 10400.167986561057, 10561.841572376421, 10751.193660475496, 18970.14634341458, 19101.2359505621, 19102.71345929812, 19109.522261943563, 19113.139908704143, 6856.040154378391, 6869.656517174121, 6885.173779146535, 6924.515283930076, 7189.209186989427, 3602.5496812898386, 3611.7832930024283, 3676.7977761222855, 3682.3187710273687, 3694.9815250923575, 2737.685166205872, 2832.1928250448523, 2834.744872961402, 2840.928976775597, 2843.360243945137, 489.3271751341905, 500.89982003599425, 502.90444815484943, 509.1497199676549, 517.3894804131162, 478.45934094473023, 516.3184596332804, 528.7303475227585, 531.8909623527168, 535.1704857470904, 7152.821179470555, 7468.850622987618, 7537.2085930977555, 7730.497517661334, 7897.17079706634, 437.1213860141076, 481.0715319433527, 493.437481271351, 539.3473896585176, 544.5262621519224, 3340.1315657928626, 3564.590072141737, 3592.1539011884392, 3617.131888346778, 3889.086064774776, 102351.0, 102617.0, 104320.47839760753, 104975.0, 105368.94631053592, 50528.74735626298, 61985.0, 78860.0, 87271.56364218138, 87762.56118719494, 46934.0, 62885.68557157185, 77283.84074238891, 78104.60947695225, 78130.0, 6822.761203357859, 8303.916960830315, 8310.667573297, 8506.574671266288, 8939.390909636328, 31336.529952051194, 36728.449073263386, 37616.0, 40922.0, 42291.36562951496, 58302.4169758297, 58364.4163558359, 59822.70088649529, 61757.0, 61952.380476196464, 10324.22568307365, 10430.16558675289, 10451.21615878797, 10660.73348166271, 11313.377764223047, 11670.0, 11898.167128301282, 11901.702457438634, 12140.696482588006, 12654.620361389174, 10817.242793004729, 11190.720231993939, 11221.382823944761, 11613.709657258636, 11948.581799636971, 11671.416429178676, 12022.0, 12089.455974481345, 12091.637250882488, 12102.213356131822, 10394.428306442916, 11047.502862371373, 11248.550057997589, 11619.0, 12037.518499259932, 9464.337496375463, 9578.760530986503, 9602.90397096048, 10014.849777253201, 10086.092251697382, 9348.95325523368, 9444.197243234403, 9802.16681582045, 9921.206303495559, 9977.653016842632], "value": 6392.685907443865, "unit": "score"}], "name": "dromaeo_css", "value": 6285.350295059295, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 117.0, 116.0, 114.0, 115.0, 116.0, 114.0, 115.0, 114.0, 113.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 129.0, 169.0, 129.0, 129.0, 122.0, 125.0, 166.0, 125.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 163.0, 163.0, 161.0, 162.0, 163.0, 164.0, 163.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 107.0, 76.0, 79.0, 78.0, 76.0, 98.0, 78.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 113.0, 83.0, 84.0, 84.0, 107.0, 83.0, 84.0, 116.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 120.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 97.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 63.0, 63.0, 66.0, 65.0, 64.0, 63.0, 65.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 71.0, 66.0, 67.0, 67.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 83.0, 84.0, 82.0, 82.0, 82.0, 82.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 132.0, 133.0, 136.0, 133.0, 137.0, 133.0, 136.0, 174.0, 137.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 176.0, 174.0, 179.0, 173.0, 173.0, 172.0, 174.0, 174.0, 173.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 71.0, 72.0, 67.0, 67.0, 69.0, 70.0, 67.0, 68.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1545.3000000000002, "alertThreshold": 2.0}]} 19:28:46 INFO - Return code: 0 19:28:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:28:47 INFO - # TBPL SUCCESS # 19:28:47 INFO - Running post-action listener: _resource_record_post_action 19:28:47 INFO - [mozharness: 2016-09-29 02:28:47.033627Z] Finished run-tests step (success) 19:28:47 INFO - Running post-run listener: _resource_record_post_run 19:28:47 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391385088; Read time: 12; Write time: 561028 19:28:47 INFO - TinderboxPrint: CPU usage
13.0% 19:28:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:28:47 INFO - TinderboxPrint: I/O write bytes / time
391,385,088 / 561,028 19:28:47 INFO - TinderboxPrint: CPU idle
8,352.8 (86.9%) 19:28:47 INFO - TinderboxPrint: CPU user
1,200.7 (12.5%) 19:28:47 INFO - TinderboxPrint: Swap in / out
0 / 0 19:28:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99368960; Read time: 0; Write time: 121204 19:28:47 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 292016128; Read time: 0; Write time: 439824 19:28:47 INFO - Running post-run listener: _upload_blobber_files 19:28:47 INFO - Blob upload gear active. 19:28:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:28:47 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 19:28:47 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'] 19:28:47 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 19:28:48 INFO - (blobuploader) - INFO - Open directory for files ... 19:28:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:28:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:28:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:51 INFO - (blobuploader) - INFO - Done attempting. 19:28:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:28:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:28:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:52 INFO - (blobuploader) - INFO - Done attempting. 19:28:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:28:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:28:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:53 INFO - (blobuploader) - INFO - Done attempting. 19:28:53 INFO - (blobuploader) - INFO - Iteration through files over. 19:28:53 INFO - Return code: 0 19:28:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:28:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:28:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/69bd45164e70cabe0bbe22a75aff2a58d10a2f2fc1f9a8707adb617e1f5ca2e566453debea2b4f0f29eb72cc9c5e487ce2a71dc514bc607b475d5ca498f08893", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2a6d2b86251353f2ac2f2a8333ffd492cc121977e558700a04b04982074df271c48589ae832a9da3f5f8c1a433801385bf98ce83e6a328eda847708d43770cb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2d9924dd1e5c84268c842a2890587b639e782c82c7e5c1db6b3055da8882f078c693eff57bd182f6aea2bbe7252db58e9b0e139144ceb512f4deeb4e3c89d1b6"} 19:28:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:28:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:28:53 INFO - Contents: 19:28:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/69bd45164e70cabe0bbe22a75aff2a58d10a2f2fc1f9a8707adb617e1f5ca2e566453debea2b4f0f29eb72cc9c5e487ce2a71dc514bc607b475d5ca498f08893", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2a6d2b86251353f2ac2f2a8333ffd492cc121977e558700a04b04982074df271c48589ae832a9da3f5f8c1a433801385bf98ce83e6a328eda847708d43770cb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2d9924dd1e5c84268c842a2890587b639e782c82c7e5c1db6b3055da8882f078c693eff57bd182f6aea2bbe7252db58e9b0e139144ceb512f4deeb4e3c89d1b6"} 19:28:53 INFO - Running post-run listener: copy_logs_to_upload_dir 19:28:53 INFO - Copying logs to upload dir... 19:28:53 INFO - mkdir: /builds/slave/test/build/upload/logs 19:28:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.232303 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-28 19:28:53.087500) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 19:28:53.090859) ========= 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=df17445c3590ff7897617a0e00000225-1475114568.319352-921956573 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/69bd45164e70cabe0bbe22a75aff2a58d10a2f2fc1f9a8707adb617e1f5ca2e566453debea2b4f0f29eb72cc9c5e487ce2a71dc514bc607b475d5ca498f08893", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2a6d2b86251353f2ac2f2a8333ffd492cc121977e558700a04b04982074df271c48589ae832a9da3f5f8c1a433801385bf98ce83e6a328eda847708d43770cb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2d9924dd1e5c84268c842a2890587b639e782c82c7e5c1db6b3055da8882f078c693eff57bd182f6aea2bbe7252db58e9b0e139144ceb512f4deeb4e3c89d1b6"} build_url:https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/eJ7uHsHrSg-FTls06oHZEg/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/69bd45164e70cabe0bbe22a75aff2a58d10a2f2fc1f9a8707adb617e1f5ca2e566453debea2b4f0f29eb72cc9c5e487ce2a71dc514bc607b475d5ca498f08893", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2a6d2b86251353f2ac2f2a8333ffd492cc121977e558700a04b04982074df271c48589ae832a9da3f5f8c1a433801385bf98ce83e6a328eda847708d43770cb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2d9924dd1e5c84268c842a2890587b639e782c82c7e5c1db6b3055da8882f078c693eff57bd182f6aea2bbe7252db58e9b0e139144ceb512f4deeb4e3c89d1b6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 19:28:53.116455) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:28:53.116799) ========= 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=df17445c3590ff7897617a0e00000225-1475114568.319352-921956573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:28:53.201879) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 19:28:53.202209) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 19:28:53.202519) ========= ========= Total master_lag: 0.18 =========