builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1475123327.55 results: success (0) buildid: 20160928183008 builduid: cccfcf79934c45869359b22c674d0c24 revision: 72f0acda20c0b6136058324bed919e2fb6c414c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 21:28:47.554097) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 21:28:47.554521) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 21:28:47.554808) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 21:28:47.569088) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:28:47.569372) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 21:28:47-- 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% 45.9M=0s 2016-09-28 21:28:47 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091613 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:28:47.674649) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:28:47.674976) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020684 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:28:47.724536) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:28:47.724897) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 72f0acda20c0b6136058324bed919e2fb6c414c3 --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 72f0acda20c0b6136058324bed919e2fb6c414c3 --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=7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 21:28:47,832 truncating revision to first 12 chars 2016-09-28 21:28:47,832 Setting DEBUG logging. 2016-09-28 21:28:47,832 attempt 1/10 2016-09-28 21:28:47,832 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/72f0acda20c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 21:28:48,422 unpacking tar archive at: autoland-72f0acda20c0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.925686 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:28:48.663864) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 21:28:48.664207) ========= script_repo_revision: 72f0acda20c0b6136058324bed919e2fb6c414c3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 21:28:48.664603) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 21:28:48.664894) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 21:28:48.675766) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-09-28 21:28:48.676163) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:28:48 INFO - MultiFileLogger online at 20160928 21:28:48 in /builds/slave/test 21:28:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:28:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:28:48 INFO - {'append_to_log': False, 21:28:48 INFO - 'base_work_dir': '/builds/slave/test', 21:28:48 INFO - 'blob_upload_branch': 'Autoland', 21:28:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:28:48 INFO - 'branch': 'Autoland', 21:28:48 INFO - 'buildbot_json_path': 'buildprops.json', 21:28:48 INFO - 'config_files': ('talos/linux_config.py',), 21:28:48 INFO - 'default_actions': ('clobber', 21:28:48 INFO - 'read-buildbot-config', 21:28:48 INFO - 'download-and-extract', 21:28:48 INFO - 'populate-webroot', 21:28:48 INFO - 'create-virtualenv', 21:28:48 INFO - 'install', 21:28:48 INFO - 'run-tests'), 21:28:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:28:48 INFO - 'download_minidump_stackwalk': True, 21:28:48 INFO - 'download_symbols': 'ondemand', 21:28:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:28:48 INFO - 'tooltool.py': '/tools/tooltool.py', 21:28:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:28:48 INFO - '/tools/misc-python/virtualenv.py')}, 21:28:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:28:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:28:48 INFO - 'installer_path': 'installer.exe', 21:28:48 INFO - 'log_level': 'info', 21:28:48 INFO - 'log_name': 'talos', 21:28:48 INFO - 'log_to_console': True, 21:28:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:28:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:28:48 INFO - 'opt_config_files': (), 21:28:48 INFO - 'pip_index': False, 21:28:48 INFO - 'sps_profile': False, 21:28:48 INFO - 'sps_profile_interval': 0, 21:28:48 INFO - 'suite': 'dromaeojs-e10s', 21:28:48 INFO - 'system_bits': '32', 21:28:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:28:48 INFO - 'title': 'talos-linux64-ix-005', 21:28:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:28:48 INFO - 'use_talos_json': True, 21:28:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:28:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:28:48 INFO - 'work_dir': 'build'} 21:28:48 INFO - [mozharness: 2016-09-29 04:28:48.881535Z] Running clobber step. 21:28:48 INFO - Running pre-action listener: _resource_record_pre_action 21:28:48 INFO - Running main action method: clobber 21:28:48 INFO - rmtree: /builds/slave/test/build 21:28:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:28:49 INFO - Running post-action listener: _resource_record_post_action 21:28:49 INFO - [mozharness: 2016-09-29 04:28:49.335938Z] Finished clobber step (success) 21:28:49 INFO - [mozharness: 2016-09-29 04:28:49.336040Z] Running read-buildbot-config step. 21:28:49 INFO - Running pre-action listener: _resource_record_pre_action 21:28:49 INFO - Running main action method: read_buildbot_config 21:28:49 INFO - Using buildbot properties: 21:28:49 INFO - { 21:28:49 INFO - "project": "", 21:28:49 INFO - "product": "firefox", 21:28:49 INFO - "script_repo_revision": "production", 21:28:49 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 21:28:49 INFO - "repository": "", 21:28:49 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 21:28:49 INFO - "buildid": "20160928183008", 21:28:49 INFO - "pgo_build": "True", 21:28:49 INFO - "basedir": "/builds/slave/test", 21:28:49 INFO - "buildnumber": 247, 21:28:49 INFO - "slavename": "talos-linux64-ix-005", 21:28:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:28:49 INFO - "platform": "ubuntu64_hw", 21:28:49 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 21:28:49 INFO - "branch": "autoland", 21:28:49 INFO - "repo_path": "integration/autoland", 21:28:49 INFO - "revision": "72f0acda20c0b6136058324bed919e2fb6c414c3", 21:28:49 INFO - "stage_platform": "linux64-pgo", 21:28:49 INFO - "builduid": "cccfcf79934c45869359b22c674d0c24", 21:28:49 INFO - "slavebuilddir": "test" 21:28:49 INFO - } 21:28:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:28:49 INFO - Running post-action listener: _resource_record_post_action 21:28:49 INFO - [mozharness: 2016-09-29 04:28:49.338467Z] Finished read-buildbot-config step (success) 21:28:49 INFO - [mozharness: 2016-09-29 04:28:49.338556Z] Running download-and-extract step. 21:28:49 INFO - Running pre-action listener: _resource_record_pre_action 21:28:49 INFO - Running main action method: download_and_extract 21:28:49 INFO - mkdir: /builds/slave/test/build/tests 21:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:49 INFO - trying https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:28:49 INFO - Downloading https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/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 21:28:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/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 21:28:49 INFO - Downloaded 1361 bytes. 21:28:49 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:28:49 INFO - Using the following test package requirements: 21:28:49 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:28:49 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:28:49 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:28:49 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:49 INFO - u'jsshell-linux-x86_64.zip'], 21:28:49 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:28:49 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:28:49 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:28:49 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:28:49 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:28:49 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:28:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:28:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:28:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:28:49 INFO - Fetch https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:28:50 INFO - Http code: 200 21:28:50 INFO - Content-Encoding: None 21:28:50 INFO - Content-Type: application/zip 21:28:50 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 21:28:50 INFO - x-amz-cf-id: E-dZn-oN1zx3ymd7lG1uBgD9n7gigLgHzeMB6jDH1wGJ96ECOwE5_A== 21:28:50 INFO - x-amz-version-id: abivinRdZBLDPSshaxM_XeKK88UT8ADg 21:28:50 INFO - x-cache: Hit from cloudfront 21:28:50 INFO - Expected file size: 21987100 21:28:50 INFO - Obtained file size: 21987100 21:28:54 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 21:28:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:28:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:28:54 INFO - Fetch https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:28:55 INFO - Http code: 200 21:28:55 INFO - Content-Encoding: None 21:28:55 INFO - Content-Type: application/zip 21:28:55 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 21:28:55 INFO - x-amz-cf-id: ZnsiVTKDnbsa9euKmn_DLbGno5g8J_bfadhcglNqLSOdGbd1T5t8PQ== 21:28:55 INFO - x-amz-version-id: abivinRdZBLDPSshaxM_XeKK88UT8ADg 21:28:55 INFO - x-cache: Hit from cloudfront 21:28:55 INFO - Expected file size: 21987100 21:28:55 INFO - Obtained file size: 21987100 21:29:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:29:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:29:00 INFO - Fetch https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:29:00 INFO - Http code: 200 21:29:00 INFO - Content-Encoding: None 21:29:00 INFO - Content-Type: application/zip 21:29:00 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 21:29:00 INFO - x-amz-cf-id: AKfAgzjRas6qyBiCViRA5yVW6HqioQA3FPW_91oLcLUy1Gr3zAK8_w== 21:29:00 INFO - x-amz-version-id: rAoVnZtuiIgK7GMOsE4WQiQTrCNJcdZN 21:29:00 INFO - x-cache: Hit from cloudfront 21:29:00 INFO - Expected file size: 14414067 21:29:00 INFO - Obtained file size: 14414067 21:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:01 INFO - trying https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:29:01 INFO - Downloading https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/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 21:29:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/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 21:29:02 INFO - Downloaded 59755759 bytes. 21:29:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:29:02 INFO - mkdir: /builds/slave/test/properties 21:29:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:29:02 INFO - Writing to file /builds/slave/test/properties/build_url 21:29:02 INFO - Contents: 21:29:02 INFO - build_url:https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:29:02 INFO - Running post-action listener: _resource_record_post_action 21:29:02 INFO - Running post-action listener: set_extra_try_arguments 21:29:02 INFO - [mozharness: 2016-09-29 04:29:02.991882Z] Finished download-and-extract step (success) 21:29:02 INFO - [mozharness: 2016-09-29 04:29:02.992108Z] Running populate-webroot step. 21:29:02 INFO - Running pre-action listener: _resource_record_pre_action 21:29:02 INFO - Running main action method: populate_webroot 21:29:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:29:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:29:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:29:03 INFO - '--tppagecycles', 21:29:03 INFO - '7'], 21:29:03 INFO - 'tests': ['tsvgm']}}, 21:29:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:29:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:29:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:29:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:29:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:29:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:29:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:03 INFO - 'talos_options': ['--disable-e10s'], 21:29:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:29:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:29:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:03 INFO - 'talos_options': ['--disable-e10s'], 21:29:03 INFO - 'tests': ['damp', 'tps']}, 21:29:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:03 INFO - 'tests': ['damp', 'tps']}, 21:29:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:29:03 INFO - 'tests': ['dromaeo_dom']}, 21:29:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:29:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:29:03 INFO - 'tests': ['basic_compositor_video']}, 21:29:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:29:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:29:03 INFO - 'tests': ['a11yr', 21:29:03 INFO - 'ts_paint', 21:29:03 INFO - 'tpaint', 21:29:03 INFO - 'sessionrestore', 21:29:03 INFO - 'sessionrestore_no_auto_restore', 21:29:03 INFO - 'tabpaint']}, 21:29:03 INFO - 'other-e10s': {'tests': ['a11yr', 21:29:03 INFO - 'ts_paint', 21:29:03 INFO - 'tpaint', 21:29:03 INFO - 'sessionrestore', 21:29:03 INFO - 'sessionrestore_no_auto_restore', 21:29:03 INFO - 'tabpaint']}, 21:29:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:29:03 INFO - 'ts_paint', 21:29:03 INFO - 'tpaint', 21:29:03 INFO - 'sessionrestore', 21:29:03 INFO - 'sessionrestore_no_auto_restore', 21:29:03 INFO - 'tabpaint']}, 21:29:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:29:03 INFO - 'ts_paint', 21:29:03 INFO - 'tpaint', 21:29:03 INFO - 'sessionrestore', 21:29:03 INFO - 'sessionrestore_no_auto_restore', 21:29:03 INFO - 'tabpaint']}, 21:29:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:29:03 INFO - 'tests': ['a11yr', 21:29:03 INFO - 'ts_paint', 21:29:03 INFO - 'tpaint', 21:29:03 INFO - 'sessionrestore', 21:29:03 INFO - 'sessionrestore_no_auto_restore', 21:29:03 INFO - 'tabpaint']}, 21:29:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:29:03 INFO - 'tests': ['a11yr', 21:29:03 INFO - 'ts_paint', 21:29:03 INFO - 'tpaint', 21:29:03 INFO - 'sessionrestore', 21:29:03 INFO - 'sessionrestore_no_auto_restore', 21:29:03 INFO - 'tabpaint']}, 21:29:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:29:03 INFO - 'tests': ['tsvgx', 21:29:03 INFO - 'tsvgr_opacity', 21:29:03 INFO - 'tart', 21:29:03 INFO - 'tscrollx', 21:29:03 INFO - 'cart']}, 21:29:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:29:03 INFO - 'tsvgr_opacity', 21:29:03 INFO - 'tart', 21:29:03 INFO - 'tscrollx', 21:29:03 INFO - 'cart']}, 21:29:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:03 INFO - 'talos_options': ['--disable-e10s'], 21:29:03 INFO - 'tests': ['tp5o']}, 21:29:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:03 INFO - 'tests': ['tp5o']}, 21:29:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:03 INFO - 'talos_options': ['--disable-e10s', 21:29:03 INFO - '--xperf_path', 21:29:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:29:03 INFO - 'tests': ['tp5n']}, 21:29:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:03 INFO - 'talos_options': ['--xperf_path', 21:29:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:29:03 INFO - 'tests': ['tp5n']}}, 21:29:03 INFO - 'talos.zip': {'path': '', 21:29:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:29:03 INFO - Running post-action listener: _resource_record_post_action 21:29:03 INFO - [mozharness: 2016-09-29 04:29:03.011048Z] Finished populate-webroot step (success) 21:29:03 INFO - [mozharness: 2016-09-29 04:29:03.011135Z] Running create-virtualenv step. 21:29:03 INFO - Running pre-action listener: _resource_record_pre_action 21:29:03 INFO - Running main action method: create_virtualenv 21:29:03 INFO - Creating virtualenv /builds/slave/test/build/venv 21:29:03 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 21:29:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:29:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:29:03 INFO - Using real prefix '/usr' 21:29:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:29:03 INFO - Installing distribute.............................................................................................................................................................................................done. 21:29:05 INFO - Installing pip.................done. 21:29:05 INFO - Return code: 0 21:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:29:05 INFO - Reading from file tmpfile_stdout 21:29:05 INFO - Output received: 21:29:05 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) 21:29:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:29:05 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')]} 21:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:05 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')]} 21:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:05 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 0x7f3cd08d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b790>, '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 0x1d8c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8cb20>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', '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 21:29:05 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 21:29:05 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 21:29:05 INFO - Using env: {'DISPLAY': ':0', 21:29:05 INFO - 'HOME': '/home/cltbld', 21:29:05 INFO - 'LANG': 'en_US.UTF-8', 21:29:05 INFO - 'LANGUAGE': 'en_US:en', 21:29:05 INFO - 'LOGNAME': 'cltbld', 21:29:05 INFO - 'MAIL': '/var/mail/cltbld', 21:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:05 INFO - 'MOZ_NO_REMOTE': '1', 21:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:05 INFO - 'NO_EM_RESTART': '1', 21:29:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:05 INFO - 'PWD': '/builds/slave/test', 21:29:05 INFO - 'SHELL': '/bin/bash', 21:29:05 INFO - 'SHLVL': '1', 21:29:05 INFO - 'TERM': 'linux', 21:29:05 INFO - 'TMOUT': '86400', 21:29:05 INFO - 'USER': 'cltbld', 21:29:05 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', 21:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:05 INFO - '_': '/tools/buildbot/bin/python'} 21:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:06 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 21:29:06 INFO - Cleaning up... 21:29:06 INFO - Return code: 0 21:29:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:29: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')]} 21:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29: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')]} 21:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:06 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 0x7f3cd08d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b790>, '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 0x1d8c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8cb20>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', '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 21:29:06 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 21:29:06 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 21:29:06 INFO - Using env: {'DISPLAY': ':0', 21:29:06 INFO - 'HOME': '/home/cltbld', 21:29:06 INFO - 'LANG': 'en_US.UTF-8', 21:29:06 INFO - 'LANGUAGE': 'en_US:en', 21:29:06 INFO - 'LOGNAME': 'cltbld', 21:29:06 INFO - 'MAIL': '/var/mail/cltbld', 21:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:06 INFO - 'MOZ_NO_REMOTE': '1', 21:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:06 INFO - 'NO_EM_RESTART': '1', 21:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:06 INFO - 'PWD': '/builds/slave/test', 21:29:06 INFO - 'SHELL': '/bin/bash', 21:29:06 INFO - 'SHLVL': '1', 21:29:06 INFO - 'TERM': 'linux', 21:29:06 INFO - 'TMOUT': '86400', 21:29:06 INFO - 'USER': 'cltbld', 21:29:06 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', 21:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:06 INFO - '_': '/tools/buildbot/bin/python'} 21:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:06 INFO - Downloading/unpacking psutil>=3.1.1 21:29:06 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 21:29:06 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 21:29:06 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 21:29:06 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 21:29:06 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 21:29:06 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 21:29:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:29:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:29:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:29:08 INFO - Installing collected packages: psutil 21:29:08 INFO - Running setup.py install for psutil 21:29:08 INFO - building 'psutil._psutil_linux' extension 21:29:08 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 21:29:08 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 21:29:08 INFO - building 'psutil._psutil_posix' extension 21:29:08 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 21:29:08 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 21:29:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:29:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:29:08 INFO - Successfully installed psutil 21:29:08 INFO - Cleaning up... 21:29:08 INFO - Return code: 0 21:29:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:29:08 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')]} 21:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:08 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')]} 21:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:08 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 0x7f3cd08d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b790>, '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 0x1d8c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8cb20>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', '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 21:29:08 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 21:29:08 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 21:29:08 INFO - Using env: {'DISPLAY': ':0', 21:29:08 INFO - 'HOME': '/home/cltbld', 21:29:08 INFO - 'LANG': 'en_US.UTF-8', 21:29:08 INFO - 'LANGUAGE': 'en_US:en', 21:29:08 INFO - 'LOGNAME': 'cltbld', 21:29:08 INFO - 'MAIL': '/var/mail/cltbld', 21:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:08 INFO - 'MOZ_NO_REMOTE': '1', 21:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:08 INFO - 'NO_EM_RESTART': '1', 21:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:08 INFO - 'PWD': '/builds/slave/test', 21:29:08 INFO - 'SHELL': '/bin/bash', 21:29:08 INFO - 'SHLVL': '1', 21:29:08 INFO - 'TERM': 'linux', 21:29:08 INFO - 'TMOUT': '86400', 21:29:08 INFO - 'USER': 'cltbld', 21:29:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', 21:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:08 INFO - '_': '/tools/buildbot/bin/python'} 21:29:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:29:09 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 21:29:09 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 21:29:09 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 21:29:09 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 21:29:09 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 21:29:09 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 21:29:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:29:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:29:10 INFO - Installing collected packages: mozsystemmonitor 21:29:10 INFO - Running setup.py install for mozsystemmonitor 21:29:11 INFO - Successfully installed mozsystemmonitor 21:29:11 INFO - Cleaning up... 21:29:11 INFO - Return code: 0 21:29:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:29:11 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')]} 21:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:11 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')]} 21:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:11 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 0x7f3cd08d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b790>, '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 0x1d8c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8cb20>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', '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 21:29:11 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 21:29:11 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 21:29:11 INFO - Using env: {'DISPLAY': ':0', 21:29:11 INFO - 'HOME': '/home/cltbld', 21:29:11 INFO - 'LANG': 'en_US.UTF-8', 21:29:11 INFO - 'LANGUAGE': 'en_US:en', 21:29:11 INFO - 'LOGNAME': 'cltbld', 21:29:11 INFO - 'MAIL': '/var/mail/cltbld', 21:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:11 INFO - 'MOZ_NO_REMOTE': '1', 21:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:11 INFO - 'NO_EM_RESTART': '1', 21:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:11 INFO - 'PWD': '/builds/slave/test', 21:29:11 INFO - 'SHELL': '/bin/bash', 21:29:11 INFO - 'SHLVL': '1', 21:29:11 INFO - 'TERM': 'linux', 21:29:11 INFO - 'TMOUT': '86400', 21:29:11 INFO - 'USER': 'cltbld', 21:29:11 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', 21:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:11 INFO - '_': '/tools/buildbot/bin/python'} 21:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:11 INFO - Downloading/unpacking jsonschema==2.5.1 21:29:11 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 21:29:11 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 21:29:11 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 21:29:11 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 21:29:11 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 21:29:11 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 21:29:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:29:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:29:13 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 21:29:13 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 21:29:13 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 21:29:13 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 21:29:13 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 21:29:13 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 21:29:13 INFO - Downloading functools32-3.2.3-2.tar.gz 21:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:29:13 INFO - warning: no files found matching '*.txt' 21:29:13 INFO - no previously-included directories found matching 'build' 21:29:13 INFO - no previously-included directories found matching 'dist' 21:29:13 INFO - no previously-included directories found matching '.git*' 21:29:13 INFO - Installing collected packages: jsonschema, functools32 21:29:13 INFO - Running setup.py install for functools32 21:29:13 INFO - warning: no files found matching '*.txt' 21:29:13 INFO - no previously-included directories found matching 'build' 21:29:13 INFO - no previously-included directories found matching 'dist' 21:29:13 INFO - no previously-included directories found matching '.git*' 21:29:13 INFO - Successfully installed jsonschema functools32 21:29:13 INFO - Cleaning up... 21:29:13 INFO - Return code: 0 21:29:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:13 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 0x7f3cd08d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b790>, '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 0x1d8c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8cb20>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', '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 21:29:13 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 21:29:13 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 21:29:13 INFO - Using env: {'DISPLAY': ':0', 21:29:13 INFO - 'HOME': '/home/cltbld', 21:29:13 INFO - 'LANG': 'en_US.UTF-8', 21:29:13 INFO - 'LANGUAGE': 'en_US:en', 21:29:13 INFO - 'LOGNAME': 'cltbld', 21:29:13 INFO - 'MAIL': '/var/mail/cltbld', 21:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:13 INFO - 'MOZ_NO_REMOTE': '1', 21:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:13 INFO - 'NO_EM_RESTART': '1', 21:29:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:13 INFO - 'PWD': '/builds/slave/test', 21:29:13 INFO - 'SHELL': '/bin/bash', 21:29:13 INFO - 'SHLVL': '1', 21:29:13 INFO - 'TERM': 'linux', 21:29:13 INFO - 'TMOUT': '86400', 21:29:13 INFO - 'USER': 'cltbld', 21:29:13 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', 21:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:13 INFO - '_': '/tools/buildbot/bin/python'} 21:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:29:13 INFO - Cleaning up... 21:29:13 INFO - Return code: 0 21:29:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:13 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 0x7f3cd08d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b790>, '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 0x1d8c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8cb20>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', '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 21:29:13 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 21:29:13 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 21:29:13 INFO - Using env: {'DISPLAY': ':0', 21:29:13 INFO - 'HOME': '/home/cltbld', 21:29:13 INFO - 'LANG': 'en_US.UTF-8', 21:29:13 INFO - 'LANGUAGE': 'en_US:en', 21:29:13 INFO - 'LOGNAME': 'cltbld', 21:29:13 INFO - 'MAIL': '/var/mail/cltbld', 21:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:13 INFO - 'MOZ_NO_REMOTE': '1', 21:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:13 INFO - 'NO_EM_RESTART': '1', 21:29:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:13 INFO - 'PWD': '/builds/slave/test', 21:29:13 INFO - 'SHELL': '/bin/bash', 21:29:13 INFO - 'SHLVL': '1', 21:29:13 INFO - 'TERM': 'linux', 21:29:13 INFO - 'TMOUT': '86400', 21:29:13 INFO - 'USER': 'cltbld', 21:29:13 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', 21:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:13 INFO - '_': '/tools/buildbot/bin/python'} 21:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:14 INFO - Downloading/unpacking blobuploader==1.2.4 21:29:14 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 21:29:14 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 21:29:14 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 21:29:14 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 21:29:14 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 21:29:14 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 21:29:16 INFO - Downloading blobuploader-1.2.4.tar.gz 21:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:29:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:29:16 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 21:29:16 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 21:29:16 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 21:29:16 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 21:29:16 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 21:29:16 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 21:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:29:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:29:16 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 21:29:16 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 21:29:16 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 21:29:16 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 21:29:16 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 21:29:16 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 21:29:16 INFO - Downloading docopt-0.6.1.tar.gz 21:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:29:16 INFO - Installing collected packages: blobuploader, requests, docopt 21:29:16 INFO - Running setup.py install for blobuploader 21:29:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:29:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:29:16 INFO - Running setup.py install for requests 21:29:17 INFO - Running setup.py install for docopt 21:29:17 INFO - Successfully installed blobuploader requests docopt 21:29:17 INFO - Cleaning up... 21:29:17 INFO - Return code: 0 21:29:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:29:17 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')]} 21:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:17 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')]} 21:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:17 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 0x7f3cd08d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b790>, '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 0x1d8c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8cb20>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', '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 21:29:17 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 21:29:17 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 21:29:17 INFO - Using env: {'DISPLAY': ':0', 21:29:17 INFO - 'HOME': '/home/cltbld', 21:29:17 INFO - 'LANG': 'en_US.UTF-8', 21:29:17 INFO - 'LANGUAGE': 'en_US:en', 21:29:17 INFO - 'LOGNAME': 'cltbld', 21:29:17 INFO - 'MAIL': '/var/mail/cltbld', 21:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:17 INFO - 'MOZ_NO_REMOTE': '1', 21:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:17 INFO - 'NO_EM_RESTART': '1', 21:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:17 INFO - 'PWD': '/builds/slave/test', 21:29:17 INFO - 'SHELL': '/bin/bash', 21:29:17 INFO - 'SHLVL': '1', 21:29:17 INFO - 'TERM': 'linux', 21:29:17 INFO - 'TMOUT': '86400', 21:29:17 INFO - 'USER': 'cltbld', 21:29:17 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', 21:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:17 INFO - '_': '/tools/buildbot/bin/python'} 21:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:29:17 INFO - Running setup.py (path:/tmp/pip-5EJxP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:29:17 INFO - Running setup.py (path:/tmp/pip-D5k09y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:29:17 INFO - Running setup.py (path:/tmp/pip-v09wMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:29:17 INFO - Running setup.py (path:/tmp/pip-VqM6zO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:29:17 INFO - Running setup.py (path:/tmp/pip-_RzOLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:29:18 INFO - Running setup.py (path:/tmp/pip-LLOW4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:29:18 INFO - Running setup.py (path:/tmp/pip-teKpQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:29:18 INFO - Running setup.py (path:/tmp/pip-QiFjtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:29:18 INFO - Running setup.py (path:/tmp/pip-jrfDv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:29:18 INFO - Running setup.py (path:/tmp/pip-_FWGOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:29:18 INFO - Running setup.py (path:/tmp/pip-SxuZgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:29:18 INFO - Running setup.py (path:/tmp/pip-ofBfug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:29:18 INFO - Running setup.py (path:/tmp/pip-wgB45v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:29:18 INFO - Running setup.py (path:/tmp/pip-ZZtEZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:18 INFO - Running setup.py (path:/tmp/pip-max23P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:29:18 INFO - Running setup.py (path:/tmp/pip-YFYOnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:29:18 INFO - Running setup.py (path:/tmp/pip-QZa6fI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:29:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:29:18 INFO - Running setup.py install for manifestparser 21:29:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:29:18 INFO - Running setup.py install for mozcrash 21:29:19 INFO - Running setup.py install for mozdebug 21:29:19 INFO - Running setup.py install for mozdevice 21:29:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:29:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:29:19 INFO - Running setup.py install for mozfile 21:29:19 INFO - Running setup.py install for mozhttpd 21:29:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:29:19 INFO - Running setup.py install for mozinfo 21:29:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:29:19 INFO - Running setup.py install for mozInstall 21:29:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:29:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:29:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:29:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:29:19 INFO - Running setup.py install for mozleak 21:29:19 INFO - Running setup.py install for mozlog 21:29:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:29:19 INFO - Running setup.py install for moznetwork 21:29:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:29:20 INFO - Running setup.py install for mozprocess 21:29:20 INFO - Running setup.py install for mozprofile 21:29:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:29:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:29:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:29:20 INFO - Running setup.py install for mozrunner 21:29:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:29:20 INFO - Running setup.py install for mozscreenshot 21:29:20 INFO - Running setup.py install for moztest 21:29:20 INFO - Running setup.py install for mozversion 21:29:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:29:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:29:20 INFO - Cleaning up... 21:29:20 INFO - Return code: 0 21:29:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:20 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 0x7f3cd08d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b790>, '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 0x1d8c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8cb20>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', '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 21:29:20 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 21:29:20 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 21:29:20 INFO - Using env: {'DISPLAY': ':0', 21:29:20 INFO - 'HOME': '/home/cltbld', 21:29:20 INFO - 'LANG': 'en_US.UTF-8', 21:29:20 INFO - 'LANGUAGE': 'en_US:en', 21:29:20 INFO - 'LOGNAME': 'cltbld', 21:29:20 INFO - 'MAIL': '/var/mail/cltbld', 21:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:20 INFO - 'MOZ_NO_REMOTE': '1', 21:29:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:20 INFO - 'NO_EM_RESTART': '1', 21:29:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:20 INFO - 'PWD': '/builds/slave/test', 21:29:20 INFO - 'SHELL': '/bin/bash', 21:29:20 INFO - 'SHLVL': '1', 21:29:20 INFO - 'TERM': 'linux', 21:29:20 INFO - 'TMOUT': '86400', 21:29:20 INFO - 'USER': 'cltbld', 21:29:20 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', 21:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:20 INFO - '_': '/tools/buildbot/bin/python'} 21:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:29:20 INFO - Running setup.py (path:/tmp/pip-s1yTAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:29:20 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)) 21:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:29:20 INFO - Running setup.py (path:/tmp/pip-VOPhsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:29:21 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)) 21:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:29:21 INFO - Running setup.py (path:/tmp/pip-Z4PkCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:29:21 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)) 21:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:29:21 INFO - Running setup.py (path:/tmp/pip-XZlNjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:29:21 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)) 21:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:29:21 INFO - Running setup.py (path:/tmp/pip-IQCr4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:29:21 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)) 21:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:29:21 INFO - Running setup.py (path:/tmp/pip-Zt2Ie1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:29:21 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)) 21:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:29:21 INFO - Running setup.py (path:/tmp/pip-WGb6oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:29:21 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)) 21:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:29:21 INFO - Running setup.py (path:/tmp/pip-t7nt9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:29:21 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)) 21:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:29:21 INFO - Running setup.py (path:/tmp/pip-Wr7sjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:29:21 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)) 21:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:29:21 INFO - Running setup.py (path:/tmp/pip-QdmuO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:29:21 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)) 21:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:29:21 INFO - Running setup.py (path:/tmp/pip-dvkw7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:29:21 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)) 21:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:29:21 INFO - Running setup.py (path:/tmp/pip-C_rw7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:29:21 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)) 21:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:29:21 INFO - Running setup.py (path:/tmp/pip-2zxVRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:29:21 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)) 21:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:29:21 INFO - Running setup.py (path:/tmp/pip-xd35hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:29:21 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)) 21:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:21 INFO - Running setup.py (path:/tmp/pip-2U5ydk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:22 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)) 21:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:29:22 INFO - Running setup.py (path:/tmp/pip-eO_sEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:29:22 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)) 21:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:29:22 INFO - Running setup.py (path:/tmp/pip-cJXWOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:29:22 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)) 21:29:22 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)) 21:29:22 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)) 21:29:22 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)) 21:29:22 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)) 21:29:22 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)) 21:29:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:29:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:29:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:29:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:29:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:29:24 INFO - Downloading blessings-1.6.tar.gz 21:29:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:29:24 INFO - Installing collected packages: blessings 21:29:24 INFO - Running setup.py install for blessings 21:29:24 INFO - Successfully installed blessings 21:29:24 INFO - Cleaning up... 21:29:24 INFO - Return code: 0 21:29:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:29:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:29:24 INFO - Reading from file tmpfile_stdout 21:29:24 INFO - Current package versions: 21:29:24 INFO - argparse == 1.2.1 21:29:24 INFO - blessings == 1.6 21:29:24 INFO - blobuploader == 1.2.4 21:29:24 INFO - docopt == 0.6.1 21:29:24 INFO - functools32 == 3.2.3-2 21:29:24 INFO - jsonschema == 2.5.1 21:29:24 INFO - manifestparser == 1.1 21:29:24 INFO - mozInstall == 1.12 21:29:24 INFO - mozcrash == 0.17 21:29:24 INFO - mozdebug == 0.1 21:29:24 INFO - mozdevice == 0.48 21:29:24 INFO - mozfile == 1.2 21:29:24 INFO - mozhttpd == 0.7 21:29:24 INFO - mozinfo == 0.9 21:29:24 INFO - mozleak == 0.1 21:29:24 INFO - mozlog == 3.4 21:29:24 INFO - moznetwork == 0.27 21:29:24 INFO - mozprocess == 0.23 21:29:24 INFO - mozprofile == 0.28 21:29:24 INFO - mozrunner == 6.12 21:29:24 INFO - mozscreenshot == 0.1 21:29:24 INFO - mozsystemmonitor == 0.3 21:29:24 INFO - moztest == 0.7 21:29:24 INFO - mozversion == 1.4 21:29:24 INFO - psutil == 3.1.1 21:29:24 INFO - requests == 1.2.3 21:29:24 INFO - wsgiref == 0.1.2 21:29:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:24 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 0x7f3cd08d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b790>, '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 0x1d8c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8cb20>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', '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 21:29:24 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 21:29:24 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 21:29:24 INFO - Using env: {'DISPLAY': ':0', 21:29:24 INFO - 'HOME': '/home/cltbld', 21:29:24 INFO - 'LANG': 'en_US.UTF-8', 21:29:24 INFO - 'LANGUAGE': 'en_US:en', 21:29:24 INFO - 'LOGNAME': 'cltbld', 21:29:24 INFO - 'MAIL': '/var/mail/cltbld', 21:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:24 INFO - 'MOZ_NO_REMOTE': '1', 21:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:24 INFO - 'NO_EM_RESTART': '1', 21:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:24 INFO - 'PWD': '/builds/slave/test', 21:29:24 INFO - 'SHELL': '/bin/bash', 21:29:24 INFO - 'SHLVL': '1', 21:29:24 INFO - 'TERM': 'linux', 21:29:24 INFO - 'TMOUT': '86400', 21:29:24 INFO - 'USER': 'cltbld', 21:29:24 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', 21:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:24 INFO - '_': '/tools/buildbot/bin/python'} 21:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:24 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)) 21:29:24 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)) 21:29:24 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)) 21:29:24 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)) 21:29:24 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)) 21:29:24 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)) 21:29:24 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)) 21:29:24 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)) 21:29:24 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)) 21:29:24 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)) 21:29:24 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)) 21:29:24 INFO - Cleaning up... 21:29:24 INFO - Return code: 0 21:29:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3cd08d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfc7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b790>, '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 0x1d8c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8cb20>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', '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 21:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:29:24 INFO - Using env: {'DISPLAY': ':0', 21:29:24 INFO - 'HOME': '/home/cltbld', 21:29:24 INFO - 'LANG': 'en_US.UTF-8', 21:29:24 INFO - 'LANGUAGE': 'en_US:en', 21:29:24 INFO - 'LOGNAME': 'cltbld', 21:29:24 INFO - 'MAIL': '/var/mail/cltbld', 21:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:24 INFO - 'MOZ_NO_REMOTE': '1', 21:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:24 INFO - 'NO_EM_RESTART': '1', 21:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:24 INFO - 'PWD': '/builds/slave/test', 21:29:24 INFO - 'SHELL': '/bin/bash', 21:29:24 INFO - 'SHLVL': '1', 21:29:24 INFO - 'TERM': 'linux', 21:29:24 INFO - 'TMOUT': '86400', 21:29:24 INFO - 'USER': 'cltbld', 21:29:24 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', 21:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:24 INFO - '_': '/tools/buildbot/bin/python'} 21:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:29:24 INFO - Cleaning up... 21:29:24 INFO - Return code: 0 21:29:24 INFO - Running post-action listener: _resource_record_post_action 21:29:24 INFO - Running post-action listener: _start_resource_monitoring 21:29:25 INFO - Starting resource monitoring. 21:29:25 INFO - [mozharness: 2016-09-29 04:29:25.019851Z] Finished create-virtualenv step (success) 21:29:25 INFO - [mozharness: 2016-09-29 04:29:25.020321Z] Running install step. 21:29:25 INFO - Running pre-action listener: _resource_record_pre_action 21:29:25 INFO - Running main action method: install 21:29:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:29:25 INFO - Reading from file tmpfile_stdout 21:29:25 INFO - Detecting whether we're running mozinstall >=1.0... 21:29:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:29:25 INFO - Reading from file tmpfile_stdout 21:29:25 INFO - Output received: 21:29:25 INFO - Usage: mozinstall [options] installer 21:29:25 INFO - Options: 21:29:25 INFO - -h, --help show this help message and exit 21:29:25 INFO - -d DEST, --destination=DEST 21:29:25 INFO - Directory to install application into. [default: 21:29:25 INFO - "/builds/slave/test"] 21:29:25 INFO - --app=APP Application being installed. [default: firefox] 21:29:25 INFO - mkdir: /builds/slave/test/build/application 21:29:25 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'] 21:29:25 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 21:29:42 INFO - Reading from file tmpfile_stdout 21:29:42 INFO - Output received: 21:29:42 INFO - /builds/slave/test/build/application/firefox/firefox 21:29:42 INFO - Running post-action listener: _resource_record_post_action 21:29:42 INFO - [mozharness: 2016-09-29 04:29:42.326715Z] Finished install step (success) 21:29:42 INFO - [mozharness: 2016-09-29 04:29:42.326959Z] Running run-tests step. 21:29:42 INFO - Running pre-action listener: _resource_record_pre_action 21:29:42 INFO - Running main action method: run_tests 21:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:29:42 INFO - Python 2.7.3 21:29:42 INFO - Return code: 0 21:29:42 INFO - grabbing minidump binary from tooltool 21:29: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')]} 21:29:42 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 0x1d8b790>, '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 0x1d8c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:29:42 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 21:29:42 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 21:29:42 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 21:29:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:29:42 INFO - Return code: 0 21:29:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:29:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:29:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:29:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:29:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:29:42 INFO - Using env: {'DISPLAY': ':0', 21:29:42 INFO - 'HOME': '/home/cltbld', 21:29:42 INFO - 'LANG': 'en_US.UTF-8', 21:29:42 INFO - 'LANGUAGE': 'en_US:en', 21:29:42 INFO - 'LOGNAME': 'cltbld', 21:29:42 INFO - 'MAIL': '/var/mail/cltbld', 21:29:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:29:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:42 INFO - 'MOZ_NO_REMOTE': '1', 21:29:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:42 INFO - 'NO_EM_RESTART': '1', 21:29:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:42 INFO - 'PWD': '/builds/slave/test', 21:29:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:29:42 INFO - 'SHELL': '/bin/bash', 21:29:42 INFO - 'SHLVL': '1', 21:29:42 INFO - 'TERM': 'linux', 21:29:42 INFO - 'TMOUT': '86400', 21:29:42 INFO - 'USER': 'cltbld', 21:29:42 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400', 21:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:42 INFO - '_': '/tools/buildbot/bin/python'} 21:29:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:29:42 INFO - mozversion application_buildid: 20160928183008 21:29:42 INFO - mozversion application_changeset: 72f0acda20c0b6136058324bed919e2fb6c414c3 21:29:42 INFO - mozversion application_display_name: Nightly 21:29:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:29:42 INFO - mozversion application_name: Firefox 21:29:42 INFO - mozversion application_remotingname: firefox 21:29:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:29:42 INFO - mozversion application_vendor: Mozilla 21:29:42 INFO - mozversion application_version: 52.0a1 21:29:42 INFO - mozversion platform_buildid: 20160928183008 21:29:42 INFO - mozversion platform_changeset: 72f0acda20c0b6136058324bed919e2fb6c414c3 21:29:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:29:42 INFO - mozversion platform_version: 52.0a1 21:29:42 INFO - using testdate: 1475123382 21:29:42 INFO - actual date: 1475123382 21:29:42 INFO - starting webserver on 'localhost:58076' 21:29:42 INFO - SUITE-START | Running 2 tests 21:29:42 INFO - TEST-START | dromaeo_css 21:29:42 INFO - operating with platform_type : linux_ 21:29:42 INFO - Initialising browser for dromaeo_css test... 21:29:42 INFO - TEST-INFO | started process 630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjL6oAu/profile http://localhost:58076/getInfo.html) 21:29:47 INFO - PROCESS | 630 | __metrics Screen width/height:1600/1200 21:29:47 INFO - PROCESS | 630 | colorDepth:24 21:29:47 INFO - PROCESS | 630 | Browser inner width/height: 1024/697 21:29:47 INFO - PROCESS | 630 | __metrics 21:29:47 ERROR - PROCESS | 630 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 21:29:48 INFO - TEST-INFO | 630: exit 0 21:29:48 INFO - Browser initialized. 21:29:48 INFO - Running cycle 1/1 for dromaeo_css test... 21:29:48 INFO - TEST-INFO | started process 751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjL6oAu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:30:00 INFO - PROCESS | 751 | RSS: Main: 185622528 21:30:00 INFO - PROCESS | 751 | 21:30:50 INFO - PROCESS | 751 | 1475123450559 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] 21:33:00 INFO - PROCESS | 751 | Cycle 1(1): loaded http://localhost:58076/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58076/tests/dromaeo/cssquery-ext.html) 21:33:01 INFO - PROCESS | 751 | RSS: Main: 200716288 21:33:01 INFO - PROCESS | 751 | 21:36:03 INFO - PROCESS | 751 | Cycle 1(1): loaded http://localhost:58076/tests/dromaeo/cssquery-ext.html (next: http://localhost:58076/tests/dromaeo/cssquery-jquery.html) 21:36:03 INFO - PROCESS | 751 | RSS: Main: 196542464 21:36:03 INFO - PROCESS | 751 | 21:39:05 INFO - PROCESS | 751 | Cycle 1(1): loaded http://localhost:58076/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58076/tests/dromaeo/cssquery-mootools.html) 21:39:06 INFO - PROCESS | 751 | RSS: Main: 198062080 21:39:06 INFO - PROCESS | 751 | 21:42:08 INFO - PROCESS | 751 | Cycle 1(1): loaded http://localhost:58076/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58076/tests/dromaeo/cssquery-prototype.html) 21:42:08 INFO - PROCESS | 751 | RSS: Main: 194568192 21:42:08 INFO - PROCESS | 751 | 21:45:11 INFO - PROCESS | 751 | Cycle 1(1): loaded http://localhost:58076/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58076/tests/dromaeo/cssquery-yui.html) 21:45:12 INFO - PROCESS | 751 | RSS: Main: 198393856 21:45:12 INFO - PROCESS | 751 | 21:48:15 INFO - PROCESS | 751 | Cycle 1(1): loaded http://localhost:58076/tests/dromaeo/cssquery-yui.html (next: http://localhost:58076/tests/dromaeo/cssquery-dojo.html) 21:48:15 INFO - PROCESS | 751 | RSS: Main: 199188480 21:48:15 INFO - PROCESS | 751 | 21:48:15 INFO - PROCESS | 751 | __start_tp_report 21:48:15 INFO - PROCESS | 751 | _x_x_mozilla_page_load 21:48:15 INFO - PROCESS | 751 | _x_x_mozilla_page_load_details 21:48:15 INFO - PROCESS | 751 | |i|pagename|runs| 21:48:15 INFO - PROCESS | 751 | |0;dojo.html;3016.683248258933;3016.969830301696;3029.742471889889;3046.1318524220587;3052.954205686915;5227.242049902762;5378.81174158905;5390.299261096057;5398.6490878092945;5482.753276102575;5325.627206095575;5351.759170837312;5365.919511207335;5405.648632838863;5453.972730136354;4839.830605928784;4934.827281045146;4946.134426475371;4995.400551933773;4997.675151115184;4257.5742425757335;4938.38270216223;4954.2568614707725;4973.303737476756;5022.221555658879;4739.146953548395;4770;4778.784954677048;4885.584725298371;4901.950980490185;4784.641151913585;4790.904181916377;4801.759912004386;4817.686850354716;4852.805887764485;4758.571728544413;4762.761861906891;4765.833195838164;4773.260144677581;4823.710577365334;5225.372955245395;5226.242194881721;5302.655327403706;5345.438728933484;5364.704941228231;5691.51622112121;5701.0878259478695;5716.085426331767;5717.342505611825;5749.8275051748515;5742.942570574282;5751.137329400582;5754.741036653319;5758;5761.855953601152;5266.183741520071;5312;5316.175992721096;5316.255724198615;5319.840404787863;5870.090136028923;5892.616979896293;5906.143609176645;5923.7926672566255;5934.821955341346;5633.549316054706;5637.859053523613;5639.971800140973;5641.661500309994;5644.153376993484;5585.385607583163;5668.404817494186;5697.971510142423;5724.084146536534;5729.083346664514;5707;5736.4550367715;5741.684207368551;5763.827085187451;5784.59507834456;5730.971345143331;5735.541156707453;5742.885142297214;5745.2818397700285;5754.482096611325;4305.82776688929;4335.544767799335;4370.912581748347;4390.012247244408;4449.599536041707;3874.6900247980093;3905.1408690088133;3927.666148377363;3940.940885886714;3989.6608788252743;5477.863053423616;5483.588730845203;5506.614536982453;5506.8347949560775;5581.358143813513;5548;5818.981678206297;5820.82537523875;5822.184894114827;5827.4172582741385;5347.3583170019065;5468.535174510212;5496.148097044885;5513.255710479034;5524.530414914777;4954;4965.528274813887;4969.4782047884455;4976.278439626234;5027.673201241908;6014;6016.217891674054;6020.789272375446;6023.307319658208;6035.245594300713;5686.175504551899;5719.599628025998;5765.308163020464;5793.94206057934;5819.82540523785;5997.370276120944;6012.939870601413;6019.187409699634;6040.879182416415;6063.514918806397;5549.278593782782;5610.18652295423;5681.2330335404195;5682.943170568242;5699.059655156852;5786.652800831964;5790.594658373873;5803.535717142703;5817.592768506333;5898.469137777449;5646.661200327993;5669.291338582677;5681.233033540584;5686.715664216856;5704.486596206195;5499.752511137089;5667.603267771381;5672.12082127271;5680.886382272249;5682.403347648437;5514.338279406336;5518.255035570147;5566.749496272759;5575.414581468887;5616.66300022;5625.128105143709;5642.23829782974;5661.433856614471;5662.858428539154;5663.830085097454;5509.696966666872;5537.861553461195;5557.777688892399;5559.1661250811085;5559.6664200148125 21:48:15 INFO - PROCESS | 751 | |1;ext.html;538.0620408927153;591.5090474905827;593.1814096546765;597.9850503737406;598.338835586677;41568.37647435291;42908.785456072714;42920;45737.54262457375;45905.31142032864;44080.77959610205;44626.107477850426;44703;44732.329015064715;44877.32684009735;8685.218330350268;8812.339074569401;8832.955835220815;8835.116488351177;8850.468971861677;8613.95693021534;8649.69726059588;8649.783755406133;8662.26370758483;8669.783255418633;8719.302455803552;8765.474071555695;8832.735017949472;8845.380823342368;8845.469271843709;8660.17728315809;8684.56577171139;8729;8734.868976965286;8782;8707.521086340248;8715;8730.257928076122;8730.476171429735;8765.649374025032;41540.1691966162;41791.37312940308;41963.37054944178;41975;42318.57681423208;3407.3866703993517;3407.778494397881;3451.2579795343872;3483.425234836249;3529.3117842020815;30439.23901902448;30707.38585228283;30912.69087309143;32566.6743332566;33450.83274583636;3976.1451287973223;3995.820188091543;4025.5370632377067;4170.145120250341;4194.979025104885;347192.2640386807;349496;349642;350939;352324;59563.702181488814;59844.40155598388;59905.400945990856;59952;59987.400125999055;36763.448548271794;37285.62714372821;37790.05524861845;38870;39198.21603567913;13732.862671373357;13909.30453477322;13931.512397066053;13956.72086558263;14009.649758755908;13136.671583210496;13234.867651323364;13236.536721214712;13250.536231231861;13280.933595332155;18704.812951870306;19129.617407652047;19132.426027219204;19161;19227.15456908596;6873.392468918969;6939.271376505495;7029.051078104492;7043.823904402431;7094.184168820549;900.4237288135598;989.094978095035;1063.6862125672944;1105.8949399807007;1122.5341483284346;31691;31829.681703183134;31892.202694932814;32104;32125.51811722826;1105.850710154135;1106.2422240765102;1113.554578168739;1140.8288756686563;1167.270455965022;15186.392544298325;16909.7463538047;16929.576760580836;16944.40694575684;17093;508459;519964;521195;522224;523293;55918.16122758162;56348;56371;56436;56543;1282.4549566434227;1314.6976195475095;1317.7891537353978;1319.8614145514775;1333.746588148268;29602;31482;31680.841595792797;32032;32103.67896321007;50888.745556271984;51219.46341609758;51643.22535162051;51674.48325516697;51675;426959;430363;430848;431468;431628;28462.85768571144;28543.857280713462;28563.28591785139;29004;29169.854150729112;45550.77224613856;45898.484006666615;46664.30003549882;46923.530764693285;47046.52953470559;39527.209455811295;39636.2072758549;40919.795401022806;41252.58747412488;41753.58246417497;40168.39747403733;40802;40853.38719919263;41453.79273103615;41577.37633935433;40036;40550.797246014765;40850;41039.1792164161;41111;31744.523832142997;34871.30257394889;36308.81845590755;36600.45099323565;36965.815170923976;27701.861490693223;27941.58087628728;27948.86025569859;27960;28240.870365185983 21:48:15 INFO - PROCESS | 751 | |2;jquery.html;388.35920730794203;388.9980550097249;397.51304651801547;401.41994817488734;422.74234153393655;14434.855651443482;18057;18972.525686857836;19634.90182549087;19676.803231967675;18403;18545.907270463664;18682;19024.2390304388;19086.141123649435;5522.22688823563;5530.806421775239;5683.886322273552;5714.914276285838;5719.113537401709;5636.943630563704;5648.293963254593;5660.3490598581275;5662.37713851476;5684.289463817023;5463.9180412293845;5579.414161513044;5628.549716022729;5631.887362252753;5633.436656334355;5385.838424847261;5593.328800543941;5628.409017053192;5629.859253518674;5641.323041235058;4999.275105109738;5021.799128034874;5032.471590482984;5035.899282014376;5043.5965122790085;21940;22018.339449816373;22242.332730018126;22456.775432245795;22513;2250.831187660932;2380.321608341614;2398.292503711392;2466.7903228225623;2475.517274131545;10909.618163364323;14395.568132956028;14480.203588802611;14666.340014699257;15042.172680502568;1904.3049287010142;1917.6260629177316;1929.2732407812607;1999.9100040498213;2004.2984955265686;80553.75016248507;81375.59312203401;81388;82199.5890020552;83845.58077209575;10097.596096156218;10277.486125693686;10486.528106235237;10617.84073238902;10864.456777161111;10835;11523.827142592867;15049.473268435551;15069.09585424878;15119.244037798066;7425.997490338735;7431.182569917305;7465.253474652492;7662.885056724153;7863.252990965963;7733.41999350051;7747.1090824555895;7944.761657150295;7956.283934445928;8017.078036025815;3572.964270357263;3615.6203598621764;3690.833912473945;3726.6646001859963;3788.753731007476;1774.7426623139572;1798.3436045843173;1806.313600831702;1833.4316361927845;1870.9812901870807;942.2414955960518;964.508100868548;970.3498655900563;1007.5214273220308;1044.9477526123662;18372.81627183711;18857.151428185764;18867.622647546974;18883.527911802314;19025.907150213465;998.5905778630727;1010.408910787183;1020.9540570674337;1042.8227201375785;1051.6319288249204;9727.464989425507;10526.263161578616;10577.100946419641;10603.363798172135;10712.892871071346;424628;432483;434929;434975;436316;82445.58777206196;85669.57165214134;86035.56982215049;86184.56907715547;91153.08846911578;975.2149519636619;994.532569692258;995.2187532786872;1000.7548150703125;1003.2826529031777;15287.381589991464;15943.36226550925;16399.180040997664;16713.247903844112;16909.23908424099;38374.80812595919;39965.200695986496;41722.37416438695;42593;43693.78153109214;54619;54809;54852.72573637106;56689.43310567007;60162.39837601568;8036.799080023046;8594;8599.785005374666;8656.394052416523;8730.075424732531;11477.713057173303;13084.803727943898;13137.934310328386;13157.868421316047;13360.93319533396;11365.204435689422;11432.542698291974;11472.598459053894;12245.938770306448;12256;11204.495797689287;11297.604583839855;11301.15241356918;11360.715982100513;11945.940270298594;11565;11695.181337306307;11810.40947952616;11833.763324733629;12024.458899349374;8368.24685778283;8456;8486.702965396182;8570.871436928575;8708.17272359125;9221.492817894812;11189.552417903193;11275.887241127812;11361.886381136414;11862.347570883685 21:48:15 INFO - PROCESS | 751 | |3;mootools.html;1453.3895763779212;1502.113752885797;1599.8800089993247;1728.2827626534988;1749.71129763589;8560.828783424327;8920.107989201077;9216.447013179213;9229.215516681083;9291.581878815452;9173.357864949456;9261.72214833556;9303.813923721538;9316.767080822983;9320.673776417827;2308.1690591387087;2346.1582657613776;2348.236823032513;2353.6940197774265;2356.7996720278798;2311.849729767568;2318.7449380568123;2364.432536191319;2370.466645004869;2372.193454225563;2302.8618282902994;2310.5378924215142;2315.189683610731;2364.84628499147;2365.515069410775;2275.601769690314;2280.965785513202;2299.2642354446584;2307.1232931486097;2313.687652166961;2265.3543740034174;2267.8979445924974;2268.2854900706225;2273.57938781326;2275.5107651854933;9012.324075694349;9038.683646072423;9063.41087829289;9074.45553266806;9104.499252541107;4948.208286674115;5105.642605017651;5133.435322114565;5133.589312855;5142.460041695643;3129.8278594677286;3160.5417214504;3248.1717162123746;3282.113829266085;3300.818454984975;1061.6921092883056;1095;1101.4988180377989;1117.6255954255334;1122.405125283601;12392.938035309857;12404.56584019564;12409.193402428813;12540.247585144829;12542.122051456401;4247.723897946624;4337.327714204303;4446.887728329018;4515.2549829277805;4522.3668686383935;9745.902540974499;9753.951230243803;9775.706728798148;9781.608735650636;9785.706428807147;4949.505049495022;4956;4962.925556116661;4983.950160498349;4994.300797888299;4117.21772863155;4247.723897946686;4533.795979180944;4616.6075883550275;4637.698549594265;3608.260306637133;3712.1276500022473;3772.7924964126687;3783.1084457771112;3845.788481633481;1151.5969410706186;1161.8896204860694;1174.3599738142561;1182.5447202826974;1197.6107764976418;895.7671005538607;907.6233363154349;925.3522534226069;942.5602590060549;953.270747877874;5576.86057848557;5604.271444712162;5638.746256418471;5682.460166284196;5842.591018628656;910.2035718746097;913.7487191022522;936.1714882329052;943.3208090175063;962.7689354554997;3549.982250088733;3562.71498280137;3657.158853463718;3698.7595806273043;3751;11011;11295.54817807295;11371.31772093677;11376.715582110348;11379.146564007568;10479.10927571165;11027.669169924915;11128.165387595962;11243.212975091665;11355.602553910574;8227.13615070409;8450.61972211252;8455.74632761018;8458.74623761288;8465.94175728034;5712.714364281686;5822.796202132905;5865.794697185578;5961.763170325539;6081.027035674271;9798.85301720489;10297;10407.06336429725;10410.843837342294;10516.631917882838;10430.895691042992;10644.627438039632;10654.094401975919;10668.83996740065;10700.839487407851;6991;7250.782476525713;7602.50583712057;8046.195380462141;8150.673973041012;8378.706745263886;8700;8767.079456656958;8768.430052046597;8785.780355490908;7652.961735191288;7658.195889431752;7841.9215807843475;7884.172161922916;7944.245296696805;7581;7705.807354816175;7736.4584479085925;7759.379249659901;8015.118336983044;6689.096971908924;6774.42417394527;6781.0845535854005;6781.38967492928;6797.72809087631;4838.806447742191;4843.878903027453;4861.270809378621;4924.261360795909;5076.11168045598;5047.167217409234;5049.747512624281;5076.5431111198695;5114.46298138705;5146.099432599355 21:48:15 INFO - PROCESS | 751 | |4;prototype.html;313.30290104517445;322.67087570677893;330.647860029069;339.2468719442836;342.30682867193946;5383.43473935237;5450.781968721251;5528.226048353234;5555.86110347241;5563.972180139093;5382.784688612461;5390.299261096052;5405.5135037846585;5431.728413579325;5466.453354664532;4193.853215137463;4194.622483976442;4198.412222288882;4214.136102099078;4221.641160501345;4018.176273863851;4205.369194620801;4212.347086201644;4228.513720922103;4229.413969761339;4198.790060496978;4220.78896055196;4221.430106935555;4222.746635201883;4226.1547690461875;4194.874153775391;4217.873463796091;4227.091175397273;4235.280002399584;4241.703080784347;3765.3034188675183;3771.283456143324;3776.093737503007;3789.5831458539537;3791;5097.7196254206;5270.367555893279;5303.814366497193;5309.734513274321;5323.520883120537;4862.6839255448285;4866.537678920497;4879.707217566957;4895.2167653175675;4915.188993816016;5394.3547218098465;5674.914876276859;5692.544596432275;5697;5718.25662663851;4053.310937140693;4073.877783666495;4077.3272410052305;4078.857239996586;4088;5894.17481552583;5899.115132730082;5902.6458412495385;5909.143174239754;5957.791477298274;4073.714839961174;4175.039740859619;4208;4208.789560521962;4267.935980960288;4244.893877653083;4254.532001479834;4257.489101307863;4265.701400901907;4300.6129448349175;4833.830815921426;4848.490908454562;4875.878103047452;4876.536729010738;4895.681780684244;5485.341758988947;5712.257406537206;5716.371199168088;5739.971300143473;5804;1469.5885152157414;1492.835788063312;1499.9475018374305;1500.8593468963666;1501.5345242974713;917.7155081924625;952.5665822050951;956.7942892278194;961.423146112341;962.3359881681617;4835;4851.733154676456;4900.5099490051425;4919.524142757158;4927.384076990376;5130.486506480597;5198.32421785173;5200.413873768462;5209.270702101709;5210.843674689765;4679.368285281512;4785.401824771903;4872;4879;4889.339939108175;2722.931926701848;2758.6827065264874;2763.9170824875287;2765.6681198255937;2781.664800895541;5294.92057619136;5335.039692855324;5365.570754339721;5368.5236559946325;5391.487808658171;4923.8276660316715;5192.506711862367;5220.216967454912;5241.292425522505;5284.841454756363;5304.761285742151;5325.786968521215;5331.214837465365;5335.519803217807;5346.433711818271;5123.3339665843205;5137.717425541631;5159.587233021424;5168.276441298146;5173.301604283373;5129.7691603877165;5432.483914028161;5840.299164100165;5876.059830427112;5876.764929402776;6147.784827531015;6166.969165154145;6172.753089876534;6179.752809887734;6196.349383314687;3955.960440395559;3993.201359728008;4039.93940090893;4041.81811818463;4210.536840947555;5755.36690964002;5783.16144159103;5814.709264536841;5829.183914251923;5830.4461076197695;5553.444655534414;5670.121131224667;5673.517750991212;5683.8863222736145;5700.600957933071;5588.105903055492;5629.718514074198;5635.971820140873;5650.954573403934;5654.773809047592;5604.187392828098;5615.904898544744;5647.350554686263;5647.915281270702;5685.857853553694;5571.916421253603;5655.717214139194;5676;5723.771049157987;5730.71346432685;5521.613487055867;5606.943930560642;5631.436856314336;5638.915416268841;5642.492175704042 21:48:15 INFO - PROCESS | 751 | |5;yui.html;729.3363039633933;730.3244498838573;770.310572038026;797.86436305828;820.6020080261075;15403.614909627266;16000.359985600577;16043.117628530426;16049.117298548575;16058.678826423464;14971.251437428113;15041.924790376033;15128.621784455367;15135.318910649019;15139.92430037851;653.9117219175422;677.678102901123;769.503670132764;775.6354513378703;796.0606484348466;796.4663675337538;796.9880451793227;800.3757069485811;802.8233788566506;803.4135081390589;839.5256679975794;847.0936098374741;849.4860609331358;854.0562678240548;854.628236717027;839.1524560194248;839.3327304792705;840.3277378097528;841.6044459104211;841.6128580852815;613.8035828534871;615.3692465223137;617.8640699046202;619.7582942652369;624.6439529468205;14737;14737.557873263819;14739.926300368537;14741.262936853114;14760.557183284518;15152.393904243818;15394.15332156731;15451.381944722198;15535.689286214325;15546.455874044354;11289.15331350152;11307.265027773168;11309.09527237819;11358.091352691765;12030.69923251917;3774.45270435788;3800.5629352624524;3889.358255887775;3904.5900180480926;4021.2560676274984;71750.28249717488;73597.63201184013;73639.63180184118;74322.99999999946;76032.61983690101;11573;11724.765504690029;11761.823572646417;11789.056875449944;12071.517139314328;22781.658275125887;22810.543789124124;22820.543589128123;22824.087036518355;22862;8388.748337549883;8417.831643367099;8586.914130858737;8951.507667078373;8963.731088067369;4670.486246512881;4736.905261894743;4869.196582563837;4957.553820156131;4987.501249874984;3225.9838700806813;3322.966770332314;3327.683870032343;3329.234276116458;3329.550510681027;558.522463293886;561.7640590951728;565.6040771459994;572.0189874365483;572.8940146072906;527.9736013199401;592.552622769806;632.5445679111033;656.2125449460666;734.7685479074074;9768.853467197998;10034.749131271778;10087.49562521871;10142.949285253526;10271;639.7345101782801;653.3303364051885;658.8912829383098;681.4922882452505;723.1972510513326;4581.496035436166;4706.62347012245;4773.546513081252;4904.852854414374;4991.251312303111;113654;127159;127442;130046;130583;64016;90929;97415.51292243494;105548;105757.47121264499;80247.59876200581;81557.9999999988;81661;85529.57235213784;98362.50818746003;9466.2427005838;9893.406395616286;9912.15746661542;9929.503524823585;9989.800203995734;48715.756421217666;49507.75246123746;50648.240276396624;51687.74156129195;54037.459625403244;68667.65666171638;71968;75101.62449187718;76788.61605691936;77579.2242077572;10947;11279;12879.420426080662;13186.406611702305;13309.800352994907;12078.154529182873;14089.788653170006;14394.35225414838;14531.564053078424;15421.691566168838;13804;14258.572242832732;14584.1978691173;14685;15082.095074295577;13329.933350333575;13572.457101715821;13824;14135.64660883445;14168.520508911106;13750.312484375541;14096.08375455592;14144.222067785959;14208.28958552089;14666.77999829982;10886.510107045044;11229.101671866069;11402.48688808989;11510.654680359603;11547.018503427304;10318.43248621333;10634.41510716887;10667.839982400425;10785.245032847626;11634.76730465403 21:48:15 INFO - PROCESS | 751 | __end_tp_report 21:48:15 INFO - PROCESS | 751 | __start_cc_report 21:48:15 INFO - PROCESS | 751 | _x_x_mozilla_cycle_collect,308 21:48:15 INFO - PROCESS | 751 | __end_cc_report 21:48:15 INFO - PROCESS | 751 | __startTimestamp1475124495327__endTimestamp 21:48:15 INFO - PROCESS | 751 | 21:48:15 INFO - PROCESS | 751 | ------- Summary: start ------- 21:48:15 INFO - PROCESS | 751 | Number of tests: 6 21:48:15 INFO - PROCESS | 751 | 21:48:15 INFO - PROCESS | 751 | [#0] dojo.html Cycles:165 Average:5336.72 Median:5559.17 stddev:630.82 (11.3%) stddev-sans-first:605.93 21:48:15 INFO - PROCESS | 751 | Values: 3016.7 3017.0 3029.7 3046.1 3053.0 5227.2 5378.8 5390.3 5398.6 5482.8 5325.6 5351.8 5365.9 5405.6 5454.0 4839.8 4934.8 4946.1 4995.4 4997.7 4257.6 4938.4 4954.3 4973.3 5022.2 4739.1 4770.0 4778.8 4885.6 4902.0 4784.6 4790.9 4801.8 4817.7 4852.8 4758.6 4762.8 4765.8 4773.3 4823.7 5225.4 5226.2 5302.7 5345.4 5364.7 5691.5 5701.1 5716.1 5717.3 5749.8 5742.9 5751.1 5754.7 5758.0 5761.9 5266.2 5312.0 5316.2 5316.3 5319.8 5870.1 5892.6 5906.1 5923.8 5934.8 5633.5 5637.9 5640.0 5641.7 5644.2 5585.4 5668.4 5698.0 5724.1 5729.1 5707.0 5736.5 5741.7 5763.8 5784.6 5731.0 5735.5 5742.9 5745.3 5754.5 4305.8 4335.5 4370.9 4390.0 4449.6 3874.7 3905.1 3927.7 3940.9 3989.7 5477.9 5483.6 5506.6 5506.8 5581.4 5548.0 5819.0 5820.8 5822.2 5827.4 5347.4 5468.5 5496.1 5513.3 5524.5 4954.0 4965.5 4969.5 4976.3 5027.7 6014.0 6016.2 6020.8 6023.3 6035.2 5686.2 5719.6 5765.3 5793.9 5819.8 5997.4 6012.9 6019.2 6040.9 6063.5 5549.3 5610.2 5681.2 5682.9 5699.1 5786.7 5790.6 5803.5 5817.6 5898.5 5646.7 5669.3 5681.2 5686.7 5704.5 5499.8 5667.6 5672.1 5680.9 5682.4 5514.3 5518.3 5566.7 5575.4 5616.7 5625.1 5642.2 5661.4 5662.9 5663.8 5509.7 5537.9 5557.8 5559.2 5559.7 21:48:15 INFO - PROCESS | 751 | 21:48:15 INFO - PROCESS | 751 | [#1] ext.html Cycles:180 Average:58773.97 Median:41075.09 stddev:116227.59 (283.0%) stddev-sans-first:116471.39 21:48:15 INFO - PROCESS | 751 | Values: 538.1 591.5 593.2 598.0 598.3 41568.4 42908.8 42920.0 45737.5 45905.3 44080.8 44626.1 44703.0 44732.3 44877.3 8685.2 8812.3 8833.0 8835.1 8850.5 8614.0 8649.7 8649.8 8662.3 8669.8 8719.3 8765.5 8832.7 8845.4 8845.5 8660.2 8684.6 8729.0 8734.9 8782.0 8707.5 8715.0 8730.3 8730.5 8765.6 41540.2 41791.4 41963.4 41975.0 42318.6 3407.4 3407.8 3451.3 3483.4 3529.3 30439.2 30707.4 30912.7 32566.7 33450.8 3976.1 3995.8 4025.5 4170.1 4195.0 347192.3 349496.0 349642.0 350939.0 352324.0 59563.7 59844.4 59905.4 59952.0 59987.4 36763.4 37285.6 37790.1 38870.0 39198.2 13732.9 13909.3 13931.5 13956.7 14009.6 13136.7 13234.9 13236.5 13250.5 13280.9 18704.8 19129.6 19132.4 19161.0 19227.2 6873.4 6939.3 7029.1 7043.8 7094.2 900.4 989.1 1063.7 1105.9 1122.5 31691.0 31829.7 31892.2 32104.0 32125.5 1105.9 1106.2 1113.6 1140.8 1167.3 15186.4 16909.7 16929.6 16944.4 17093.0 508459.0 519964.0 521195.0 522224.0 523293.0 55918.2 56348.0 56371.0 56436.0 56543.0 1282.5 1314.7 1317.8 1319.9 1333.7 29602.0 31482.0 31680.8 32032.0 32103.7 50888.7 51219.5 51643.2 51674.5 51675.0 426959.0 430363.0 430848.0 431468.0 431628.0 28462.9 28543.9 28563.3 29004.0 29169.9 45550.8 45898.5 46664.3 46923.5 47046.5 39527.2 39636.2 40919.8 41252.6 41753.6 40168.4 40802.0 40853.4 41453.8 41577.4 40036.0 40550.8 40850.0 41039.2 41111.0 31744.5 34871.3 36308.8 36600.5 36965.8 27701.9 27941.6 27948.9 27960.0 28240.9 21:48:15 INFO - PROCESS | 751 | 21:48:15 INFO - PROCESS | 751 | [#2] jquery.html Cycles:180 Average:27023.49 Median:3024.24 stddev:71593.64 (2367.3%) stddev-sans-first:71766.55 21:48:15 INFO - PROCESS | 751 | Values: 388.4 389.0 397.5 401.4 422.7 14434.9 18057.0 18972.5 19634.9 19676.8 18403.0 18545.9 18682.0 19024.2 19086.1 5522.2 5530.8 5683.9 5714.9 5719.1 5636.9 5648.3 5660.3 5662.4 5684.3 5463.9 5579.4 5628.5 5631.9 5633.4 5385.8 5593.3 5628.4 5629.9 5641.3 4999.3 5021.8 5032.5 5035.9 5043.6 21940.0 22018.3 22242.3 22456.8 22513.0 2250.8 2380.3 2398.3 2466.8 2475.5 10909.6 14395.6 14480.2 14666.3 15042.2 1904.3 1917.6 1929.3 1999.9 2004.3 80553.8 81375.6 81388.0 82199.6 83845.6 10097.6 10277.5 10486.5 10617.8 10864.5 10835.0 11523.8 15049.5 15069.1 15119.2 7426.0 7431.2 7465.3 7662.9 7863.3 7733.4 7747.1 7944.8 7956.3 8017.1 3573.0 3615.6 3690.8 3726.7 3788.8 1774.7 1798.3 1806.3 1833.4 1871.0 942.2 964.5 970.3 1007.5 1044.9 18372.8 18857.2 18867.6 18883.5 19025.9 998.6 1010.4 1021.0 1042.8 1051.6 9727.5 10526.3 10577.1 10603.4 10712.9 424628.0 432483.0 434929.0 434975.0 436316.0 82445.6 85669.6 86035.6 86184.6 91153.1 975.2 994.5 995.2 1000.8 1003.3 15287.4 15943.4 16399.2 16713.2 16909.2 38374.8 39965.2 41722.4 42593.0 43693.8 54619.0 54809.0 54852.7 56689.4 60162.4 8036.8 8594.0 8599.8 8656.4 8730.1 11477.7 13084.8 13137.9 13157.9 13360.9 11365.2 11432.5 11472.6 12245.9 12256.0 11204.5 11297.6 11301.2 11360.7 11945.9 11565.0 11695.2 11810.4 11833.8 12024.5 8368.2 8456.0 8486.7 8570.9 8708.2 9221.5 11189.6 11275.9 11361.9 11862.3 21:48:15 INFO - PROCESS | 751 | 21:48:15 INFO - PROCESS | 751 | [#3] mootools.html Cycles:180 Average:5785.05 Median:4852.57 stddev:3396.85 (70.0%) stddev-sans-first:3390.78 21:48:15 INFO - PROCESS | 751 | Values: 1453.4 1502.1 1599.9 1728.3 1749.7 8560.8 8920.1 9216.4 9229.2 9291.6 9173.4 9261.7 9303.8 9316.8 9320.7 2308.2 2346.2 2348.2 2353.7 2356.8 2311.8 2318.7 2364.4 2370.5 2372.2 2302.9 2310.5 2315.2 2364.8 2365.5 2275.6 2281.0 2299.3 2307.1 2313.7 2265.4 2267.9 2268.3 2273.6 2275.5 9012.3 9038.7 9063.4 9074.5 9104.5 4948.2 5105.6 5133.4 5133.6 5142.5 3129.8 3160.5 3248.2 3282.1 3300.8 1061.7 1095.0 1101.5 1117.6 1122.4 12392.9 12404.6 12409.2 12540.2 12542.1 4247.7 4337.3 4446.9 4515.3 4522.4 9745.9 9754.0 9775.7 9781.6 9785.7 4949.5 4956.0 4962.9 4984.0 4994.3 4117.2 4247.7 4533.8 4616.6 4637.7 3608.3 3712.1 3772.8 3783.1 3845.8 1151.6 1161.9 1174.4 1182.5 1197.6 895.8 907.6 925.4 942.6 953.3 5576.9 5604.3 5638.7 5682.5 5842.6 910.2 913.7 936.2 943.3 962.8 3550.0 3562.7 3657.2 3698.8 3751.0 11011.0 11295.5 11371.3 11376.7 11379.1 10479.1 11027.7 11128.2 11243.2 11355.6 8227.1 8450.6 8455.7 8458.7 8465.9 5712.7 5822.8 5865.8 5961.8 6081.0 9798.9 10297.0 10407.1 10410.8 10516.6 10430.9 10644.6 10654.1 10668.8 10700.8 6991.0 7250.8 7602.5 8046.2 8150.7 8378.7 8700.0 8767.1 8768.4 8785.8 7653.0 7658.2 7841.9 7884.2 7944.2 7581.0 7705.8 7736.5 7759.4 8015.1 6689.1 6774.4 6781.1 6781.4 6797.7 4838.8 4843.9 4861.3 4924.3 5076.1 5047.2 5049.7 5076.5 5114.5 5146.1 21:48:15 INFO - PROCESS | 751 | 21:48:15 INFO - PROCESS | 751 | [#4] prototype.html Cycles:180 Average:4655.23 Median:5199.37 stddev:1352.66 (26.0%) stddev-sans-first:1316.61 21:48:15 INFO - PROCESS | 751 | Values: 313.3 322.7 330.6 339.2 342.3 5383.4 5450.8 5528.2 5555.9 5564.0 5382.8 5390.3 5405.5 5431.7 5466.5 4193.9 4194.6 4198.4 4214.1 4221.6 4018.2 4205.4 4212.3 4228.5 4229.4 4198.8 4220.8 4221.4 4222.7 4226.2 4194.9 4217.9 4227.1 4235.3 4241.7 3765.3 3771.3 3776.1 3789.6 3791.0 5097.7 5270.4 5303.8 5309.7 5323.5 4862.7 4866.5 4879.7 4895.2 4915.2 5394.4 5674.9 5692.5 5697.0 5718.3 4053.3 4073.9 4077.3 4078.9 4088.0 5894.2 5899.1 5902.6 5909.1 5957.8 4073.7 4175.0 4208.0 4208.8 4267.9 4244.9 4254.5 4257.5 4265.7 4300.6 4833.8 4848.5 4875.9 4876.5 4895.7 5485.3 5712.3 5716.4 5740.0 5804.0 1469.6 1492.8 1499.9 1500.9 1501.5 917.7 952.6 956.8 961.4 962.3 4835.0 4851.7 4900.5 4919.5 4927.4 5130.5 5198.3 5200.4 5209.3 5210.8 4679.4 4785.4 4872.0 4879.0 4889.3 2722.9 2758.7 2763.9 2765.7 2781.7 5294.9 5335.0 5365.6 5368.5 5391.5 4923.8 5192.5 5220.2 5241.3 5284.8 5304.8 5325.8 5331.2 5335.5 5346.4 5123.3 5137.7 5159.6 5168.3 5173.3 5129.8 5432.5 5840.3 5876.1 5876.8 6147.8 6167.0 6172.8 6179.8 6196.3 3956.0 3993.2 4039.9 4041.8 4210.5 5755.4 5783.2 5814.7 5829.2 5830.4 5553.4 5670.1 5673.5 5683.9 5700.6 5588.1 5629.7 5636.0 5651.0 5654.8 5604.2 5615.9 5647.4 5647.9 5685.9 5571.9 5655.7 5676.0 5723.8 5730.7 5521.6 5606.9 5631.4 5638.9 5642.5 21:48:15 INFO - PROCESS | 751 | 21:48:15 INFO - PROCESS | 751 | [#5] yui.html Cycles:180 Average:20913.22 Median:4301.38 stddev:30416.61 (707.1%) stddev-sans-first:30464.18 21:48:15 INFO - PROCESS | 751 | Values: 729.3 730.3 770.3 797.9 820.6 15403.6 16000.4 16043.1 16049.1 16058.7 14971.3 15041.9 15128.6 15135.3 15139.9 653.9 677.7 769.5 775.6 796.1 796.5 797.0 800.4 802.8 803.4 839.5 847.1 849.5 854.1 854.6 839.2 839.3 840.3 841.6 841.6 613.8 615.4 617.9 619.8 624.6 14737.0 14737.6 14739.9 14741.3 14760.6 15152.4 15394.2 15451.4 15535.7 15546.5 11289.2 11307.3 11309.1 11358.1 12030.7 3774.5 3800.6 3889.4 3904.6 4021.3 71750.3 73597.6 73639.6 74323.0 76032.6 11573.0 11724.8 11761.8 11789.1 12071.5 22781.7 22810.5 22820.5 22824.1 22862.0 8388.7 8417.8 8586.9 8951.5 8963.7 4670.5 4736.9 4869.2 4957.6 4987.5 3226.0 3323.0 3327.7 3329.2 3329.6 558.5 561.8 565.6 572.0 572.9 528.0 592.6 632.5 656.2 734.8 9768.9 10034.7 10087.5 10142.9 10271.0 639.7 653.3 658.9 681.5 723.2 4581.5 4706.6 4773.5 4904.9 4991.3 113654.0 127159.0 127442.0 130046.0 130583.0 64016.0 90929.0 97415.5 105548.0 105757.5 80247.6 81558.0 81661.0 85529.6 98362.5 9466.2 9893.4 9912.2 9929.5 9989.8 48715.8 49507.8 50648.2 51687.7 54037.5 68667.7 71968.0 75101.6 76788.6 77579.2 10947.0 11279.0 12879.4 13186.4 13309.8 12078.2 14089.8 14394.4 14531.6 15421.7 13804.0 14258.6 14584.2 14685.0 15082.1 13329.9 13572.5 13824.0 14135.6 14168.5 13750.3 14096.1 14144.2 14208.3 14666.8 10886.5 11229.1 11402.5 11510.7 11547.0 10318.4 10634.4 10667.8 10785.2 11634.8 21:48:15 INFO - PROCESS | 751 | -------- Summary: end -------- 21:48:15 INFO - PROCESS | 751 | 21:48:16 INFO - TEST-INFO | 751: exit 0 21:48:16 INFO - TEST-OK | dromaeo_css | took 1113706ms 21:48:16 INFO - TEST-START | kraken 21:48:16 INFO - operating with platform_type : linux_ 21:48:16 INFO - Initialising browser for kraken test... 21:48:16 INFO - TEST-INFO | started process 1130 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ8nDVy/profile http://localhost:58076/getInfo.html) 21:48:20 INFO - PROCESS | 1130 | __metrics Screen width/height:1600/1200 21:48:20 INFO - PROCESS | 1130 | colorDepth:24 21:48:20 INFO - PROCESS | 1130 | Browser inner width/height: 1024/697 21:48:20 INFO - PROCESS | 1130 | __metrics 21:48:21 ERROR - PROCESS | 1130 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 21:48:22 INFO - TEST-INFO | 1130: exit 0 21:48:22 INFO - Browser initialized. 21:48:22 INFO - Running cycle 1/1 for kraken test... 21:48:22 INFO - TEST-INFO | started process 1319 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ8nDVy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:48:34 INFO - PROCESS | 1319 | RSS: Main: 185475072 21:48:34 INFO - PROCESS | 1319 | 21:48:37 INFO - PROCESS | 1319 | Cycle 1(1): loaded http://localhost:58076/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58076/tests/kraken/driver.html?testName=audio-beat-detection) 21:48:37 INFO - PROCESS | 1319 | RSS: Main: 199409664 21:48:37 INFO - PROCESS | 1319 | 21:48:40 INFO - PROCESS | 1319 | Cycle 1(1): loaded http://localhost:58076/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58076/tests/kraken/driver.html?testName=audio-dft) 21:48:41 INFO - PROCESS | 1319 | RSS: Main: 197115904 21:48:41 INFO - PROCESS | 1319 | 21:48:44 INFO - PROCESS | 1319 | Cycle 1(1): loaded http://localhost:58076/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58076/tests/kraken/driver.html?testName=audio-fft) 21:48:44 INFO - PROCESS | 1319 | RSS: Main: 192372736 21:48:44 INFO - PROCESS | 1319 | 21:48:46 INFO - PROCESS | 1319 | Cycle 1(1): loaded http://localhost:58076/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58076/tests/kraken/driver.html?testName=audio-oscillator) 21:48:47 INFO - PROCESS | 1319 | RSS: Main: 193814528 21:48:47 INFO - PROCESS | 1319 | 21:48:49 INFO - PROCESS | 1319 | Cycle 1(1): loaded http://localhost:58076/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58076/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:48:50 INFO - PROCESS | 1319 | RSS: Main: 193372160 21:48:50 INFO - PROCESS | 1319 | 21:48:53 INFO - PROCESS | 1319 | Cycle 1(1): loaded http://localhost:58076/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58076/tests/kraken/driver.html?testName=imaging-darkroom) 21:48:53 INFO - PROCESS | 1319 | RSS: Main: 194113536 21:48:53 INFO - PROCESS | 1319 | 21:48:57 INFO - PROCESS | 1319 | Cycle 1(1): loaded http://localhost:58076/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58076/tests/kraken/driver.html?testName=imaging-desaturate) 21:48:57 INFO - PROCESS | 1319 | RSS: Main: 191770624 21:48:57 INFO - PROCESS | 1319 | 21:49:00 INFO - PROCESS | 1319 | Cycle 1(1): loaded http://localhost:58076/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58076/tests/kraken/driver.html?testName=json-parse-financial) 21:49:01 INFO - PROCESS | 1319 | RSS: Main: 192950272 21:49:01 INFO - PROCESS | 1319 | 21:49:03 INFO - PROCESS | 1319 | Cycle 1(1): loaded http://localhost:58076/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58076/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:49:03 INFO - PROCESS | 1319 | RSS: Main: 193220608 21:49:03 INFO - PROCESS | 1319 | 21:49:05 INFO - PROCESS | 1319 | Cycle 1(1): loaded http://localhost:58076/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58076/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:49:06 INFO - PROCESS | 1319 | RSS: Main: 193314816 21:49:06 INFO - PROCESS | 1319 | 21:49:08 INFO - PROCESS | 1319 | Cycle 1(1): loaded http://localhost:58076/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58076/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:49:08 INFO - PROCESS | 1319 | RSS: Main: 193642496 21:49:08 INFO - PROCESS | 1319 | 21:49:11 INFO - PROCESS | 1319 | Cycle 1(1): loaded http://localhost:58076/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58076/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:49:12 INFO - PROCESS | 1319 | RSS: Main: 194170880 21:49:12 INFO - PROCESS | 1319 | 21:49:14 INFO - PROCESS | 1319 | Cycle 1(1): loaded http://localhost:58076/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58076/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:49:15 INFO - PROCESS | 1319 | RSS: Main: 194052096 21:49:15 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | Cycle 1(1): loaded http://localhost:58076/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58076/tests/kraken/driver.html?testName=ai-astar) 21:49:17 INFO - PROCESS | 1319 | RSS: Main: 195301376 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | __start_tp_report 21:49:17 INFO - PROCESS | 1319 | _x_x_mozilla_page_load 21:49:17 INFO - PROCESS | 1319 | _x_x_mozilla_page_load_details 21:49:17 INFO - PROCESS | 1319 | |i|pagename|runs| 21:49:17 INFO - PROCESS | 1319 | |0;ai-astar;107;111;113;112;111;111;110;110;111;110 21:49:17 INFO - PROCESS | 1319 | |1;audio-beat-detection;149;122;121;178;123;122;125;123;146;121 21:49:17 INFO - PROCESS | 1319 | |2;audio-dft;161;163;167;175;166;163;163;163;164;163 21:49:17 INFO - PROCESS | 1319 | |3;audio-fft;76;76;75;117;76;78;76;77;97;76 21:49:17 INFO - PROCESS | 1319 | |4;audio-oscillator;84;82;113;84;83;82;113;83;82;116 21:49:17 INFO - PROCESS | 1319 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;118;120;117 21:49:17 INFO - PROCESS | 1319 | |6;imaging-darkroom;147;146;148;147;147;147;146;148;147;146 21:49:17 INFO - PROCESS | 1319 | |7;imaging-desaturate;96;97;96;96;96;96;96;96;96;95 21:49:17 INFO - PROCESS | 1319 | |8;json-parse-financial;51;52;53;53;53;59;55;54;54;54 21:49:17 INFO - PROCESS | 1319 | |9;json-stringify-tinderbox;59;59;58;58;62;59;58;59;59;59 21:49:17 INFO - PROCESS | 1319 | |10;stanford-crypto-aes;79;80;80;86;85;80;80;84;79;80 21:49:17 INFO - PROCESS | 1319 | |11;stanford-crypto-ccm;130;129;134;127;129;125;135;124;173;129 21:49:17 INFO - PROCESS | 1319 | |12;stanford-crypto-pbkdf2;172;167;166;171;170;163;162;170;165;164 21:49:17 INFO - PROCESS | 1319 | |13;stanford-crypto-sha256-iterative;66;67;66;67;65;67;76;67;68;64 21:49:17 INFO - PROCESS | 1319 | __end_tp_report 21:49:17 INFO - PROCESS | 1319 | __start_cc_report 21:49:17 INFO - PROCESS | 1319 | _x_x_mozilla_cycle_collect,770 21:49:17 INFO - PROCESS | 1319 | __end_cc_report 21:49:17 INFO - PROCESS | 1319 | __startTimestamp1475124557498__endTimestamp 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | ------- Summary: start ------- 21:49:17 INFO - PROCESS | 1319 | Number of tests: 14 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.58 (1.4%) stddev-sans-first:1.00 21:49:17 INFO - PROCESS | 1319 | Values: 107.0 111.0 113.0 112.0 111.0 111.0 110.0 110.0 111.0 110.0 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | [#1] audio-beat-detection Cycles:10 Average:133.00 Median:124.00 stddev:18.99 (15.3%) stddev-sans-first:19.23 21:49:17 INFO - PROCESS | 1319 | Values: 149.0 122.0 121.0 178.0 123.0 122.0 125.0 123.0 146.0 121.0 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | [#2] audio-dft Cycles:10 Average:164.80 Median:163.50 stddev:3.97 (2.4%) stddev-sans-first:3.96 21:49:17 INFO - PROCESS | 1319 | Values: 161.0 163.0 167.0 175.0 166.0 163.0 163.0 163.0 164.0 163.0 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:13.82 (18.2%) stddev-sans-first:14.46 21:49:17 INFO - PROCESS | 1319 | Values: 76.0 76.0 75.0 117.0 76.0 78.0 76.0 77.0 97.0 76.0 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:82.50 stddev:15.08 (18.3%) stddev-sans-first:15.70 21:49:17 INFO - PROCESS | 1319 | Values: 84.0 82.0 113.0 84.0 83.0 82.0 113.0 83.0 82.0 116.0 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 21:49:17 INFO - PROCESS | 1319 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 120.0 117.0 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 21:49:17 INFO - PROCESS | 1319 | Values: 147.0 146.0 148.0 147.0 147.0 147.0 146.0 148.0 147.0 146.0 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 21:49:17 INFO - PROCESS | 1319 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:2.15 (4.0%) stddev-sans-first:2.03 21:49:17 INFO - PROCESS | 1319 | Values: 51.0 52.0 53.0 53.0 53.0 59.0 55.0 54.0 54.0 54.0 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:1.15 (2.0%) stddev-sans-first:1.22 21:49:17 INFO - PROCESS | 1319 | Values: 59.0 59.0 58.0 58.0 62.0 59.0 58.0 59.0 59.0 59.0 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.00 stddev:2.63 (3.3%) stddev-sans-first:2.65 21:49:17 INFO - PROCESS | 1319 | Values: 79.0 80.0 80.0 86.0 85.0 80.0 80.0 84.0 79.0 80.0 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:129.50 stddev:14.30 (11.0%) stddev-sans-first:15.11 21:49:17 INFO - PROCESS | 1319 | Values: 130.0 129.0 134.0 127.0 129.0 125.0 135.0 124.0 173.0 129.0 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:168.50 stddev:3.56 (2.1%) stddev-sans-first:3.28 21:49:17 INFO - PROCESS | 1319 | Values: 172.0 167.0 166.0 171.0 170.0 163.0 162.0 170.0 165.0 164.0 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:3.27 (4.9%) stddev-sans-first:3.43 21:49:17 INFO - PROCESS | 1319 | Values: 66.0 67.0 66.0 67.0 65.0 67.0 76.0 67.0 68.0 64.0 21:49:17 INFO - PROCESS | 1319 | -------- Summary: end -------- 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | 21:49:17 INFO - PROCESS | 1319 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 21:49:17 INFO - PROCESS | 1319 | 21:49:18 INFO - TEST-INFO | 1319: exit 0 21:49:18 INFO - TEST-OK | kraken | took 62242ms 21:49:18 INFO - SUITE-END | took 1175s 21:49:18 INFO - Completed test suite (00:19:36) 21:49:18 INFO - javascript benchmark 21:49:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7164.953850445713, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3016.683248258933, 3016.969830301696, 3029.742471889889, 3046.1318524220587, 3052.954205686915, 5227.242049902762, 5378.81174158905, 5390.299261096057, 5398.6490878092945, 5482.753276102575, 5325.627206095575, 5351.759170837312, 5365.919511207335, 5405.648632838863, 5453.972730136354, 4839.830605928784, 4934.827281045146, 4946.134426475371, 4995.400551933773, 4997.675151115184, 4257.5742425757335, 4938.38270216223, 4954.2568614707725, 4973.303737476756, 5022.221555658879, 4739.146953548395, 4770.0, 4778.784954677048, 4885.584725298371, 4901.950980490185, 4784.641151913585, 4790.904181916377, 4801.759912004386, 4817.686850354716, 4852.805887764485, 4758.571728544413, 4762.761861906891, 4765.833195838164, 4773.260144677581, 4823.710577365334, 5225.372955245395, 5226.242194881721, 5302.655327403706, 5345.438728933484, 5364.704941228231, 5691.51622112121, 5701.0878259478695, 5716.085426331767, 5717.342505611825, 5749.8275051748515, 5742.942570574282, 5751.137329400582, 5754.741036653319, 5758.0, 5761.855953601152, 5266.183741520071, 5312.0, 5316.175992721096, 5316.255724198615, 5319.840404787863, 5870.090136028923, 5892.616979896293, 5906.143609176645, 5923.7926672566255, 5934.821955341346, 5633.549316054706, 5637.859053523613, 5639.971800140973, 5641.661500309994, 5644.153376993484, 5585.385607583163, 5668.404817494186, 5697.971510142423, 5724.084146536534, 5729.083346664514, 5707.0, 5736.4550367715, 5741.684207368551, 5763.827085187451, 5784.59507834456, 5730.971345143331, 5735.541156707453, 5742.885142297214, 5745.2818397700285, 5754.482096611325, 4305.82776688929, 4335.544767799335, 4370.912581748347, 4390.012247244408, 4449.599536041707, 3874.6900247980093, 3905.1408690088133, 3927.666148377363, 3940.940885886714, 3989.6608788252743, 5477.863053423616, 5483.588730845203, 5506.614536982453, 5506.8347949560775, 5581.358143813513, 5548.0, 5818.981678206297, 5820.82537523875, 5822.184894114827, 5827.4172582741385, 5347.3583170019065, 5468.535174510212, 5496.148097044885, 5513.255710479034, 5524.530414914777, 4954.0, 4965.528274813887, 4969.4782047884455, 4976.278439626234, 5027.673201241908, 6014.0, 6016.217891674054, 6020.789272375446, 6023.307319658208, 6035.245594300713, 5686.175504551899, 5719.599628025998, 5765.308163020464, 5793.94206057934, 5819.82540523785, 5997.370276120944, 6012.939870601413, 6019.187409699634, 6040.879182416415, 6063.514918806397, 5549.278593782782, 5610.18652295423, 5681.2330335404195, 5682.943170568242, 5699.059655156852, 5786.652800831964, 5790.594658373873, 5803.535717142703, 5817.592768506333, 5898.469137777449, 5646.661200327993, 5669.291338582677, 5681.233033540584, 5686.715664216856, 5704.486596206195, 5499.752511137089, 5667.603267771381, 5672.12082127271, 5680.886382272249, 5682.403347648437, 5514.338279406336, 5518.255035570147, 5566.749496272759, 5575.414581468887, 5616.66300022, 5625.128105143709, 5642.23829782974, 5661.433856614471, 5662.858428539154, 5663.830085097454, 5509.696966666872, 5537.861553461195, 5557.777688892399, 5559.1661250811085, 5559.6664200148125], "value": 5292.405410556336, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.0620408927153, 591.5090474905827, 593.1814096546765, 597.9850503737406, 598.338835586677, 41568.37647435291, 42908.785456072714, 42920.0, 45737.54262457375, 45905.31142032864, 44080.77959610205, 44626.107477850426, 44703.0, 44732.329015064715, 44877.32684009735, 8685.218330350268, 8812.339074569401, 8832.955835220815, 8835.116488351177, 8850.468971861677, 8613.95693021534, 8649.69726059588, 8649.783755406133, 8662.26370758483, 8669.783255418633, 8719.302455803552, 8765.474071555695, 8832.735017949472, 8845.380823342368, 8845.469271843709, 8660.17728315809, 8684.56577171139, 8729.0, 8734.868976965286, 8782.0, 8707.521086340248, 8715.0, 8730.257928076122, 8730.476171429735, 8765.649374025032, 41540.1691966162, 41791.37312940308, 41963.37054944178, 41975.0, 42318.57681423208, 3407.3866703993517, 3407.778494397881, 3451.2579795343872, 3483.425234836249, 3529.3117842020815, 30439.23901902448, 30707.38585228283, 30912.69087309143, 32566.6743332566, 33450.83274583636, 3976.1451287973223, 3995.820188091543, 4025.5370632377067, 4170.145120250341, 4194.979025104885, 347192.2640386807, 349496.0, 349642.0, 350939.0, 352324.0, 59563.702181488814, 59844.40155598388, 59905.400945990856, 59952.0, 59987.400125999055, 36763.448548271794, 37285.62714372821, 37790.05524861845, 38870.0, 39198.21603567913, 13732.862671373357, 13909.30453477322, 13931.512397066053, 13956.72086558263, 14009.649758755908, 13136.671583210496, 13234.867651323364, 13236.536721214712, 13250.536231231861, 13280.933595332155, 18704.812951870306, 19129.617407652047, 19132.426027219204, 19161.0, 19227.15456908596, 6873.392468918969, 6939.271376505495, 7029.051078104492, 7043.823904402431, 7094.184168820549, 900.4237288135598, 989.094978095035, 1063.6862125672944, 1105.8949399807007, 1122.5341483284346, 31691.0, 31829.681703183134, 31892.202694932814, 32104.0, 32125.51811722826, 1105.850710154135, 1106.2422240765102, 1113.554578168739, 1140.8288756686563, 1167.270455965022, 15186.392544298325, 16909.7463538047, 16929.576760580836, 16944.40694575684, 17093.0, 508459.0, 519964.0, 521195.0, 522224.0, 523293.0, 55918.16122758162, 56348.0, 56371.0, 56436.0, 56543.0, 1282.4549566434227, 1314.6976195475095, 1317.7891537353978, 1319.8614145514775, 1333.746588148268, 29602.0, 31482.0, 31680.841595792797, 32032.0, 32103.67896321007, 50888.745556271984, 51219.46341609758, 51643.22535162051, 51674.48325516697, 51675.0, 426959.0, 430363.0, 430848.0, 431468.0, 431628.0, 28462.85768571144, 28543.857280713462, 28563.28591785139, 29004.0, 29169.854150729112, 45550.77224613856, 45898.484006666615, 46664.30003549882, 46923.530764693285, 47046.52953470559, 39527.209455811295, 39636.2072758549, 40919.795401022806, 41252.58747412488, 41753.58246417497, 40168.39747403733, 40802.0, 40853.38719919263, 41453.79273103615, 41577.37633935433, 40036.0, 40550.797246014765, 40850.0, 41039.1792164161, 41111.0, 31744.523832142997, 34871.30257394889, 36308.81845590755, 36600.45099323565, 36965.815170923976, 27701.861490693223, 27941.58087628728, 27948.86025569859, 27960.0, 28240.870365185983], "value": 19568.904436688466, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.35920730794203, 388.9980550097249, 397.51304651801547, 401.41994817488734, 422.74234153393655, 14434.855651443482, 18057.0, 18972.525686857836, 19634.90182549087, 19676.803231967675, 18403.0, 18545.907270463664, 18682.0, 19024.2390304388, 19086.141123649435, 5522.22688823563, 5530.806421775239, 5683.886322273552, 5714.914276285838, 5719.113537401709, 5636.943630563704, 5648.293963254593, 5660.3490598581275, 5662.37713851476, 5684.289463817023, 5463.9180412293845, 5579.414161513044, 5628.549716022729, 5631.887362252753, 5633.436656334355, 5385.838424847261, 5593.328800543941, 5628.409017053192, 5629.859253518674, 5641.323041235058, 4999.275105109738, 5021.799128034874, 5032.471590482984, 5035.899282014376, 5043.5965122790085, 21940.0, 22018.339449816373, 22242.332730018126, 22456.775432245795, 22513.0, 2250.831187660932, 2380.321608341614, 2398.292503711392, 2466.7903228225623, 2475.517274131545, 10909.618163364323, 14395.568132956028, 14480.203588802611, 14666.340014699257, 15042.172680502568, 1904.3049287010142, 1917.6260629177316, 1929.2732407812607, 1999.9100040498213, 2004.2984955265686, 80553.75016248507, 81375.59312203401, 81388.0, 82199.5890020552, 83845.58077209575, 10097.596096156218, 10277.486125693686, 10486.528106235237, 10617.84073238902, 10864.456777161111, 10835.0, 11523.827142592867, 15049.473268435551, 15069.09585424878, 15119.244037798066, 7425.997490338735, 7431.182569917305, 7465.253474652492, 7662.885056724153, 7863.252990965963, 7733.41999350051, 7747.1090824555895, 7944.761657150295, 7956.283934445928, 8017.078036025815, 3572.964270357263, 3615.6203598621764, 3690.833912473945, 3726.6646001859963, 3788.753731007476, 1774.7426623139572, 1798.3436045843173, 1806.313600831702, 1833.4316361927845, 1870.9812901870807, 942.2414955960518, 964.508100868548, 970.3498655900563, 1007.5214273220308, 1044.9477526123662, 18372.81627183711, 18857.151428185764, 18867.622647546974, 18883.527911802314, 19025.907150213465, 998.5905778630727, 1010.408910787183, 1020.9540570674337, 1042.8227201375785, 1051.6319288249204, 9727.464989425507, 10526.263161578616, 10577.100946419641, 10603.363798172135, 10712.892871071346, 424628.0, 432483.0, 434929.0, 434975.0, 436316.0, 82445.58777206196, 85669.57165214134, 86035.56982215049, 86184.56907715547, 91153.08846911578, 975.2149519636619, 994.532569692258, 995.2187532786872, 1000.7548150703125, 1003.2826529031777, 15287.381589991464, 15943.36226550925, 16399.180040997664, 16713.247903844112, 16909.23908424099, 38374.80812595919, 39965.200695986496, 41722.37416438695, 42593.0, 43693.78153109214, 54619.0, 54809.0, 54852.72573637106, 56689.43310567007, 60162.39837601568, 8036.799080023046, 8594.0, 8599.785005374666, 8656.394052416523, 8730.075424732531, 11477.713057173303, 13084.803727943898, 13137.934310328386, 13157.868421316047, 13360.93319533396, 11365.204435689422, 11432.542698291974, 11472.598459053894, 12245.938770306448, 12256.0, 11204.495797689287, 11297.604583839855, 11301.15241356918, 11360.715982100513, 11945.940270298594, 11565.0, 11695.181337306307, 11810.40947952616, 11833.763324733629, 12024.458899349374, 8368.24685778283, 8456.0, 8486.702965396182, 8570.871436928575, 8708.17272359125, 9221.492817894812, 11189.552417903193, 11275.887241127812, 11361.886381136414, 11862.347570883685], "value": 8976.114637489385, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.3895763779212, 1502.113752885797, 1599.8800089993247, 1728.2827626534988, 1749.71129763589, 8560.828783424327, 8920.107989201077, 9216.447013179213, 9229.215516681083, 9291.581878815452, 9173.357864949456, 9261.72214833556, 9303.813923721538, 9316.767080822983, 9320.673776417827, 2308.1690591387087, 2346.1582657613776, 2348.236823032513, 2353.6940197774265, 2356.7996720278798, 2311.849729767568, 2318.7449380568123, 2364.432536191319, 2370.466645004869, 2372.193454225563, 2302.8618282902994, 2310.5378924215142, 2315.189683610731, 2364.84628499147, 2365.515069410775, 2275.601769690314, 2280.965785513202, 2299.2642354446584, 2307.1232931486097, 2313.687652166961, 2265.3543740034174, 2267.8979445924974, 2268.2854900706225, 2273.57938781326, 2275.5107651854933, 9012.324075694349, 9038.683646072423, 9063.41087829289, 9074.45553266806, 9104.499252541107, 4948.208286674115, 5105.642605017651, 5133.435322114565, 5133.589312855, 5142.460041695643, 3129.8278594677286, 3160.5417214504, 3248.1717162123746, 3282.113829266085, 3300.818454984975, 1061.6921092883056, 1095.0, 1101.4988180377989, 1117.6255954255334, 1122.405125283601, 12392.938035309857, 12404.56584019564, 12409.193402428813, 12540.247585144829, 12542.122051456401, 4247.723897946624, 4337.327714204303, 4446.887728329018, 4515.2549829277805, 4522.3668686383935, 9745.902540974499, 9753.951230243803, 9775.706728798148, 9781.608735650636, 9785.706428807147, 4949.505049495022, 4956.0, 4962.925556116661, 4983.950160498349, 4994.300797888299, 4117.21772863155, 4247.723897946686, 4533.795979180944, 4616.6075883550275, 4637.698549594265, 3608.260306637133, 3712.1276500022473, 3772.7924964126687, 3783.1084457771112, 3845.788481633481, 1151.5969410706186, 1161.8896204860694, 1174.3599738142561, 1182.5447202826974, 1197.6107764976418, 895.7671005538607, 907.6233363154349, 925.3522534226069, 942.5602590060549, 953.270747877874, 5576.86057848557, 5604.271444712162, 5638.746256418471, 5682.460166284196, 5842.591018628656, 910.2035718746097, 913.7487191022522, 936.1714882329052, 943.3208090175063, 962.7689354554997, 3549.982250088733, 3562.71498280137, 3657.158853463718, 3698.7595806273043, 3751.0, 11011.0, 11295.54817807295, 11371.31772093677, 11376.715582110348, 11379.146564007568, 10479.10927571165, 11027.669169924915, 11128.165387595962, 11243.212975091665, 11355.602553910574, 8227.13615070409, 8450.61972211252, 8455.74632761018, 8458.74623761288, 8465.94175728034, 5712.714364281686, 5822.796202132905, 5865.794697185578, 5961.763170325539, 6081.027035674271, 9798.85301720489, 10297.0, 10407.06336429725, 10410.843837342294, 10516.631917882838, 10430.895691042992, 10644.627438039632, 10654.094401975919, 10668.83996740065, 10700.839487407851, 6991.0, 7250.782476525713, 7602.50583712057, 8046.195380462141, 8150.673973041012, 8378.706745263886, 8700.0, 8767.079456656958, 8768.430052046597, 8785.780355490908, 7652.961735191288, 7658.195889431752, 7841.9215807843475, 7884.172161922916, 7944.245296696805, 7581.0, 7705.807354816175, 7736.4584479085925, 7759.379249659901, 8015.118336983044, 6689.096971908924, 6774.42417394527, 6781.0845535854005, 6781.38967492928, 6797.72809087631, 4838.806447742191, 4843.878903027453, 4861.270809378621, 4924.261360795909, 5076.11168045598, 5047.167217409234, 5049.747512624281, 5076.5431111198695, 5114.46298138705, 5146.099432599355], "value": 4581.03400536653, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.30290104517445, 322.67087570677893, 330.647860029069, 339.2468719442836, 342.30682867193946, 5383.43473935237, 5450.781968721251, 5528.226048353234, 5555.86110347241, 5563.972180139093, 5382.784688612461, 5390.299261096052, 5405.5135037846585, 5431.728413579325, 5466.453354664532, 4193.853215137463, 4194.622483976442, 4198.412222288882, 4214.136102099078, 4221.641160501345, 4018.176273863851, 4205.369194620801, 4212.347086201644, 4228.513720922103, 4229.413969761339, 4198.790060496978, 4220.78896055196, 4221.430106935555, 4222.746635201883, 4226.1547690461875, 4194.874153775391, 4217.873463796091, 4227.091175397273, 4235.280002399584, 4241.703080784347, 3765.3034188675183, 3771.283456143324, 3776.093737503007, 3789.5831458539537, 3791.0, 5097.7196254206, 5270.367555893279, 5303.814366497193, 5309.734513274321, 5323.520883120537, 4862.6839255448285, 4866.537678920497, 4879.707217566957, 4895.2167653175675, 4915.188993816016, 5394.3547218098465, 5674.914876276859, 5692.544596432275, 5697.0, 5718.25662663851, 4053.310937140693, 4073.877783666495, 4077.3272410052305, 4078.857239996586, 4088.0, 5894.17481552583, 5899.115132730082, 5902.6458412495385, 5909.143174239754, 5957.791477298274, 4073.714839961174, 4175.039740859619, 4208.0, 4208.789560521962, 4267.935980960288, 4244.893877653083, 4254.532001479834, 4257.489101307863, 4265.701400901907, 4300.6129448349175, 4833.830815921426, 4848.490908454562, 4875.878103047452, 4876.536729010738, 4895.681780684244, 5485.341758988947, 5712.257406537206, 5716.371199168088, 5739.971300143473, 5804.0, 1469.5885152157414, 1492.835788063312, 1499.9475018374305, 1500.8593468963666, 1501.5345242974713, 917.7155081924625, 952.5665822050951, 956.7942892278194, 961.423146112341, 962.3359881681617, 4835.0, 4851.733154676456, 4900.5099490051425, 4919.524142757158, 4927.384076990376, 5130.486506480597, 5198.32421785173, 5200.413873768462, 5209.270702101709, 5210.843674689765, 4679.368285281512, 4785.401824771903, 4872.0, 4879.0, 4889.339939108175, 2722.931926701848, 2758.6827065264874, 2763.9170824875287, 2765.6681198255937, 2781.664800895541, 5294.92057619136, 5335.039692855324, 5365.570754339721, 5368.5236559946325, 5391.487808658171, 4923.8276660316715, 5192.506711862367, 5220.216967454912, 5241.292425522505, 5284.841454756363, 5304.761285742151, 5325.786968521215, 5331.214837465365, 5335.519803217807, 5346.433711818271, 5123.3339665843205, 5137.717425541631, 5159.587233021424, 5168.276441298146, 5173.301604283373, 5129.7691603877165, 5432.483914028161, 5840.299164100165, 5876.059830427112, 5876.764929402776, 6147.784827531015, 6166.969165154145, 6172.753089876534, 6179.752809887734, 6196.349383314687, 3955.960440395559, 3993.201359728008, 4039.93940090893, 4041.81811818463, 4210.536840947555, 5755.36690964002, 5783.16144159103, 5814.709264536841, 5829.183914251923, 5830.4461076197695, 5553.444655534414, 5670.121131224667, 5673.517750991212, 5683.8863222736145, 5700.600957933071, 5588.105903055492, 5629.718514074198, 5635.971820140873, 5650.954573403934, 5654.773809047592, 5604.187392828098, 5615.904898544744, 5647.350554686263, 5647.915281270702, 5685.857853553694, 5571.916421253603, 5655.717214139194, 5676.0, 5723.771049157987, 5730.71346432685, 5521.613487055867, 5606.943930560642, 5631.436856314336, 5638.915416268841, 5642.492175704042], "value": 4225.68668346866, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.3363039633933, 730.3244498838573, 770.310572038026, 797.86436305828, 820.6020080261075, 15403.614909627266, 16000.359985600577, 16043.117628530426, 16049.117298548575, 16058.678826423464, 14971.251437428113, 15041.924790376033, 15128.621784455367, 15135.318910649019, 15139.92430037851, 653.9117219175422, 677.678102901123, 769.503670132764, 775.6354513378703, 796.0606484348466, 796.4663675337538, 796.9880451793227, 800.3757069485811, 802.8233788566506, 803.4135081390589, 839.5256679975794, 847.0936098374741, 849.4860609331358, 854.0562678240548, 854.628236717027, 839.1524560194248, 839.3327304792705, 840.3277378097528, 841.6044459104211, 841.6128580852815, 613.8035828534871, 615.3692465223137, 617.8640699046202, 619.7582942652369, 624.6439529468205, 14737.0, 14737.557873263819, 14739.926300368537, 14741.262936853114, 14760.557183284518, 15152.393904243818, 15394.15332156731, 15451.381944722198, 15535.689286214325, 15546.455874044354, 11289.15331350152, 11307.265027773168, 11309.09527237819, 11358.091352691765, 12030.69923251917, 3774.45270435788, 3800.5629352624524, 3889.358255887775, 3904.5900180480926, 4021.2560676274984, 71750.28249717488, 73597.63201184013, 73639.63180184118, 74322.99999999946, 76032.61983690101, 11573.0, 11724.765504690029, 11761.823572646417, 11789.056875449944, 12071.517139314328, 22781.658275125887, 22810.543789124124, 22820.543589128123, 22824.087036518355, 22862.0, 8388.748337549883, 8417.831643367099, 8586.914130858737, 8951.507667078373, 8963.731088067369, 4670.486246512881, 4736.905261894743, 4869.196582563837, 4957.553820156131, 4987.501249874984, 3225.9838700806813, 3322.966770332314, 3327.683870032343, 3329.234276116458, 3329.550510681027, 558.522463293886, 561.7640590951728, 565.6040771459994, 572.0189874365483, 572.8940146072906, 527.9736013199401, 592.552622769806, 632.5445679111033, 656.2125449460666, 734.7685479074074, 9768.853467197998, 10034.749131271778, 10087.49562521871, 10142.949285253526, 10271.0, 639.7345101782801, 653.3303364051885, 658.8912829383098, 681.4922882452505, 723.1972510513326, 4581.496035436166, 4706.62347012245, 4773.546513081252, 4904.852854414374, 4991.251312303111, 113654.0, 127159.0, 127442.0, 130046.0, 130583.0, 64016.0, 90929.0, 97415.51292243494, 105548.0, 105757.47121264499, 80247.59876200581, 81557.9999999988, 81661.0, 85529.57235213784, 98362.50818746003, 9466.2427005838, 9893.406395616286, 9912.15746661542, 9929.503524823585, 9989.800203995734, 48715.756421217666, 49507.75246123746, 50648.240276396624, 51687.74156129195, 54037.459625403244, 68667.65666171638, 71968.0, 75101.62449187718, 76788.61605691936, 77579.2242077572, 10947.0, 11279.0, 12879.420426080662, 13186.406611702305, 13309.800352994907, 12078.154529182873, 14089.788653170006, 14394.35225414838, 14531.564053078424, 15421.691566168838, 13804.0, 14258.572242832732, 14584.1978691173, 14685.0, 15082.095074295577, 13329.933350333575, 13572.457101715821, 13824.0, 14135.64660883445, 14168.520508911106, 13750.312484375541, 14096.08375455592, 14144.222067785959, 14208.28958552089, 14666.77999829982, 10886.510107045044, 11229.101671866069, 11402.48688808989, 11510.654680359603, 11547.018503427304, 10318.43248621333, 10634.41510716887, 10667.839982400425, 10785.245032847626, 11634.76730465403], "value": 7517.3933760080645, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1505.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 113.0, 112.0, 111.0, 111.0, 110.0, 110.0, 111.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 121.0, 178.0, 123.0, 122.0, 125.0, 123.0, 146.0, 121.0], "value": 133.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 167.0, 175.0, 166.0, 163.0, 163.0, 163.0, 164.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 117.0, 76.0, 78.0, 76.0, 77.0, 97.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 113.0, 84.0, 83.0, 82.0, 113.0, 83.0, 82.0, 116.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 120.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 147.0, 147.0, 147.0, 146.0, 148.0, 147.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 53.0, 53.0, 53.0, 59.0, 55.0, 54.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 58.0, 62.0, 59.0, 58.0, 59.0, 59.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 86.0, 85.0, 80.0, 80.0, 84.0, 79.0, 80.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 134.0, 127.0, 129.0, 125.0, 135.0, 124.0, 173.0, 129.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 167.0, 166.0, 171.0, 170.0, 163.0, 162.0, 170.0, 165.0, 164.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 65.0, 67.0, 76.0, 67.0, 68.0, 64.0], "value": 67.3, "unit": "score"}]}]} 21:49:18 INFO - Return code: 0 21:49:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:49:18 ERROR - # TBPL SUCCESS # 21:49:18 INFO - Running post-action listener: _resource_record_post_action 21:49:18 INFO - [mozharness: 2016-09-29 04:49:18.806113Z] Finished run-tests step (success) 21:49:18 INFO - Running post-run listener: _resource_record_post_run 21:49:18 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393895936; Read time: 12; Write time: 266284 21:49:18 INFO - TinderboxPrint: CPU usage
13.4% 21:49:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:49:18 INFO - TinderboxPrint: I/O write bytes / time
393,895,936 / 266,284 21:49:18 INFO - TinderboxPrint: CPU idle
8,234.8 (86.5%) 21:49:18 INFO - TinderboxPrint: CPU user
1,217.3 (12.8%) 21:49:18 INFO - TinderboxPrint: Swap in / out
0 / 0 21:49:18 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103858176; Read time: 0; Write time: 95512 21:49:18 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 290037760; Read time: 0; Write time: 170772 21:49:19 INFO - Running post-run listener: _upload_blobber_files 21:49:19 INFO - Blob upload gear active. 21:49:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:49:19 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 21:49:19 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:49:19 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:49:19 INFO - (blobuploader) - INFO - Open directory for files ... 21:49:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:49:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:49:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:20 INFO - (blobuploader) - INFO - Done attempting. 21:49:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:49:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:49:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:21 INFO - (blobuploader) - INFO - Done attempting. 21:49:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:49:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:49:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:24 INFO - (blobuploader) - INFO - Done attempting. 21:49:24 INFO - (blobuploader) - INFO - Iteration through files over. 21:49:24 INFO - Return code: 0 21:49:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:49:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:49:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9d8555a0f743abe131f0bf1b5d21d45dca5a5bf8e72d71a4c9157c7038d33ebb8cb1456a22e5ba3932c708cb62b5aafa568811abb2a93051382f905822fbd18d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5b476ca6c42c09ffc8f5074f76b8fcfd08d7ee519a3d22bd6ab9dfb494c95b600f79332ac82f9105608df43763ada4f795104d6220a3f4fbf7b48a86d5866485", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7974d9e01071d5100de158c62e617f711fce96258abdc4be3390b69db4b55182e34e21bded224bb87d6c112a17335d54a7f5debdb2cbce0e6eb7f0512a59d733"} 21:49:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:49:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:49:24 INFO - Contents: 21:49:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9d8555a0f743abe131f0bf1b5d21d45dca5a5bf8e72d71a4c9157c7038d33ebb8cb1456a22e5ba3932c708cb62b5aafa568811abb2a93051382f905822fbd18d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5b476ca6c42c09ffc8f5074f76b8fcfd08d7ee519a3d22bd6ab9dfb494c95b600f79332ac82f9105608df43763ada4f795104d6220a3f4fbf7b48a86d5866485", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7974d9e01071d5100de158c62e617f711fce96258abdc4be3390b69db4b55182e34e21bded224bb87d6c112a17335d54a7f5debdb2cbce0e6eb7f0512a59d733"} 21:49:24 INFO - Running post-run listener: copy_logs_to_upload_dir 21:49:24 INFO - Copying logs to upload dir... 21:49:24 INFO - mkdir: /builds/slave/test/build/upload/logs 21:49:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.861023 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-09-28 21:49:24.562997) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 21:49:24.569153) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9d8555a0f743abe131f0bf1b5d21d45dca5a5bf8e72d71a4c9157c7038d33ebb8cb1456a22e5ba3932c708cb62b5aafa568811abb2a93051382f905822fbd18d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5b476ca6c42c09ffc8f5074f76b8fcfd08d7ee519a3d22bd6ab9dfb494c95b600f79332ac82f9105608df43763ada4f795104d6220a3f4fbf7b48a86d5866485", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7974d9e01071d5100de158c62e617f711fce96258abdc4be3390b69db4b55182e34e21bded224bb87d6c112a17335d54a7f5debdb2cbce0e6eb7f0512a59d733"} build_url:https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/UbbFHxVhTzeWVSrSrcW97Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9d8555a0f743abe131f0bf1b5d21d45dca5a5bf8e72d71a4c9157c7038d33ebb8cb1456a22e5ba3932c708cb62b5aafa568811abb2a93051382f905822fbd18d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5b476ca6c42c09ffc8f5074f76b8fcfd08d7ee519a3d22bd6ab9dfb494c95b600f79332ac82f9105608df43763ada4f795104d6220a3f4fbf7b48a86d5866485", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7974d9e01071d5100de158c62e617f711fce96258abdc4be3390b69db4b55182e34e21bded224bb87d6c112a17335d54a7f5debdb2cbce0e6eb7f0512a59d733"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 21:49:24.599668) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:49:24.600573) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1475123326.894826-138004400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:49:24.685577) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 21:49:24.686373) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 21:49:24.687012) ========= ========= Total master_lag: 0.18 =========