builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1475177557.38 results: success (0) buildid: 20160929093019 builduid: 6c2bdf1702bd45df882f45a5da334c40 revision: f21ffbf119bd6d7084309123be42f97743f1f7e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 12:32:37.379391) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 12:32:37.379948) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 12:32:37.380295) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 12:32:37.395409) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:32:37.395880) ========= 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=920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-29 12:32:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-09-29 12:32:37 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094434 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:32:37.504716) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:32:37.505038) ========= 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=920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016214 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:32:37.554676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 12:32:37.555053) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev f21ffbf119bd6d7084309123be42f97743f1f7e5 --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 f21ffbf119bd6d7084309123be42f97743f1f7e5 --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=920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-29 12:32:37,950 truncating revision to first 12 chars 2016-09-29 12:32:37,950 Setting DEBUG logging. 2016-09-29 12:32:37,950 attempt 1/10 2016-09-29 12:32:37,950 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/f21ffbf119bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 12:32:38,912 unpacking tar archive at: autoland-f21ffbf119bd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.274704 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 12:32:38.842958) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 12:32:38.843274) ========= script_repo_revision: f21ffbf119bd6d7084309123be42f97743f1f7e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 12:32:38.843655) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 12:32:38.843917) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 12:32:38.852726) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-29 12:32:38.853120) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:32:39 INFO - MultiFileLogger online at 20160929 12:32:39 in /builds/slave/test 12:32:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 12:32:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:32:39 INFO - {'append_to_log': False, 12:32:39 INFO - 'base_work_dir': '/builds/slave/test', 12:32:39 INFO - 'blob_upload_branch': 'Autoland', 12:32:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:32:39 INFO - 'branch': 'Autoland', 12:32:39 INFO - 'buildbot_json_path': 'buildprops.json', 12:32:39 INFO - 'config_files': ('talos/linux_config.py',), 12:32:39 INFO - 'default_actions': ('clobber', 12:32:39 INFO - 'read-buildbot-config', 12:32:39 INFO - 'download-and-extract', 12:32:39 INFO - 'populate-webroot', 12:32:39 INFO - 'create-virtualenv', 12:32:39 INFO - 'install', 12:32:39 INFO - 'run-tests'), 12:32:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:32:39 INFO - 'download_minidump_stackwalk': True, 12:32:39 INFO - 'download_symbols': 'ondemand', 12:32:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:32:39 INFO - 'tooltool.py': '/tools/tooltool.py', 12:32:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:32:39 INFO - '/tools/misc-python/virtualenv.py')}, 12:32:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:32:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:32:39 INFO - 'installer_path': 'installer.exe', 12:32:39 INFO - 'log_level': 'info', 12:32:39 INFO - 'log_name': 'talos', 12:32:39 INFO - 'log_to_console': True, 12:32:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:32:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:32:39 INFO - 'opt_config_files': (), 12:32:39 INFO - 'pip_index': False, 12:32:39 INFO - 'sps_profile': False, 12:32:39 INFO - 'sps_profile_interval': 0, 12:32:39 INFO - 'suite': 'dromaeojs', 12:32:39 INFO - 'system_bits': '32', 12:32:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:32:39 INFO - 'title': 'talos-linux64-ix-053', 12:32:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:32:39 INFO - 'use_talos_json': True, 12:32:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:32:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:32:39 INFO - 'work_dir': 'build'} 12:32:39 INFO - [mozharness: 2016-09-29 19:32:39.338528Z] Running clobber step. 12:32:39 INFO - Running pre-action listener: _resource_record_pre_action 12:32:39 INFO - Running main action method: clobber 12:32:39 INFO - rmtree: /builds/slave/test/build 12:32:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:32:39 INFO - Running post-action listener: _resource_record_post_action 12:32:39 INFO - [mozharness: 2016-09-29 19:32:39.803576Z] Finished clobber step (success) 12:32:39 INFO - [mozharness: 2016-09-29 19:32:39.803676Z] Running read-buildbot-config step. 12:32:39 INFO - Running pre-action listener: _resource_record_pre_action 12:32:39 INFO - Running main action method: read_buildbot_config 12:32:39 INFO - Using buildbot properties: 12:32:39 INFO - { 12:32:39 INFO - "project": "", 12:32:39 INFO - "product": "firefox", 12:32:39 INFO - "script_repo_revision": "production", 12:32:39 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 12:32:39 INFO - "repository": "", 12:32:39 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 12:32:39 INFO - "buildid": "20160929093019", 12:32:39 INFO - "pgo_build": "True", 12:32:39 INFO - "basedir": "/builds/slave/test", 12:32:39 INFO - "buildnumber": 270, 12:32:39 INFO - "slavename": "talos-linux64-ix-053", 12:32:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:32:39 INFO - "platform": "ubuntu64_hw", 12:32:39 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 12:32:39 INFO - "branch": "autoland", 12:32:39 INFO - "repo_path": "integration/autoland", 12:32:39 INFO - "revision": "f21ffbf119bd6d7084309123be42f97743f1f7e5", 12:32:39 INFO - "stage_platform": "linux64-pgo", 12:32:39 INFO - "builduid": "6c2bdf1702bd45df882f45a5da334c40", 12:32:39 INFO - "slavebuilddir": "test" 12:32:39 INFO - } 12:32:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:32:39 INFO - Running post-action listener: _resource_record_post_action 12:32:39 INFO - [mozharness: 2016-09-29 19:32:39.806100Z] Finished read-buildbot-config step (success) 12:32:39 INFO - [mozharness: 2016-09-29 19:32:39.806189Z] Running download-and-extract step. 12:32:39 INFO - Running pre-action listener: _resource_record_pre_action 12:32:39 INFO - Running main action method: download_and_extract 12:32:39 INFO - mkdir: /builds/slave/test/build/tests 12:32:39 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')]} 12:32:39 INFO - trying https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:32:39 INFO - Downloading https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/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 12:32:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/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 12:32:40 INFO - Downloaded 1361 bytes. 12:32:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:32:40 INFO - Using the following test package requirements: 12:32:40 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:32:40 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:32:40 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:32:40 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:40 INFO - u'jsshell-linux-x86_64.zip'], 12:32:40 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:32:40 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:32:40 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:32:40 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:32:40 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:32:40 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:32:40 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:32:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:32:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:32:40 INFO - Fetch https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:32:40 INFO - Http code: 200 12:32:40 INFO - Content-Encoding: None 12:32:40 INFO - Content-Type: application/zip 12:32:40 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 12:32:40 INFO - x-amz-cf-id: 9u1RUTmUEtbcKDrvpR4J6KAdpoKLxez85s4K_6WogWxe6O5jYPlhGA== 12:32:40 INFO - x-amz-version-id: mYxwdnwBjAC.bGLQemXK21FbAbZRWp6W 12:32:40 INFO - x-cache: Hit from cloudfront 12:32:41 INFO - Expected file size: 21988666 12:32:41 INFO - Obtained file size: 21988666 12:32:45 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 12:32:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:32:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:32:45 INFO - Fetch https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:32:45 INFO - Http code: 200 12:32:45 INFO - Content-Encoding: None 12:32:45 INFO - Content-Type: application/zip 12:32:45 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 12:32:45 INFO - x-amz-cf-id: XeMB4lBCB4DHnPvVC1fV6n2cotjJeuNsiQsHcEeiSO0NgTIyIpk9dQ== 12:32:45 INFO - x-amz-version-id: mYxwdnwBjAC.bGLQemXK21FbAbZRWp6W 12:32:45 INFO - x-cache: Hit from cloudfront 12:32:46 INFO - Expected file size: 21988666 12:32:46 INFO - Obtained file size: 21988666 12:32:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:32:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:32:50 INFO - Fetch https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:32:51 INFO - Http code: 200 12:32:51 INFO - Content-Encoding: None 12:32:51 INFO - Content-Type: application/zip 12:32:51 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 12:32:51 INFO - x-amz-cf-id: Z3c33Zw-EtrJEcSk6BQyF8_zO8jbcBAWJGKKR9sZ-Xd-HkF2sgGHUg== 12:32:51 INFO - x-amz-version-id: pNsSW5b0G32A0.E7SuTH4pbuC3rVnU5C 12:32:51 INFO - x-cache: Hit from cloudfront 12:32:51 INFO - Expected file size: 14414067 12:32:51 INFO - Obtained file size: 14414067 12:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:51 INFO - trying https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:32:51 INFO - Downloading https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/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 12:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/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 12:32:52 INFO - Downloaded 59748949 bytes. 12:32:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:32:52 INFO - mkdir: /builds/slave/test/properties 12:32:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:32:52 INFO - Writing to file /builds/slave/test/properties/build_url 12:32:52 INFO - Contents: 12:32:52 INFO - build_url:https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:32:53 INFO - Running post-action listener: _resource_record_post_action 12:32:53 INFO - Running post-action listener: set_extra_try_arguments 12:32:53 INFO - [mozharness: 2016-09-29 19:32:53.490244Z] Finished download-and-extract step (success) 12:32:53 INFO - [mozharness: 2016-09-29 19:32:53.490472Z] Running populate-webroot step. 12:32:53 INFO - Running pre-action listener: _resource_record_pre_action 12:32:53 INFO - Running main action method: populate_webroot 12:32:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:32:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:32:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:32:53 INFO - '--tppagecycles', 12:32:53 INFO - '7'], 12:32:53 INFO - 'tests': ['tsvgm']}}, 12:32:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:32:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:32:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:32:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:32:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:32:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:32:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:32:53 INFO - 'talos_options': ['--disable-e10s'], 12:32:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:32:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:32:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:32:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:32:53 INFO - 'talos_options': ['--disable-e10s'], 12:32:53 INFO - 'tests': ['damp', 'tps']}, 12:32:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:32:53 INFO - 'tests': ['damp', 'tps']}, 12:32:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:32:53 INFO - 'tests': ['dromaeo_dom']}, 12:32:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:32:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:32:53 INFO - 'tests': ['basic_compositor_video']}, 12:32:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:32:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:32:53 INFO - 'tests': ['a11yr', 12:32:53 INFO - 'ts_paint', 12:32:53 INFO - 'tpaint', 12:32:53 INFO - 'sessionrestore', 12:32:53 INFO - 'sessionrestore_no_auto_restore', 12:32:53 INFO - 'tabpaint']}, 12:32:53 INFO - 'other-e10s': {'tests': ['a11yr', 12:32:53 INFO - 'ts_paint', 12:32:53 INFO - 'tpaint', 12:32:53 INFO - 'sessionrestore', 12:32:53 INFO - 'sessionrestore_no_auto_restore', 12:32:53 INFO - 'tabpaint']}, 12:32:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:32:53 INFO - 'ts_paint', 12:32:53 INFO - 'tpaint', 12:32:53 INFO - 'sessionrestore', 12:32:53 INFO - 'sessionrestore_no_auto_restore', 12:32:53 INFO - 'tabpaint']}, 12:32:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:32:53 INFO - 'ts_paint', 12:32:53 INFO - 'tpaint', 12:32:53 INFO - 'sessionrestore', 12:32:53 INFO - 'sessionrestore_no_auto_restore', 12:32:53 INFO - 'tabpaint']}, 12:32:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:32:53 INFO - 'tests': ['a11yr', 12:32:53 INFO - 'ts_paint', 12:32:53 INFO - 'tpaint', 12:32:53 INFO - 'sessionrestore', 12:32:53 INFO - 'sessionrestore_no_auto_restore', 12:32:53 INFO - 'tabpaint']}, 12:32:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:32:53 INFO - 'tests': ['a11yr', 12:32:53 INFO - 'ts_paint', 12:32:53 INFO - 'tpaint', 12:32:53 INFO - 'sessionrestore', 12:32:53 INFO - 'sessionrestore_no_auto_restore', 12:32:53 INFO - 'tabpaint']}, 12:32:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:32:53 INFO - 'tests': ['tsvgx', 12:32:53 INFO - 'tsvgr_opacity', 12:32:53 INFO - 'tart', 12:32:53 INFO - 'tscrollx', 12:32:53 INFO - 'cart']}, 12:32:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:32:53 INFO - 'tsvgr_opacity', 12:32:53 INFO - 'tart', 12:32:53 INFO - 'tscrollx', 12:32:53 INFO - 'cart']}, 12:32:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:32:53 INFO - 'talos_options': ['--disable-e10s'], 12:32:53 INFO - 'tests': ['tp5o']}, 12:32:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:32:53 INFO - 'tests': ['tp5o']}, 12:32:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:32:53 INFO - 'talos_options': ['--disable-e10s', 12:32:53 INFO - '--xperf_path', 12:32:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:32:53 INFO - 'tests': ['tp5n']}, 12:32:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:32:53 INFO - 'talos_options': ['--xperf_path', 12:32:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:32:53 INFO - 'tests': ['tp5n']}}, 12:32:53 INFO - 'talos.zip': {'path': '', 12:32:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:32:53 INFO - Running post-action listener: _resource_record_post_action 12:32:53 INFO - [mozharness: 2016-09-29 19:32:53.506455Z] Finished populate-webroot step (success) 12:32:53 INFO - [mozharness: 2016-09-29 19:32:53.506544Z] Running create-virtualenv step. 12:32:53 INFO - Running pre-action listener: _resource_record_pre_action 12:32:53 INFO - Running main action method: create_virtualenv 12:32:53 INFO - Creating virtualenv /builds/slave/test/build/venv 12:32:53 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 12:32:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:32:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:32:53 INFO - Using real prefix '/usr' 12:32:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:32:54 INFO - Installing distribute.............................................................................................................................................................................................done. 12:32:56 INFO - Installing pip.................done. 12:32:56 INFO - Return code: 0 12:32:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:32:56 INFO - Reading from file tmpfile_stdout 12:32:56 INFO - Output received: 12:32:56 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) 12:32:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80af5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, '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 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, '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': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', '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 12:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:32:56 INFO - Using env: {'DISPLAY': ':0', 12:32:56 INFO - 'HOME': '/home/cltbld', 12:32:56 INFO - 'LANG': 'en_US.UTF-8', 12:32:56 INFO - 'LANGUAGE': 'en_US:en', 12:32:56 INFO - 'LOGNAME': 'cltbld', 12:32:56 INFO - 'MAIL': '/var/mail/cltbld', 12:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:56 INFO - 'MOZ_NO_REMOTE': '1', 12:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:56 INFO - 'NO_EM_RESTART': '1', 12:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:56 INFO - 'PWD': '/builds/slave/test', 12:32:56 INFO - 'SHELL': '/bin/bash', 12:32:56 INFO - 'SHLVL': '1', 12:32:56 INFO - 'TERM': 'linux', 12:32:56 INFO - 'TMOUT': '86400', 12:32:56 INFO - 'USER': 'cltbld', 12:32:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', 12:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:56 INFO - '_': '/tools/buildbot/bin/python'} 12:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:56 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 12:32:56 INFO - Cleaning up... 12:32:56 INFO - Return code: 0 12:32:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fde80af5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, '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 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, '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': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', '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 12:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:32:56 INFO - Using env: {'DISPLAY': ':0', 12:32:56 INFO - 'HOME': '/home/cltbld', 12:32:56 INFO - 'LANG': 'en_US.UTF-8', 12:32:56 INFO - 'LANGUAGE': 'en_US:en', 12:32:56 INFO - 'LOGNAME': 'cltbld', 12:32:56 INFO - 'MAIL': '/var/mail/cltbld', 12:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:56 INFO - 'MOZ_NO_REMOTE': '1', 12:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:56 INFO - 'NO_EM_RESTART': '1', 12:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:56 INFO - 'PWD': '/builds/slave/test', 12:32:56 INFO - 'SHELL': '/bin/bash', 12:32:56 INFO - 'SHLVL': '1', 12:32:56 INFO - 'TERM': 'linux', 12:32:56 INFO - 'TMOUT': '86400', 12:32:56 INFO - 'USER': 'cltbld', 12:32:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', 12:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:56 INFO - '_': '/tools/buildbot/bin/python'} 12:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:56 INFO - Downloading/unpacking psutil>=3.1.1 12:32:56 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 12:32:56 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 12:32:56 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 12:32:56 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 12:32:56 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 12:32:56 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 12:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:32:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:32:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:32:58 INFO - Installing collected packages: psutil 12:32:58 INFO - Running setup.py install for psutil 12:32:58 INFO - building 'psutil._psutil_linux' extension 12:32:58 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 12:32:59 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 12:32:59 INFO - building 'psutil._psutil_posix' extension 12:32:59 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 12:32:59 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 12:32:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:32:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:32:59 INFO - Successfully installed psutil 12:32:59 INFO - Cleaning up... 12:32:59 INFO - Return code: 0 12:32:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:32:59 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')]} 12:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:59 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')]} 12:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:59 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 0x7fde80af5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, '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 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, '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': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', '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 12:32:59 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 12:32:59 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 12:32:59 INFO - Using env: {'DISPLAY': ':0', 12:32:59 INFO - 'HOME': '/home/cltbld', 12:32:59 INFO - 'LANG': 'en_US.UTF-8', 12:32:59 INFO - 'LANGUAGE': 'en_US:en', 12:32:59 INFO - 'LOGNAME': 'cltbld', 12:32:59 INFO - 'MAIL': '/var/mail/cltbld', 12:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:59 INFO - 'MOZ_NO_REMOTE': '1', 12:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:59 INFO - 'NO_EM_RESTART': '1', 12:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:59 INFO - 'PWD': '/builds/slave/test', 12:32:59 INFO - 'SHELL': '/bin/bash', 12:32:59 INFO - 'SHLVL': '1', 12:32:59 INFO - 'TERM': 'linux', 12:32:59 INFO - 'TMOUT': '86400', 12:32:59 INFO - 'USER': 'cltbld', 12:32:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', 12:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:59 INFO - '_': '/tools/buildbot/bin/python'} 12:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:32:59 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 12:32:59 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 12:32:59 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 12:32:59 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 12:32:59 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 12:32:59 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 12:33:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:33:01 INFO - Installing collected packages: mozsystemmonitor 12:33:01 INFO - Running setup.py install for mozsystemmonitor 12:33:01 INFO - Successfully installed mozsystemmonitor 12:33:01 INFO - Cleaning up... 12:33:01 INFO - Return code: 0 12:33:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:33: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')]} 12:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33: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')]} 12:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:01 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 0x7fde80af5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, '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 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, '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': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', '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 12:33:01 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 12:33:01 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 12:33:01 INFO - Using env: {'DISPLAY': ':0', 12:33:01 INFO - 'HOME': '/home/cltbld', 12:33:01 INFO - 'LANG': 'en_US.UTF-8', 12:33:01 INFO - 'LANGUAGE': 'en_US:en', 12:33:01 INFO - 'LOGNAME': 'cltbld', 12:33:01 INFO - 'MAIL': '/var/mail/cltbld', 12:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:01 INFO - 'MOZ_NO_REMOTE': '1', 12:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:01 INFO - 'NO_EM_RESTART': '1', 12:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:01 INFO - 'PWD': '/builds/slave/test', 12:33:01 INFO - 'SHELL': '/bin/bash', 12:33:01 INFO - 'SHLVL': '1', 12:33:01 INFO - 'TERM': 'linux', 12:33:01 INFO - 'TMOUT': '86400', 12:33:01 INFO - 'USER': 'cltbld', 12:33:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', 12:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:01 INFO - '_': '/tools/buildbot/bin/python'} 12:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:01 INFO - Downloading/unpacking jsonschema==2.5.1 12:33:01 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 12:33:01 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 12:33:01 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 12:33:01 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 12:33:01 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 12:33:01 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 12:33:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:33:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:33:03 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 12:33:03 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 12:33:03 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 12:33:03 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 12:33:03 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 12:33:03 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 12:33:03 INFO - Downloading functools32-3.2.3-2.tar.gz 12:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:33:04 INFO - warning: no files found matching '*.txt' 12:33:04 INFO - no previously-included directories found matching 'build' 12:33:04 INFO - no previously-included directories found matching 'dist' 12:33:04 INFO - no previously-included directories found matching '.git*' 12:33:04 INFO - Installing collected packages: jsonschema, functools32 12:33:04 INFO - Running setup.py install for functools32 12:33:04 INFO - warning: no files found matching '*.txt' 12:33:04 INFO - no previously-included directories found matching 'build' 12:33:04 INFO - no previously-included directories found matching 'dist' 12:33:04 INFO - no previously-included directories found matching '.git*' 12:33:04 INFO - Successfully installed jsonschema functools32 12:33:04 INFO - Cleaning up... 12:33:04 INFO - Return code: 0 12:33:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:33:04 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')]} 12:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:04 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')]} 12:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:04 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 0x7fde80af5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, '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 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, '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': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', '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 12:33:04 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 12:33:04 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 12:33:04 INFO - Using env: {'DISPLAY': ':0', 12:33:04 INFO - 'HOME': '/home/cltbld', 12:33:04 INFO - 'LANG': 'en_US.UTF-8', 12:33:04 INFO - 'LANGUAGE': 'en_US:en', 12:33:04 INFO - 'LOGNAME': 'cltbld', 12:33:04 INFO - 'MAIL': '/var/mail/cltbld', 12:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:04 INFO - 'MOZ_NO_REMOTE': '1', 12:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:04 INFO - 'NO_EM_RESTART': '1', 12:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:04 INFO - 'PWD': '/builds/slave/test', 12:33:04 INFO - 'SHELL': '/bin/bash', 12:33:04 INFO - 'SHLVL': '1', 12:33:04 INFO - 'TERM': 'linux', 12:33:04 INFO - 'TMOUT': '86400', 12:33:04 INFO - 'USER': 'cltbld', 12:33:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', 12:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:04 INFO - '_': '/tools/buildbot/bin/python'} 12:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:33:04 INFO - Cleaning up... 12:33:04 INFO - Return code: 0 12:33:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:33:04 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')]} 12:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:04 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')]} 12:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:04 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 0x7fde80af5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, '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 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, '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': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', '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 12:33:04 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 12:33:04 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 12:33:04 INFO - Using env: {'DISPLAY': ':0', 12:33:04 INFO - 'HOME': '/home/cltbld', 12:33:04 INFO - 'LANG': 'en_US.UTF-8', 12:33:04 INFO - 'LANGUAGE': 'en_US:en', 12:33:04 INFO - 'LOGNAME': 'cltbld', 12:33:04 INFO - 'MAIL': '/var/mail/cltbld', 12:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:04 INFO - 'MOZ_NO_REMOTE': '1', 12:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:04 INFO - 'NO_EM_RESTART': '1', 12:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:04 INFO - 'PWD': '/builds/slave/test', 12:33:04 INFO - 'SHELL': '/bin/bash', 12:33:04 INFO - 'SHLVL': '1', 12:33:04 INFO - 'TERM': 'linux', 12:33:04 INFO - 'TMOUT': '86400', 12:33:04 INFO - 'USER': 'cltbld', 12:33:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', 12:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:04 INFO - '_': '/tools/buildbot/bin/python'} 12:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:04 INFO - Downloading/unpacking blobuploader==1.2.4 12:33:04 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 12:33:04 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 12:33:04 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 12:33:04 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 12:33:04 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 12:33:04 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 12:33:06 INFO - Downloading blobuploader-1.2.4.tar.gz 12:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:33:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:33: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 12:33: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 12:33: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 12:33: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 12:33: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 12:33: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 12:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:33:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:33:07 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 12:33:07 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 12:33:07 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 12:33:07 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 12:33:07 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 12:33:07 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 12:33:07 INFO - Downloading docopt-0.6.1.tar.gz 12:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:33:07 INFO - Installing collected packages: blobuploader, requests, docopt 12:33:07 INFO - Running setup.py install for blobuploader 12:33:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:33:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:33:07 INFO - Running setup.py install for requests 12:33:07 INFO - Running setup.py install for docopt 12:33:07 INFO - Successfully installed blobuploader requests docopt 12:33:07 INFO - Cleaning up... 12:33:07 INFO - Return code: 0 12:33:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:33:07 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')]} 12:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:07 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')]} 12:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:07 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 0x7fde80af5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, '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 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, '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': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', '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 12:33:07 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 12:33:07 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 12:33:07 INFO - Using env: {'DISPLAY': ':0', 12:33:07 INFO - 'HOME': '/home/cltbld', 12:33:07 INFO - 'LANG': 'en_US.UTF-8', 12:33:07 INFO - 'LANGUAGE': 'en_US:en', 12:33:07 INFO - 'LOGNAME': 'cltbld', 12:33:07 INFO - 'MAIL': '/var/mail/cltbld', 12:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:07 INFO - 'MOZ_NO_REMOTE': '1', 12:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:07 INFO - 'NO_EM_RESTART': '1', 12:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:07 INFO - 'PWD': '/builds/slave/test', 12:33:07 INFO - 'SHELL': '/bin/bash', 12:33:07 INFO - 'SHLVL': '1', 12:33:07 INFO - 'TERM': 'linux', 12:33:07 INFO - 'TMOUT': '86400', 12:33:07 INFO - 'USER': 'cltbld', 12:33:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', 12:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:07 INFO - '_': '/tools/buildbot/bin/python'} 12:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:33:08 INFO - Running setup.py (path:/tmp/pip-s82ucQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:33:08 INFO - Running setup.py (path:/tmp/pip-jckXkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:33:08 INFO - Running setup.py (path:/tmp/pip-hkugIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:33:08 INFO - Running setup.py (path:/tmp/pip-ECKtlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:33:08 INFO - Running setup.py (path:/tmp/pip-WkFics-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:33:08 INFO - Running setup.py (path:/tmp/pip-i_sBcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:33:08 INFO - Running setup.py (path:/tmp/pip-FHp6SE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:33:08 INFO - Running setup.py (path:/tmp/pip-9wABBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:33:08 INFO - Running setup.py (path:/tmp/pip-1uFUlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:33:08 INFO - Running setup.py (path:/tmp/pip-7gqeVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:33:08 INFO - Running setup.py (path:/tmp/pip-C08Uoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:33:08 INFO - Running setup.py (path:/tmp/pip-TjKZbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:33:08 INFO - Running setup.py (path:/tmp/pip-sYnxZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:33:09 INFO - Running setup.py (path:/tmp/pip-Zhne7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:09 INFO - Running setup.py (path:/tmp/pip-LQeGWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:33:09 INFO - Running setup.py (path:/tmp/pip-XRnY9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:33:09 INFO - Running setup.py (path:/tmp/pip-8XiuDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:33:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:33:09 INFO - Running setup.py install for manifestparser 12:33:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:33:09 INFO - Running setup.py install for mozcrash 12:33:09 INFO - Running setup.py install for mozdebug 12:33:09 INFO - Running setup.py install for mozdevice 12:33:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:33:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:33:09 INFO - Running setup.py install for mozfile 12:33:09 INFO - Running setup.py install for mozhttpd 12:33:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:33:09 INFO - Running setup.py install for mozinfo 12:33:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:33:10 INFO - Running setup.py install for mozInstall 12:33:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:33:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:33:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:33:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:33:10 INFO - Running setup.py install for mozleak 12:33:10 INFO - Running setup.py install for mozlog 12:33:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:33:10 INFO - Running setup.py install for moznetwork 12:33:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:33:10 INFO - Running setup.py install for mozprocess 12:33:10 INFO - Running setup.py install for mozprofile 12:33:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:33:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:33:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:33:10 INFO - Running setup.py install for mozrunner 12:33:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:33:10 INFO - Running setup.py install for mozscreenshot 12:33:10 INFO - Running setup.py install for moztest 12:33:11 INFO - Running setup.py install for mozversion 12:33:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:33:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:33:11 INFO - Cleaning up... 12:33:11 INFO - Return code: 0 12:33:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:33: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')]} 12:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33: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')]} 12:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:11 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 0x7fde80af5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, '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 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, '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': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', '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 12:33:11 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 12:33:11 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 12:33:11 INFO - Using env: {'DISPLAY': ':0', 12:33:11 INFO - 'HOME': '/home/cltbld', 12:33:11 INFO - 'LANG': 'en_US.UTF-8', 12:33:11 INFO - 'LANGUAGE': 'en_US:en', 12:33:11 INFO - 'LOGNAME': 'cltbld', 12:33:11 INFO - 'MAIL': '/var/mail/cltbld', 12:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:11 INFO - 'MOZ_NO_REMOTE': '1', 12:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:11 INFO - 'NO_EM_RESTART': '1', 12:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:11 INFO - 'PWD': '/builds/slave/test', 12:33:11 INFO - 'SHELL': '/bin/bash', 12:33:11 INFO - 'SHLVL': '1', 12:33:11 INFO - 'TERM': 'linux', 12:33:11 INFO - 'TMOUT': '86400', 12:33:11 INFO - 'USER': 'cltbld', 12:33:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', 12:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:11 INFO - '_': '/tools/buildbot/bin/python'} 12:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:33:11 INFO - Running setup.py (path:/tmp/pip-xHDsLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:33:11 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)) 12:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:33:11 INFO - Running setup.py (path:/tmp/pip-X3K17e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:33:11 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)) 12:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:33:11 INFO - Running setup.py (path:/tmp/pip-TdbICO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:33:11 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)) 12:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:33:11 INFO - Running setup.py (path:/tmp/pip-8_Fbop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:33:11 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)) 12:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:33:11 INFO - Running setup.py (path:/tmp/pip-U_ZLE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:33:11 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)) 12:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:33:11 INFO - Running setup.py (path:/tmp/pip-OImajh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:33:11 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)) 12:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:33:11 INFO - Running setup.py (path:/tmp/pip-VihHsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:33:11 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)) 12:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:33:11 INFO - Running setup.py (path:/tmp/pip-sIXpvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:33:11 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)) 12:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:33:11 INFO - Running setup.py (path:/tmp/pip-k25DZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:33:12 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)) 12:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:33:12 INFO - Running setup.py (path:/tmp/pip-DE6DVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:33:12 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)) 12:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:33:12 INFO - Running setup.py (path:/tmp/pip-PVZeiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:33:12 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)) 12:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:33:12 INFO - Running setup.py (path:/tmp/pip-yl_ceI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:33:12 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)) 12:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:33:12 INFO - Running setup.py (path:/tmp/pip-hP5pL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:33:12 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)) 12:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:33:12 INFO - Running setup.py (path:/tmp/pip-Zq8S4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:33:12 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)) 12:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:12 INFO - Running setup.py (path:/tmp/pip-FaFj1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:12 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)) 12:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:33:12 INFO - Running setup.py (path:/tmp/pip-SNcnAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:33:12 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)) 12:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:33:12 INFO - Running setup.py (path:/tmp/pip-Z4dii3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:33:12 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)) 12:33:12 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)) 12:33:12 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)) 12:33:12 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)) 12:33:12 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)) 12:33:12 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)) 12:33:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:33:12 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 12:33:12 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 12:33:12 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 12:33:12 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 12:33:12 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 12:33:12 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 12:33:14 INFO - Downloading blessings-1.6.tar.gz 12:33:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:33:14 INFO - Installing collected packages: blessings 12:33:14 INFO - Running setup.py install for blessings 12:33:14 INFO - Successfully installed blessings 12:33:14 INFO - Cleaning up... 12:33:14 INFO - Return code: 0 12:33:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:33:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:33:14 INFO - Reading from file tmpfile_stdout 12:33:14 INFO - Current package versions: 12:33:14 INFO - argparse == 1.2.1 12:33:14 INFO - blessings == 1.6 12:33:14 INFO - blobuploader == 1.2.4 12:33:14 INFO - docopt == 0.6.1 12:33:15 INFO - functools32 == 3.2.3-2 12:33:15 INFO - jsonschema == 2.5.1 12:33:15 INFO - manifestparser == 1.1 12:33:15 INFO - mozInstall == 1.12 12:33:15 INFO - mozcrash == 0.17 12:33:15 INFO - mozdebug == 0.1 12:33:15 INFO - mozdevice == 0.48 12:33:15 INFO - mozfile == 1.2 12:33:15 INFO - mozhttpd == 0.7 12:33:15 INFO - mozinfo == 0.9 12:33:15 INFO - mozleak == 0.1 12:33:15 INFO - mozlog == 3.4 12:33:15 INFO - moznetwork == 0.27 12:33:15 INFO - mozprocess == 0.23 12:33:15 INFO - mozprofile == 0.28 12:33:15 INFO - mozrunner == 6.12 12:33:15 INFO - mozscreenshot == 0.1 12:33:15 INFO - mozsystemmonitor == 0.3 12:33:15 INFO - moztest == 0.7 12:33:15 INFO - mozversion == 1.4 12:33:15 INFO - psutil == 3.1.1 12:33:15 INFO - requests == 1.2.3 12:33:15 INFO - wsgiref == 0.1.2 12:33:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:15 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 0x7fde80af5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, '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 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, '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': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', '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 12:33:15 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 12:33:15 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 12:33:15 INFO - Using env: {'DISPLAY': ':0', 12:33:15 INFO - 'HOME': '/home/cltbld', 12:33:15 INFO - 'LANG': 'en_US.UTF-8', 12:33:15 INFO - 'LANGUAGE': 'en_US:en', 12:33:15 INFO - 'LOGNAME': 'cltbld', 12:33:15 INFO - 'MAIL': '/var/mail/cltbld', 12:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:15 INFO - 'MOZ_NO_REMOTE': '1', 12:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:15 INFO - 'NO_EM_RESTART': '1', 12:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:15 INFO - 'PWD': '/builds/slave/test', 12:33:15 INFO - 'SHELL': '/bin/bash', 12:33:15 INFO - 'SHLVL': '1', 12:33:15 INFO - 'TERM': 'linux', 12:33:15 INFO - 'TMOUT': '86400', 12:33:15 INFO - 'USER': 'cltbld', 12:33:15 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', 12:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:15 INFO - '_': '/tools/buildbot/bin/python'} 12:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:15 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)) 12:33:15 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)) 12:33:15 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)) 12:33:15 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)) 12:33:15 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)) 12:33:15 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)) 12:33:15 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)) 12:33:15 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)) 12:33:15 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)) 12:33:15 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)) 12:33:15 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)) 12:33:15 INFO - Cleaning up... 12:33:15 INFO - Return code: 0 12:33:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80af5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df930>, '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 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, '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': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', '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 12:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:33:15 INFO - Using env: {'DISPLAY': ':0', 12:33:15 INFO - 'HOME': '/home/cltbld', 12:33:15 INFO - 'LANG': 'en_US.UTF-8', 12:33:15 INFO - 'LANGUAGE': 'en_US:en', 12:33:15 INFO - 'LOGNAME': 'cltbld', 12:33:15 INFO - 'MAIL': '/var/mail/cltbld', 12:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:15 INFO - 'MOZ_NO_REMOTE': '1', 12:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:15 INFO - 'NO_EM_RESTART': '1', 12:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:15 INFO - 'PWD': '/builds/slave/test', 12:33:15 INFO - 'SHELL': '/bin/bash', 12:33:15 INFO - 'SHLVL': '1', 12:33:15 INFO - 'TERM': 'linux', 12:33:15 INFO - 'TMOUT': '86400', 12:33:15 INFO - 'USER': 'cltbld', 12:33:15 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', 12:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:15 INFO - '_': '/tools/buildbot/bin/python'} 12:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:33:15 INFO - Cleaning up... 12:33:15 INFO - Return code: 0 12:33:15 INFO - Running post-action listener: _resource_record_post_action 12:33:15 INFO - Running post-action listener: _start_resource_monitoring 12:33:15 INFO - Starting resource monitoring. 12:33:15 INFO - [mozharness: 2016-09-29 19:33:15.518137Z] Finished create-virtualenv step (success) 12:33:15 INFO - [mozharness: 2016-09-29 19:33:15.518700Z] Running install step. 12:33:15 INFO - Running pre-action listener: _resource_record_pre_action 12:33:15 INFO - Running main action method: install 12:33:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:33:15 INFO - Reading from file tmpfile_stdout 12:33:15 INFO - Detecting whether we're running mozinstall >=1.0... 12:33:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:33:15 INFO - Reading from file tmpfile_stdout 12:33:15 INFO - Output received: 12:33:15 INFO - Usage: mozinstall [options] installer 12:33:15 INFO - Options: 12:33:15 INFO - -h, --help show this help message and exit 12:33:15 INFO - -d DEST, --destination=DEST 12:33:15 INFO - Directory to install application into. [default: 12:33:15 INFO - "/builds/slave/test"] 12:33:15 INFO - --app=APP Application being installed. [default: firefox] 12:33:15 INFO - mkdir: /builds/slave/test/build/application 12:33:15 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'] 12:33:15 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 12:33:32 INFO - Reading from file tmpfile_stdout 12:33:32 INFO - Output received: 12:33:32 INFO - /builds/slave/test/build/application/firefox/firefox 12:33:32 INFO - Running post-action listener: _resource_record_post_action 12:33:32 INFO - [mozharness: 2016-09-29 19:33:32.824114Z] Finished install step (success) 12:33:32 INFO - [mozharness: 2016-09-29 19:33:32.824359Z] Running run-tests step. 12:33:32 INFO - Running pre-action listener: _resource_record_pre_action 12:33:32 INFO - Running main action method: run_tests 12:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:33:32 INFO - Python 2.7.3 12:33:32 INFO - Return code: 0 12:33:32 INFO - grabbing minidump binary from tooltool 12:33:32 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')]} 12:33:32 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 0x26df930>, '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 0x26e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e0cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:33:32 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 12:33:32 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 12:33:32 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 12:33:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:33:32 INFO - Return code: 0 12:33:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:33:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:33:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:33:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:33:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:33:32 INFO - Using env: {'DISPLAY': ':0', 12:33:32 INFO - 'HOME': '/home/cltbld', 12:33:32 INFO - 'LANG': 'en_US.UTF-8', 12:33:32 INFO - 'LANGUAGE': 'en_US:en', 12:33:32 INFO - 'LOGNAME': 'cltbld', 12:33:32 INFO - 'MAIL': '/var/mail/cltbld', 12:33:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:33:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:32 INFO - 'MOZ_NO_REMOTE': '1', 12:33:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:33:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:32 INFO - 'NO_EM_RESTART': '1', 12:33:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:32 INFO - 'PWD': '/builds/slave/test', 12:33:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:33:32 INFO - 'SHELL': '/bin/bash', 12:33:32 INFO - 'SHLVL': '1', 12:33:32 INFO - 'TERM': 'linux', 12:33:32 INFO - 'TMOUT': '86400', 12:33:32 INFO - 'USER': 'cltbld', 12:33:32 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890', 12:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:32 INFO - '_': '/tools/buildbot/bin/python'} 12:33:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:33:33 INFO - mozversion application_buildid: 20160929093019 12:33:33 INFO - mozversion application_changeset: f21ffbf119bd6d7084309123be42f97743f1f7e5 12:33:33 INFO - mozversion application_display_name: Nightly 12:33:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:33:33 INFO - mozversion application_name: Firefox 12:33:33 INFO - mozversion application_remotingname: firefox 12:33:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:33:33 INFO - mozversion application_vendor: Mozilla 12:33:33 INFO - mozversion application_version: 52.0a1 12:33:33 INFO - mozversion platform_buildid: 20160929093019 12:33:33 INFO - mozversion platform_changeset: f21ffbf119bd6d7084309123be42f97743f1f7e5 12:33:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:33:33 INFO - mozversion platform_version: 52.0a1 12:33:33 INFO - using testdate: 1475177613 12:33:33 INFO - actual date: 1475177613 12:33:33 INFO - starting webserver on 'localhost:42489' 12:33:33 INFO - SUITE-START | Running 2 tests 12:33:33 INFO - TEST-START | dromaeo_css 12:33:33 INFO - operating with platform_type : linux_ 12:33:33 INFO - Initialising browser for dromaeo_css test... 12:33:33 INFO - TEST-INFO | started process 28129 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5TJMpk/profile http://localhost:42489/getInfo.html) 12:33:37 INFO - PROCESS | 28129 | __metrics Screen width/height:1600/1200 12:33:37 INFO - PROCESS | 28129 | colorDepth:24 12:33:37 INFO - PROCESS | 28129 | Browser inner width/height: 1024/697 12:33:37 INFO - PROCESS | 28129 | __metrics 12:33:38 INFO - PROCESS | 28129 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:33:38 INFO - PROCESS | 28129 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:33:38 INFO - PROCESS | 28129 | console.error: PushService: 12:33:38 INFO - PROCESS | 28129 | stateChangeProcessEnqueue: Error transitioning state 12:33:38 INFO - PROCESS | 28129 | UnknownError 12:33:39 INFO - TEST-INFO | 28129: exit 0 12:33:39 INFO - Browser initialized. 12:33:39 INFO - Running cycle 1/1 for dromaeo_css test... 12:33:39 INFO - TEST-INFO | started process 28214 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5TJMpk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:33:51 INFO - PROCESS | 28214 | RSS: Main: 173293568 12:33:51 INFO - PROCESS | 28214 | 12:34:43 INFO - PROCESS | 28214 | 1475177683576 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] 12:36:52 INFO - PROCESS | 28214 | Cycle 1(1): loaded http://localhost:42489/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42489/tests/dromaeo/cssquery-ext.html) 12:36:53 INFO - PROCESS | 28214 | RSS: Main: 284164096 12:36:53 INFO - PROCESS | 28214 | 12:39:56 INFO - PROCESS | 28214 | Cycle 1(1): loaded http://localhost:42489/tests/dromaeo/cssquery-ext.html (next: http://localhost:42489/tests/dromaeo/cssquery-jquery.html) 12:39:57 INFO - PROCESS | 28214 | RSS: Main: 282058752 12:39:57 INFO - PROCESS | 28214 | 12:42:59 INFO - PROCESS | 28214 | Cycle 1(1): loaded http://localhost:42489/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42489/tests/dromaeo/cssquery-mootools.html) 12:42:59 INFO - PROCESS | 28214 | RSS: Main: 219234304 12:42:59 INFO - PROCESS | 28214 | 12:46:01 INFO - PROCESS | 28214 | Cycle 1(1): loaded http://localhost:42489/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42489/tests/dromaeo/cssquery-prototype.html) 12:46:02 INFO - PROCESS | 28214 | RSS: Main: 263991296 12:46:02 INFO - PROCESS | 28214 | 12:49:05 INFO - PROCESS | 28214 | Cycle 1(1): loaded http://localhost:42489/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42489/tests/dromaeo/cssquery-yui.html) 12:49:05 INFO - PROCESS | 28214 | RSS: Main: 222539776 12:49:05 INFO - PROCESS | 28214 | 12:52:08 INFO - PROCESS | 28214 | Cycle 1(1): loaded http://localhost:42489/tests/dromaeo/cssquery-yui.html (next: http://localhost:42489/tests/dromaeo/cssquery-dojo.html) 12:52:09 INFO - PROCESS | 28214 | RSS: Main: 312852480 12:52:09 INFO - PROCESS | 28214 | 12:52:09 INFO - PROCESS | 28214 | __start_tp_report 12:52:09 INFO - PROCESS | 28214 | _x_x_mozilla_page_load 12:52:09 INFO - PROCESS | 28214 | _x_x_mozilla_page_load_details 12:52:09 INFO - PROCESS | 28214 | |i|pagename|runs| 12:52:09 INFO - PROCESS | 28214 | |0;dojo.html;2975.8660860261284;3012.819230846148;3020.7734419918497;3033.2416895776055;3064.494358430859;5138.640295179339;5225.399079105904;5228;5288.550473209777;5329.120695085311;5219.660722053064;5267.315249017632;5365.463453654643;5393.649412788176;5435.972820135904;4783.952160478386;4829.782659780319;4841.491643377448;4876.561109500144;4949.455559888409;4862.246351815475;4897.3878265216845;4966.950330496703;5020.523050310215;5022.974885125569;4894.755262236874;4906.362172917534;4944.986277813057;4967.403911530621;4999.525045120708;4714.38712967312;4754.286856971447;4782.450018247911;4835.05716385305;4840.273958906157;4786.736729479877;4806.375171227718;4806.831760888387;4810.11012962603;4870.09903167915;5337.066013447631;5380.977614253279;5403.972980135074;5404.432534583891;5406.378266499363;5460.372057213432;5536.833894983117;5621.269234999465;5658.943410565883;5761.049426844607;5760.423957604248;5778.855528611776;5795.1017592273265;5798.710064496759;5841.415858414167;5400.243965844785;5404.540614047811;5404.972975135099;5406.621536492447;5407.459254074601;5602.439756024365;5645.661260324394;5758.222639943554;5776.566757493205;5797.420257974253;5576.1356989666665;5583.664980101125;5590.301212348457;5657.8019769307875;5659.745311460994;5639.238702775073;5659.349174844946;5667.376588575254;5667.744951477193;5669.064604340238;5555.111182210827;5593.524550413179;5660.462256085665;5661.66030038199;5664.405237450091;5629.521490673339;5637.7181140942785;5674.432556744293;5695.914561281584;5749.022666146765;4371.562843715603;4373.540778218305;4413.691041627056;4417.271150260235;4426.64586833059;3911.9608803912165;3922.1371298314325;3925.156091440354;3925.646691797752;3968.265870813909;5283.762230699628;5330.040592693353;5337.8131765388025;5444.50999410055;5506.559475241971;5692.089265717465;5692.971535142297;5700.600957932905;5701.344345400332;5702.087665973508;5401.378841433207;5439.020976224318;5452.100403433389;5461.044317244467;5462;4950.801967921315;5003.7998480061115;5006.724630145304;5006.774695138727;5061.848144555669;5916.585838991229;5920.585559010828;5925.762969481259;5933.673647949404;5954.583179177416;5545.7781688732;5604.467575580314;5656.123300888369;5726.770929162787;5746.540276777764;5936.851578710567;5943.227380440515;5945.464908158114;5945.851353716192;5998.820035398945;5605.915911261416;5650.23721797552;5652.434756524314;5653.067243904709;5656.490915817596;5540.584456165884;5600.187972744011;5695.886082278248;5730.541556675373;5735.971320143372;5623.971880140573;5627.577931655224;5628.409017053151;5671.149327600893;5696.060150075191;5538.889222215614;5567.665940043448;5570.805021824217;5571.13647384656;5586.994341018656;5384.165454354581;5435.83692489226;5464.562834973272;5516.297014462804;5524.889502209853;5621.2411324472305;5627.493525582717;5646.2942132233475;5726.198332233574;5732.082866741302;5532.474414930575;5541.307336582927;5548.861278468071;5549.639273447213;5551.861203469945 12:52:09 INFO - PROCESS | 28214 | |1;ext.html;600.9549283803716;610.8564487345474;617.5214208988036;621.9004959206528;642;32161.839190804072;42441.36337954933;43649.34525982113;43674.126517469675;47216.291755623606;44629;44696.553034469645;44804;44991.10017799642;45169.09661806762;8030.317423019051;8828.955855220715;8978.191962723353;8982.461052336848;8983.95508022459;8036.598170091501;10753.51609177585;11118.054965327958;11125.332480051182;11125.388103654295;10969.177311701615;11024;11030.448477576128;11042;11043.447827608628;10840.620578279762;10871.402072885989;10895.83656245157;10910.23628346016;10911.181661375389;10576.36541807494;10622.734431639194;10623.25637205396;10631.415272160028;10634.57461701531;41149.794251028856;41312;41339.793301033606;41377.37933930993;41491.377629335584;3331.566896303489;3373.4939759036097;3838.9808050959846;4018.819153138116;4134.937975930364;31125.37749245025;31142.22144446407;31430;31440.842795786102;33274.500882486784;4300.419443375167;4406.713563618355;4548.385967894358;4581.496035436099;4582.564656357641;359334;360870;361623;362272;363078;57930.710346447995;57965.13052304134;58278.70860645754;58360;58394.70802645959;60387;60415.69792151099;60427.18718438454;60542.394576054554;60546.69726651339;14119;14164.220967846868;14188.574342769733;14198.077124987049;14246.715065698629;10809.081228095543;10813.56745730162;10922.890771092187;10997.670069897917;12132.757344853053;15928.362865485482;16475.6704865902;16756.413525526546;16884.915575422045;16889.577760556083;6259.685466052089;6286.151369565142;6311.684415779193;6381.298057213703;6392.232932048091;920.8756817829641;955.4506158958627;1031.2162756305263;1065.893410658928;1086.3916206923989;31278.218044548612;32329.35341293208;32900.67099329024;33291.33669306498;35609.465858012154;1034.7464871106476;1044.185535282481;1116.0290547223967;1123.601121601836;1150.2408410449063;15860.92069539645;16750.581235468966;16826;16903.408380706616;17142;510941;514844;515252;515946;518934;56259.71870140623;56775;56817.14774278389;56889.43110568841;56902.43097569054;1230.975380492385;1283.7047479079863;1285.68500717323;1298.7857003594302;1340.3499302838115;29082.12753617395;32361;32837.34325313528;32840.671593284715;33292.50061249132;48818;49402.50597493979;49427.258591121885;49453.75273123611;49459;384486;387811;388222;388265;388710;27367.452650947267;28370.43259134847;28371.432571348043;28420.715792842635;28452.85773571119;46110.76944615255;46168.07663846637;47153;47212.7639361801;47664;39914.401283981344;40785.59214407818;41138.79430602828;41804.163916720885;42621.57378426176;40251.396229056;40498;40818.79590602147;41568.58431415647;41909.79045104755;39825.20349592934;41633.58366416297;42003.57996419997;42496.78751606222;42523.36214956716;31261.687383126788;36338.45492317565;36833.447498288086;36927.81536092302;37033.259334813694;27743;27810.443791124468;27966.44067118687;28203.576946345413;28282.434351312448 12:52:09 INFO - PROCESS | 28214 | |2;jquery.html;381.47737599488704;392.5074032089727;405.5923796584433;410.11824577159115;423.83894120234305;13699.246541440218;15500.06999580026;19297;19515.60968780627;20203.59592808143;18530.814691853077;18905.24379024841;19056.618867622637;19524.121414536345;19526.707099393487;4349.369341445488;5032.547070763621;5185.55922746567;5192.844214673566;5207.791688332462;5069.44236134025;5092.643514953955;5127.154019586782;5127.410347810012;5134.512221338967;4932.125792198959;5122.948770512285;5124.308218390525;5127.5128862758165;5130.871728206806;5006.399232092136;5072;5076.44159142494;5081.339425874649;5081.745912704387;4932.704037757746;4955.182394904872;4958.628102892298;4960.23116416956;4960.851174464772;20766.377008689764;21852.016659250214;21873.78126218749;22176.445588860246;22223;2089.226986015169;2100.2859027930426;2123.384218576611;2152.1929276521305;2201.1085510368325;9362.36654848511;9530.761730956781;9715.417074975525;9952.154066904322;10036.247281453847;1743.6338368942538;1812.8187181281899;1895.3176856331709;1906.4852489827808;1927.296536764085;73080.26919730788;80951.99999999942;81017.59491202566;81782.59108704478;82823.58588207081;10739.946300268448;10989.505472253768;11181.881811818754;11185.217034807485;11238.7190320241;15767.68464630724;15771.68456630861;15786.052836829827;15790.763138552931;15799.526014219591;7668.501547399401;7773.727919522903;7988.241117093867;8108.675652973933;8179.304759095425;7451.44114191427;7459.962700186465;7537.057867766529;7736.419768517271;7739.806504837424;4779.426468823764;4785.138675038457;4801.831935882227;4807.326974223612;4891.388576427947;1977.6835706286925;2011.215625905898;2014.405750303664;2014.8992550372423;2029.9086541105685;919.5723988345452;926.5129467205173;1015.5988384588194;1020.9795804084025;1047.3087762076993;18549.721754173697;19399;19570.315038973567;19602;19786.802131978497;1006.6476733143488;1007.4308015970953;1022.9283950123569;1034.1054987435964;1034.5758239121924;10194.337368071052;10722.78554428907;10772.784544309226;10840.728981775519;10843.457827108614;451814;461141;464916;464953;466615;94263.52868235615;98248.50875745718;98734.5063274679;98752.50623746835;100500;1010.8079464901646;1052.5053224984244;1075.1022895882027;1076.8546246256656;1081.7025318037602;17552.82447175512;17569.297228110732;18292.72560911614;18311.35910243135;18463.35378261808;39850;40131.799341003105;41204.58795412008;41409.79295103626;41678;56570.717146414005;57517;57653.13520297115;58854.7057264711;59804;8075.152109028468;8186.631601578062;8272.751817445485;8282.627281772215;8614.569271536273;10923.726906827074;13144.80282795778;13170.209787412787;13490.662733431744;13764.105333153313;11262.38056906878;11610.12924030718;11705.122115841175;11889.821652675044;12396;10781.299215550964;11125.299995528185;11187.32876027441;11330.886691132982;11370.886291137314;12011.63965081049;12065.155439119528;12123.272603643809;12137.939310303393;12494.625161245178;7848.568328741746;8045.034595848536;8107.918920810716;8226;8500.659973600987;10735.677929662123;11288.661340159808;11340.829887551528;11740.765184696429;11810.881891181321 12:52:09 INFO - PROCESS | 28214 | |3;mootools.html;1346.548906116451;1474.0860666386834;1490.5677353567462;1650.4223521767376;1818.154558130469;7865.567393793339;8530;8845.33659975502;8854.070322616113;9009.90990090099;9063.139001794836;9114.088591140882;9123.771905702344;9136.725898223047;9144.451332920029;2404.362843846382;2404.843685160468;2421.2978236311446;2423.684920960273;2425.915092971746;2377.108584280895;2396.6405039244078;2437.6709144265565;2440.7803297703203;2444.2300675287315;2372.757743931985;2388.152205966883;2398.8200884933613;2412.95174096518;2422.697162854643;2336.754640762721;2342.7540108288554;2346.483773569812;2372.146027430124;2395.2574701842486;2296.402935236834;2308.3075077476856;2310.838241323108;2312.6184179610345;2314.328844635054;8675.869861952076;8753.47479151253;8829.514376709278;9045.954770226106;9073;5147.330846989905;5357.946420535823;5368.30212072432;5369.40936496985;5378;3576.6959808416054;3615.891523254307;3654.689351405134;3661.4141737322166;3665.596784353719;1147.5983405807983;1148.4430051425052;1153.2907262033789;1175.9118066144988;1194.1103877611235;12295.139340246187;12342.382880855921;12392.380380981005;12416.627501174979;12501.49994000239;4401.405810215644;4623.907521849612;4757.833475828329;4803.663743537919;4820.325154478376;9646.938836727953;9655.22758179344;9659.275554333453;9661.13049825519;9661.855072173923;5298.470152984671;5306.495882891119;5321.813736519203;5324.494173053554;5325.094733895247;4367.978160109179;4518.412606361152;4789.3055506952;4869.440014398389;4893.559579637778;3903.4144878268485;3926.784026878549;3977.622125898035;3987.4218238355274;4049.8380064797666;1220.3166226912779;1221.993890030562;1228.6621179175797;1233.7964235900977;1248.126311581878;996.1831298335441;1003.8544411060501;1014.8934361891895;1016.3698506925754;1032.865727455426;6145.815625531151;6225.501959843202;6265.686715664198;6270.592411493239;6518.641474718841;440.467034887783;447.9888002799956;450.7025363260233;452.7736131934033;459.7839015662633;4305.913881722348;4370.431843860278;4379.1241751649795;4434.5343738907595;4476.462824461086;10969.83545246822;11300.604478843201;11350.432478376048;11377.658670239905;11385.658430247106;10575.471226438647;11082.113430925669;11242.55029798799;11264.774704505864;11288.209825312313;8056.959715201504;8261.504309741435;8266.751997440086;8271.2142346477;8282.958585207036;6289.937100628935;6463.870722585616;6502.642354670538;6545.476361891133;6721.495887808532;10277.715285589302;10584.947075264883;10624.575016999233;10724.356538607708;10736.838947415952;10820.89179108199;10824.079953204066;10927.344359338465;10952.890471095507;10956.123510119012;7170.533915295489;7464.738734144279;7465.888011679937;7964.880526791987;8076.83846323082;8487.702930397407;9054.909450905407;9056.27549796028;9058.003619601706;9060.365774395992;7865.567393793396;7919.247671471201;8016.118226995142;8126.553039582644;8178.059523154913;7820.921790782019;7831.530108193527;7855.882161767692;7866.331361834308;8046.798830029296;7228.421726261781;7334.6699398526125;7345.595992220479;7345.926540734525;7347.7795666130105;4998.400191976986;5073.239014147907;5132.12753831842;5285.550728188147;5444.292242008513;5444.6188766785945;5460.31746031746;5536.501714845684;5564.610477266552;5677 12:52:09 INFO - PROCESS | 28214 | |4;prototype.html;301.421271159374;312.99996511146895;315.6448994880759;322.8643969532796;325.9796835903622;5110.872228194297;5212.2963399941;5280.419153893074;5337.973310133449;5363.168708850129;5068.46781087986;5154.94323663649;5181.404138524071;5185.222216667502;5240.213967904807;4061.878143655695;4067.4102255172984;4073.7352072115364;4079.3473044312914;4081.3469844824835;3908.609139086083;4070.3949472337727;4074.982883472685;4118.588141185887;4121.505419349667;4060.314969287757;4065.2885744994655;4070.837166513336;4082.4080508326424;4095.344744840826;4033.7176397652174;4049.1496785674894;4050.25070361984;4067.6949228807957;4071.7149799514045;3409.710174635159;3496.230829217568;3506.63180366063;3521.4893840393;3588.22853086585;5106.872328191825;5110.693358398471;5115.948840511622;5119.692818430906;5127.384713834326;4534.88662783433;4601.83893563727;4602.6087782538525;4603.309503574457;4626.79703277147;5194.818181363672;5375.784968601251;5422.783088676449;5440.809571664972;5451.291332126838;3850.210706805098;3853.7880416577077;3859.9614003859883;3860.4595356650093;3884;5650.180723795027;5652.802151924704;5681.630694004918;5692.914606280868;5694.202811606337;3856.46009558662;3914.706397020235;3922.646961773454;3961.187956468917;4009.719319647597;4009.538903026131;4019.2162528307285;4029.9395509067385;4034.3141665916864;4037.5558688544825;4622.214223581999;4622.422197225347;4623.722576645412;4648.97675511627;4653.650976176733;5364.892702145935;5432.945670543323;5472.972635136878;5504;5540.722963851791;1347.9663008424673;1376.3393571085735;1377.7864431013209;1379.544750232421;1379.744747221747;867.7093173786726;877.4077497689034;900.2123142250531;913.7441516375426;913.7624217703445;4741.502142275081;4752.3584316116885;4777.856664300077;4809.615230781529;4821.927671084936;4979.502049794992;5002.174206414633;5009.89980200394;5023.120953833065;5054.342935418372;4419.690621656453;4738.47876733559;4755.216793702361;4755.667103302736;4760.714357138583;2611.4385407137556;2625.6324114623967;2637.472505498908;2638.6569745932907;2644.3917898883365;5102.647798333444;5108.19049522761;5129.973660404194;5134.2812006319145;5155.252488389163;5015.3480047593575;5036.823711170165;5068.23976403535;5373.865653358619;5814.738336774855;5840.620359676607;5852.4147585241135;5853.678047707332;5854.326752423441;5894.911576326273;5584.497395234448;5632.324121105494;5670.177824215548;5670.262865827416;5676.17695434168;5496.945030549643;5548.472895074961;5584.274044374368;5610.438956104357;5620.325560932714;5838.036723940672;5847.561432892465;5854.5609079320075;5856.765729370948;5864.533866533367;3741.943870841994;3824.4454554090057;3839.328117579357;3977.2642061218767;4009.5565596384695;5477.917831232615;5486.256871564218;5524.972375138099;5541.974734674098;5555.30558680165;5415.106507426231;5445.53712934405;5454.945450545602;5475.780968761205;5476.397596264487;5270.73646317675;5395.3525576931015;5415.050581790473;5415.238228503413;5424.698072462502;5360.731963401737;5372.534715108811;5377.408485066718;5383.2463455117095;5395.271638328775;5256.132738098324;5406.2701535292235;5441.0478166319945;5470.6991115487435;5497.147942068986;5309.867253318698;5367.248585198154;5373.677579345252;5390.110631745718;5402.351717793733 12:52:09 INFO - PROCESS | 28214 | |5;yui.html;727.9344858962693;740.0601236429734;743.6765007221856;790.1150711203451;832.8292699996501;14835;15688.058716477019;16036.75944860828;16088.276027578759;16103.677926441464;14488.20314882681;14727.410903563845;14784.260786960636;14785.55643330699;14838.18389988553;786.1548835002367;804.0793291681022;807.90709068457;808.6118663041714;809.6194788449419;670.9161354830646;687.6286805125252;786.3709032773787;803.9477433966773;806.4959400374765;855.5508358111979;857.8927634045745;857.9056303806576;858.1675774498726;858.5149390594295;851.7998270406449;851.8722191671268;853.1937319233327;853.7524118005801;854.5171977832536;511.47829214201676;524.7376311844077;600.9248843894513;613.5674349583533;620.3052581109187;14443;14459.493917712934;14506.347214375379;14510.201938893357;14518;12869.806952895715;13034.608961731163;13191.966055991737;13475.865241347658;13540.661483462894;12312.630621081382;12525.812112818316;12595.370231488389;12595.811062834066;12822.294773787438;4259.382389553529;4281.143771245732;4296.806643701009;4365.083332500179;4505.346724724929;66722.33277667259;68755.96866047013;70311;83163.58418207931;83571.16428835694;10979.451027448597;11138.721531961766;11500.25248358854;11508.424578771028;11552.537898483966;21450.463738406666;21482.14071437125;21514.13943442276;21620.56758864814;21720;8287.709930152536;8471.745847624581;8587.355948303903;8643.697470588499;8711.25954293892;4608.170529304691;4718.952810471851;4733.810647574127;4812.422509298836;4937.950620493821;3281.0812972367776;3346.9163270917934;3365.0914253151514;3404.7957122572725;3425.845836937344;569.954134163814;573.2032474859948;575.576950941058;578.8957987562195;598.5843480169455;636.2142753699178;650.3561474140566;663.6449499517735;705.8706070287601;709.9006139140421;8092.225586903755;8524.616392262364;8782.253508451726;9211.355205135576;9221.031791661913;586.3374386942727;589.9705014749331;601.2424345324922;612.4120843989731;628.84593274648;4239.872803815891;4324.805383757738;4327.740335579875;4335.176316499855;4415.227335216325;98185.50907245418;127179;127466;133667;134004;93717;96059;96318.51840740751;97135.51432242793;97713.5114324438;58810;86376.56811716026;86670.96651617163;88547.55726221327;93071.53464232771;8785.780355491164;8850;9226.769330766785;9229.86155207659;9383.390079644802;50700.74649626728;50815.237771432716;50919.23621145612;52849;52980.20529692135;68720.3127968714;75311.24688753042;75968;76724;76911;12238.510459581874;12256.571020014257;12603.306818125091;12647.114701970773;12659.620211393672;13616.319184040956;13731.313434328444;14091.436342546593;14297;14660.266986650839;13351.732965340832;13397.53108641193;13743.106698064594;13835.79246311286;14300.141991480545;13203.933980330037;13606.25165615861;14086.22525761093;14263.286835658384;14726;13910.443582256596;14182.858171418155;14544;14601.26993650292;14985.175815330262;10269.948650256702;10810.783784324427;11064.944675276573;11355.659330220107;11426.885731142915;10709.410982396043;11314.773704525698;11346.773064538498;11472.770544589228;11512.251703639236 12:52:09 INFO - PROCESS | 28214 | __end_tp_report 12:52:09 INFO - PROCESS | 28214 | __start_cc_report 12:52:09 INFO - PROCESS | 28214 | _x_x_mozilla_cycle_collect,1036 12:52:09 INFO - PROCESS | 28214 | __end_cc_report 12:52:09 INFO - PROCESS | 28214 | __startTimestamp1475178729115__endTimestamp 12:52:09 INFO - PROCESS | 28214 | 12:52:09 INFO - PROCESS | 28214 | ------- Summary: start ------- 12:52:09 INFO - PROCESS | 28214 | Number of tests: 6 12:52:09 INFO - PROCESS | 28214 | 12:52:09 INFO - PROCESS | 28214 | [#0] dojo.html Cycles:165 Average:5304.32 Median:5536.83 stddev:599.72 (10.8%) stddev-sans-first:573.07 12:52:09 INFO - PROCESS | 28214 | Values: 2975.9 3012.8 3020.8 3033.2 3064.5 5138.6 5225.4 5228.0 5288.6 5329.1 5219.7 5267.3 5365.5 5393.6 5436.0 4784.0 4829.8 4841.5 4876.6 4949.5 4862.2 4897.4 4967.0 5020.5 5023.0 4894.8 4906.4 4945.0 4967.4 4999.5 4714.4 4754.3 4782.5 4835.1 4840.3 4786.7 4806.4 4806.8 4810.1 4870.1 5337.1 5381.0 5404.0 5404.4 5406.4 5460.4 5536.8 5621.3 5658.9 5761.0 5760.4 5778.9 5795.1 5798.7 5841.4 5400.2 5404.5 5405.0 5406.6 5407.5 5602.4 5645.7 5758.2 5776.6 5797.4 5576.1 5583.7 5590.3 5657.8 5659.7 5639.2 5659.3 5667.4 5667.7 5669.1 5555.1 5593.5 5660.5 5661.7 5664.4 5629.5 5637.7 5674.4 5695.9 5749.0 4371.6 4373.5 4413.7 4417.3 4426.6 3912.0 3922.1 3925.2 3925.6 3968.3 5283.8 5330.0 5337.8 5444.5 5506.6 5692.1 5693.0 5700.6 5701.3 5702.1 5401.4 5439.0 5452.1 5461.0 5462.0 4950.8 5003.8 5006.7 5006.8 5061.8 5916.6 5920.6 5925.8 5933.7 5954.6 5545.8 5604.5 5656.1 5726.8 5746.5 5936.9 5943.2 5945.5 5945.9 5998.8 5605.9 5650.2 5652.4 5653.1 5656.5 5540.6 5600.2 5695.9 5730.5 5736.0 5624.0 5627.6 5628.4 5671.1 5696.1 5538.9 5567.7 5570.8 5571.1 5587.0 5384.2 5435.8 5464.6 5516.3 5524.9 5621.2 5627.5 5646.3 5726.2 5732.1 5532.5 5541.3 5548.9 5549.6 5551.9 12:52:09 INFO - PROCESS | 28214 | 12:52:09 INFO - PROCESS | 28214 | [#1] ext.html Cycles:180 Average:58479.30 Median:194162.49 stddev:112872.34 (58.1%) stddev-sans-first:113105.32 12:52:09 INFO - PROCESS | 28214 | Values: 601.0 610.9 617.5 621.9 642.0 32161.8 42441.4 43649.3 43674.1 47216.3 44629.0 44696.6 44804.0 44991.1 45169.1 8030.3 8829.0 8978.2 8982.5 8984.0 8036.6 10753.5 11118.1 11125.3 11125.4 10969.2 11024.0 11030.4 11042.0 11043.4 10840.6 10871.4 10895.8 10910.2 10911.2 10576.4 10622.7 10623.3 10631.4 10634.6 41149.8 41312.0 41339.8 41377.4 41491.4 3331.6 3373.5 3839.0 4018.8 4134.9 31125.4 31142.2 31430.0 31440.8 33274.5 4300.4 4406.7 4548.4 4581.5 4582.6 359334.0 360870.0 361623.0 362272.0 363078.0 57930.7 57965.1 58278.7 58360.0 58394.7 60387.0 60415.7 60427.2 60542.4 60546.7 14119.0 14164.2 14188.6 14198.1 14246.7 10809.1 10813.6 10922.9 10997.7 12132.8 15928.4 16475.7 16756.4 16884.9 16889.6 6259.7 6286.2 6311.7 6381.3 6392.2 920.9 955.5 1031.2 1065.9 1086.4 31278.2 32329.4 32900.7 33291.3 35609.5 1034.7 1044.2 1116.0 1123.6 1150.2 15860.9 16750.6 16826.0 16903.4 17142.0 510941.0 514844.0 515252.0 515946.0 518934.0 56259.7 56775.0 56817.1 56889.4 56902.4 1231.0 1283.7 1285.7 1298.8 1340.3 29082.1 32361.0 32837.3 32840.7 33292.5 48818.0 49402.5 49427.3 49453.8 49459.0 384486.0 387811.0 388222.0 388265.0 388710.0 27367.5 28370.4 28371.4 28420.7 28452.9 46110.8 46168.1 47153.0 47212.8 47664.0 39914.4 40785.6 41138.8 41804.2 42621.6 40251.4 40498.0 40818.8 41568.6 41909.8 39825.2 41633.6 42003.6 42496.8 42523.4 31261.7 36338.5 36833.4 36927.8 37033.3 27743.0 27810.4 27966.4 28203.6 28282.4 12:52:09 INFO - PROCESS | 28214 | 12:52:09 INFO - PROCESS | 28214 | [#2] jquery.html Cycles:180 Average:28135.54 Median:21862.90 stddev:76500.54 (349.9%) stddev-sans-first:76686.76 12:52:09 INFO - PROCESS | 28214 | Values: 381.5 392.5 405.6 410.1 423.8 13699.2 15500.1 19297.0 19515.6 20203.6 18530.8 18905.2 19056.6 19524.1 19526.7 4349.4 5032.5 5185.6 5192.8 5207.8 5069.4 5092.6 5127.2 5127.4 5134.5 4932.1 5122.9 5124.3 5127.5 5130.9 5006.4 5072.0 5076.4 5081.3 5081.7 4932.7 4955.2 4958.6 4960.2 4960.9 20766.4 21852.0 21873.8 22176.4 22223.0 2089.2 2100.3 2123.4 2152.2 2201.1 9362.4 9530.8 9715.4 9952.2 10036.2 1743.6 1812.8 1895.3 1906.5 1927.3 73080.3 80952.0 81017.6 81782.6 82823.6 10739.9 10989.5 11181.9 11185.2 11238.7 15767.7 15771.7 15786.1 15790.8 15799.5 7668.5 7773.7 7988.2 8108.7 8179.3 7451.4 7460.0 7537.1 7736.4 7739.8 4779.4 4785.1 4801.8 4807.3 4891.4 1977.7 2011.2 2014.4 2014.9 2029.9 919.6 926.5 1015.6 1021.0 1047.3 18549.7 19399.0 19570.3 19602.0 19786.8 1006.6 1007.4 1022.9 1034.1 1034.6 10194.3 10722.8 10772.8 10840.7 10843.5 451814.0 461141.0 464916.0 464953.0 466615.0 94263.5 98248.5 98734.5 98752.5 100500.0 1010.8 1052.5 1075.1 1076.9 1081.7 17552.8 17569.3 18292.7 18311.4 18463.4 39850.0 40131.8 41204.6 41409.8 41678.0 56570.7 57517.0 57653.1 58854.7 59804.0 8075.2 8186.6 8272.8 8282.6 8614.6 10923.7 13144.8 13170.2 13490.7 13764.1 11262.4 11610.1 11705.1 11889.8 12396.0 10781.3 11125.3 11187.3 11330.9 11370.9 12011.6 12065.2 12123.3 12137.9 12494.6 7848.6 8045.0 8107.9 8226.0 8500.7 10735.7 11288.7 11340.8 11740.8 11810.9 12:52:09 INFO - PROCESS | 28214 | 12:52:09 INFO - PROCESS | 28214 | [#3] mootools.html Cycles:180 Average:5927.02 Median:456.28 stddev:3379.99 (740.8%) stddev-sans-first:3371.94 12:52:09 INFO - PROCESS | 28214 | Values: 1346.5 1474.1 1490.6 1650.4 1818.2 7865.6 8530.0 8845.3 8854.1 9009.9 9063.1 9114.1 9123.8 9136.7 9144.5 2404.4 2404.8 2421.3 2423.7 2425.9 2377.1 2396.6 2437.7 2440.8 2444.2 2372.8 2388.2 2398.8 2413.0 2422.7 2336.8 2342.8 2346.5 2372.1 2395.3 2296.4 2308.3 2310.8 2312.6 2314.3 8675.9 8753.5 8829.5 9046.0 9073.0 5147.3 5357.9 5368.3 5369.4 5378.0 3576.7 3615.9 3654.7 3661.4 3665.6 1147.6 1148.4 1153.3 1175.9 1194.1 12295.1 12342.4 12392.4 12416.6 12501.5 4401.4 4623.9 4757.8 4803.7 4820.3 9646.9 9655.2 9659.3 9661.1 9661.9 5298.5 5306.5 5321.8 5324.5 5325.1 4368.0 4518.4 4789.3 4869.4 4893.6 3903.4 3926.8 3977.6 3987.4 4049.8 1220.3 1222.0 1228.7 1233.8 1248.1 996.2 1003.9 1014.9 1016.4 1032.9 6145.8 6225.5 6265.7 6270.6 6518.6 440.5 448.0 450.7 452.8 459.8 4305.9 4370.4 4379.1 4434.5 4476.5 10969.8 11300.6 11350.4 11377.7 11385.7 10575.5 11082.1 11242.6 11264.8 11288.2 8057.0 8261.5 8266.8 8271.2 8283.0 6289.9 6463.9 6502.6 6545.5 6721.5 10277.7 10584.9 10624.6 10724.4 10736.8 10820.9 10824.1 10927.3 10952.9 10956.1 7170.5 7464.7 7465.9 7964.9 8076.8 8487.7 9054.9 9056.3 9058.0 9060.4 7865.6 7919.2 8016.1 8126.6 8178.1 7820.9 7831.5 7855.9 7866.3 8046.8 7228.4 7334.7 7345.6 7345.9 7347.8 4998.4 5073.2 5132.1 5285.6 5444.3 5444.6 5460.3 5536.5 5564.6 5677.0 12:52:09 INFO - PROCESS | 28214 | 12:52:09 INFO - PROCESS | 28214 | [#4] prototype.html Cycles:180 Average:4507.75 Median:5107.53 stddev:1338.38 (26.2%) stddev-sans-first:1304.36 12:52:09 INFO - PROCESS | 28214 | Values: 301.4 313.0 315.6 322.9 326.0 5110.9 5212.3 5280.4 5338.0 5363.2 5068.5 5154.9 5181.4 5185.2 5240.2 4061.9 4067.4 4073.7 4079.3 4081.3 3908.6 4070.4 4075.0 4118.6 4121.5 4060.3 4065.3 4070.8 4082.4 4095.3 4033.7 4049.1 4050.3 4067.7 4071.7 3409.7 3496.2 3506.6 3521.5 3588.2 5106.9 5110.7 5115.9 5119.7 5127.4 4534.9 4601.8 4602.6 4603.3 4626.8 5194.8 5375.8 5422.8 5440.8 5451.3 3850.2 3853.8 3860.0 3860.5 3884.0 5650.2 5652.8 5681.6 5692.9 5694.2 3856.5 3914.7 3922.6 3961.2 4009.7 4009.5 4019.2 4029.9 4034.3 4037.6 4622.2 4622.4 4623.7 4649.0 4653.7 5364.9 5432.9 5473.0 5504.0 5540.7 1348.0 1376.3 1377.8 1379.5 1379.7 867.7 877.4 900.2 913.7 913.8 4741.5 4752.4 4777.9 4809.6 4821.9 4979.5 5002.2 5009.9 5023.1 5054.3 4419.7 4738.5 4755.2 4755.7 4760.7 2611.4 2625.6 2637.5 2638.7 2644.4 5102.6 5108.2 5130.0 5134.3 5155.3 5015.3 5036.8 5068.2 5373.9 5814.7 5840.6 5852.4 5853.7 5854.3 5894.9 5584.5 5632.3 5670.2 5670.3 5676.2 5496.9 5548.5 5584.3 5610.4 5620.3 5838.0 5847.6 5854.6 5856.8 5864.5 3741.9 3824.4 3839.3 3977.3 4009.6 5477.9 5486.3 5525.0 5542.0 5555.3 5415.1 5445.5 5454.9 5475.8 5476.4 5270.7 5395.4 5415.1 5415.2 5424.7 5360.7 5372.5 5377.4 5383.2 5395.3 5256.1 5406.3 5441.0 5470.7 5497.1 5309.9 5367.2 5373.7 5390.1 5402.4 12:52:09 INFO - PROCESS | 28214 | 12:52:09 INFO - PROCESS | 28214 | [#5] yui.html Cycles:180 Average:20781.77 Median:4726.38 stddev:30472.64 (644.7%) stddev-sans-first:30520.92 12:52:09 INFO - PROCESS | 28214 | Values: 727.9 740.1 743.7 790.1 832.8 14835.0 15688.1 16036.8 16088.3 16103.7 14488.2 14727.4 14784.3 14785.6 14838.2 786.2 804.1 807.9 808.6 809.6 670.9 687.6 786.4 803.9 806.5 855.6 857.9 857.9 858.2 858.5 851.8 851.9 853.2 853.8 854.5 511.5 524.7 600.9 613.6 620.3 14443.0 14459.5 14506.3 14510.2 14518.0 12869.8 13034.6 13192.0 13475.9 13540.7 12312.6 12525.8 12595.4 12595.8 12822.3 4259.4 4281.1 4296.8 4365.1 4505.3 66722.3 68756.0 70311.0 83163.6 83571.2 10979.5 11138.7 11500.3 11508.4 11552.5 21450.5 21482.1 21514.1 21620.6 21720.0 8287.7 8471.7 8587.4 8643.7 8711.3 4608.2 4719.0 4733.8 4812.4 4938.0 3281.1 3346.9 3365.1 3404.8 3425.8 570.0 573.2 575.6 578.9 598.6 636.2 650.4 663.6 705.9 709.9 8092.2 8524.6 8782.3 9211.4 9221.0 586.3 590.0 601.2 612.4 628.8 4239.9 4324.8 4327.7 4335.2 4415.2 98185.5 127179.0 127466.0 133667.0 134004.0 93717.0 96059.0 96318.5 97135.5 97713.5 58810.0 86376.6 86671.0 88547.6 93071.5 8785.8 8850.0 9226.8 9229.9 9383.4 50700.7 50815.2 50919.2 52849.0 52980.2 68720.3 75311.2 75968.0 76724.0 76911.0 12238.5 12256.6 12603.3 12647.1 12659.6 13616.3 13731.3 14091.4 14297.0 14660.3 13351.7 13397.5 13743.1 13835.8 14300.1 13203.9 13606.3 14086.2 14263.3 14726.0 13910.4 14182.9 14544.0 14601.3 14985.2 10269.9 10810.8 11064.9 11355.7 11426.9 10709.4 11314.8 11346.8 11472.8 11512.3 12:52:09 INFO - PROCESS | 28214 | -------- Summary: end -------- 12:52:09 INFO - PROCESS | 28214 | 12:52:09 INFO - TEST-INFO | 28214: exit 0 12:52:10 INFO - TEST-OK | dromaeo_css | took 1116917ms 12:52:10 INFO - TEST-START | kraken 12:52:10 INFO - operating with platform_type : linux_ 12:52:10 INFO - Initialising browser for kraken test... 12:52:10 INFO - TEST-INFO | started process 28521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCeE9SA/profile http://localhost:42489/getInfo.html) 12:52:14 INFO - PROCESS | 28521 | __metrics Screen width/height:1600/1200 12:52:14 INFO - PROCESS | 28521 | colorDepth:24 12:52:14 INFO - PROCESS | 28521 | Browser inner width/height: 1024/697 12:52:14 INFO - PROCESS | 28521 | __metrics 12:52:15 INFO - PROCESS | 28521 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:52:15 INFO - PROCESS | 28521 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:52:15 INFO - PROCESS | 28521 | console.error: PushService: 12:52:15 INFO - PROCESS | 28521 | stateChangeProcessEnqueue: Error transitioning state 12:52:15 INFO - PROCESS | 28521 | UnknownError 12:52:16 INFO - TEST-INFO | 28521: exit 0 12:52:16 INFO - Browser initialized. 12:52:16 INFO - Running cycle 1/1 for kraken test... 12:52:16 INFO - TEST-INFO | started process 28602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCeE9SA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:52:28 INFO - PROCESS | 28602 | RSS: Main: 174059520 12:52:28 INFO - PROCESS | 28602 | 12:52:30 INFO - PROCESS | 28602 | Cycle 1(1): loaded http://localhost:42489/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42489/tests/kraken/driver.html?testName=audio-beat-detection) 12:52:31 INFO - PROCESS | 28602 | RSS: Main: 232357888 12:52:31 INFO - PROCESS | 28602 | 12:52:34 INFO - PROCESS | 28602 | Cycle 1(1): loaded http://localhost:42489/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42489/tests/kraken/driver.html?testName=audio-dft) 12:52:35 INFO - PROCESS | 28602 | RSS: Main: 217083904 12:52:35 INFO - PROCESS | 28602 | 12:52:38 INFO - PROCESS | 28602 | Cycle 1(1): loaded http://localhost:42489/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42489/tests/kraken/driver.html?testName=audio-fft) 12:52:38 INFO - PROCESS | 28602 | RSS: Main: 298278912 12:52:38 INFO - PROCESS | 28602 | 12:52:40 INFO - PROCESS | 28602 | Cycle 1(1): loaded http://localhost:42489/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42489/tests/kraken/driver.html?testName=audio-oscillator) 12:52:41 INFO - PROCESS | 28602 | RSS: Main: 207552512 12:52:41 INFO - PROCESS | 28602 | 12:52:43 INFO - PROCESS | 28602 | Cycle 1(1): loaded http://localhost:42489/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42489/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:52:44 INFO - PROCESS | 28602 | RSS: Main: 212705280 12:52:44 INFO - PROCESS | 28602 | 12:52:47 INFO - PROCESS | 28602 | Cycle 1(1): loaded http://localhost:42489/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42489/tests/kraken/driver.html?testName=imaging-darkroom) 12:52:47 INFO - PROCESS | 28602 | RSS: Main: 249495552 12:52:47 INFO - PROCESS | 28602 | 12:52:51 INFO - PROCESS | 28602 | Cycle 1(1): loaded http://localhost:42489/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42489/tests/kraken/driver.html?testName=imaging-desaturate) 12:52:51 INFO - PROCESS | 28602 | RSS: Main: 248209408 12:52:51 INFO - PROCESS | 28602 | 12:52:54 INFO - PROCESS | 28602 | Cycle 1(1): loaded http://localhost:42489/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42489/tests/kraken/driver.html?testName=json-parse-financial) 12:52:55 INFO - PROCESS | 28602 | RSS: Main: 247783424 12:52:55 INFO - PROCESS | 28602 | 12:52:56 INFO - PROCESS | 28602 | Cycle 1(1): loaded http://localhost:42489/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42489/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:52:57 INFO - PROCESS | 28602 | RSS: Main: 210415616 12:52:57 INFO - PROCESS | 28602 | 12:52:58 INFO - PROCESS | 28602 | Cycle 1(1): loaded http://localhost:42489/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42489/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:52:59 INFO - PROCESS | 28602 | RSS: Main: 217636864 12:52:59 INFO - PROCESS | 28602 | 12:53:01 INFO - PROCESS | 28602 | Cycle 1(1): loaded http://localhost:42489/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42489/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:53:02 INFO - PROCESS | 28602 | RSS: Main: 222183424 12:53:02 INFO - PROCESS | 28602 | 12:53:04 INFO - PROCESS | 28602 | Cycle 1(1): loaded http://localhost:42489/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:53:05 INFO - PROCESS | 28602 | RSS: Main: 217505792 12:53:05 INFO - PROCESS | 28602 | 12:53:08 INFO - PROCESS | 28602 | Cycle 1(1): loaded http://localhost:42489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:53:08 INFO - PROCESS | 28602 | RSS: Main: 220483584 12:53:08 INFO - PROCESS | 28602 | 12:53:10 INFO - PROCESS | 28602 | Cycle 1(1): loaded http://localhost:42489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42489/tests/kraken/driver.html?testName=ai-astar) 12:53:10 INFO - PROCESS | 28602 | RSS: Main: 271478784 12:53:10 INFO - PROCESS | 28602 | 12:53:10 INFO - PROCESS | 28602 | __start_tp_report 12:53:10 INFO - PROCESS | 28602 | _x_x_mozilla_page_load 12:53:10 INFO - PROCESS | 28602 | _x_x_mozilla_page_load_details 12:53:10 INFO - PROCESS | 28602 | |i|pagename|runs| 12:53:10 INFO - PROCESS | 28602 | |0;ai-astar;108;110;111;112;111;110;112;112;111;110 12:53:10 INFO - PROCESS | 28602 | |1;audio-beat-detection;144;117;117;157;123;120;120;116;162;118 12:53:10 INFO - PROCESS | 28602 | |2;audio-dft;160;160;160;159;160;160;162;160;161;163 12:53:10 INFO - PROCESS | 28602 | |3;audio-fft;76;77;77;109;76;75;75;75;96;75 12:53:10 INFO - PROCESS | 28602 | |4;audio-oscillator;82;83;125;82;82;83;102;82;82;106 12:53:10 INFO - PROCESS | 28602 | |5;imaging-gaussian-blur;117;116;116;118;116;116;117;118;118;118 12:53:10 INFO - PROCESS | 28602 | |6;imaging-darkroom;146;145;145;146;146;146;145;145;146;145 12:53:10 INFO - PROCESS | 28602 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;95 12:53:10 INFO - PROCESS | 28602 | |8;json-parse-financial;51;63;51;51;51;53;52;52;52;51 12:53:10 INFO - PROCESS | 28602 | |9;json-stringify-tinderbox;59;60;59;59;59;60;60;60;60;64 12:53:10 INFO - PROCESS | 28602 | |10;stanford-crypto-aes;79;79;79;78;78;78;78;78;83;78 12:53:10 INFO - PROCESS | 28602 | |11;stanford-crypto-ccm;123;120;121;132;120;123;123;136;172;125 12:53:10 INFO - PROCESS | 28602 | |12;stanford-crypto-pbkdf2;167;160;159;160;161;164;160;165;160;160 12:53:10 INFO - PROCESS | 28602 | |13;stanford-crypto-sha256-iterative;66;66;64;63;64;64;64;69;65;61 12:53:10 INFO - PROCESS | 28602 | __end_tp_report 12:53:10 INFO - PROCESS | 28602 | __start_cc_report 12:53:10 INFO - PROCESS | 28602 | _x_x_mozilla_cycle_collect,1623 12:53:10 INFO - PROCESS | 28602 | __end_cc_report 12:53:10 INFO - PROCESS | 28602 | __startTimestamp1475178790561__endTimestamp 12:53:10 INFO - PROCESS | 28602 | 12:53:10 INFO - PROCESS | 28602 | ------- Summary: start ------- 12:53:10 INFO - PROCESS | 28602 | Number of tests: 14 12:53:10 INFO - PROCESS | 28602 | 12:53:10 INFO - PROCESS | 28602 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.25 (1.1%) stddev-sans-first:0.87 12:53:10 INFO - PROCESS | 28602 | Values: 108.0 110.0 111.0 112.0 111.0 110.0 112.0 112.0 111.0 110.0 12:53:10 INFO - PROCESS | 28602 | 12:53:10 INFO - PROCESS | 28602 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:121.50 stddev:17.86 (14.7%) stddev-sans-first:18.15 12:53:10 INFO - PROCESS | 28602 | Values: 144.0 117.0 117.0 157.0 123.0 120.0 120.0 116.0 162.0 118.0 12:53:10 INFO - PROCESS | 28602 | 12:53:10 INFO - PROCESS | 28602 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 12:53:10 INFO - PROCESS | 28602 | Values: 160.0 160.0 160.0 159.0 160.0 160.0 162.0 160.0 161.0 163.0 12:53:10 INFO - PROCESS | 28602 | 12:53:10 INFO - PROCESS | 28602 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:11.71 (15.4%) stddev-sans-first:12.28 12:53:10 INFO - PROCESS | 28602 | Values: 76.0 77.0 77.0 109.0 76.0 75.0 75.0 75.0 96.0 75.0 12:53:10 INFO - PROCESS | 28602 | 12:53:10 INFO - PROCESS | 28602 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:82.00 stddev:15.04 (18.3%) stddev-sans-first:15.60 12:53:10 INFO - PROCESS | 28602 | Values: 82.0 83.0 125.0 82.0 82.0 83.0 102.0 82.0 82.0 106.0 12:53:10 INFO - PROCESS | 28602 | 12:53:10 INFO - PROCESS | 28602 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.50 stddev:0.94 (0.8%) stddev-sans-first:1.00 12:53:10 INFO - PROCESS | 28602 | Values: 117.0 116.0 116.0 118.0 116.0 116.0 117.0 118.0 118.0 118.0 12:53:10 INFO - PROCESS | 28602 | 12:53:10 INFO - PROCESS | 28602 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 12:53:10 INFO - PROCESS | 28602 | Values: 146.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 12:53:10 INFO - PROCESS | 28602 | 12:53:10 INFO - PROCESS | 28602 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:53:10 INFO - PROCESS | 28602 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 12:53:10 INFO - PROCESS | 28602 | 12:53:10 INFO - PROCESS | 28602 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.00 stddev:3.68 (7.1%) stddev-sans-first:3.86 12:53:10 INFO - PROCESS | 28602 | Values: 51.0 63.0 51.0 51.0 51.0 53.0 52.0 52.0 52.0 51.0 12:53:10 INFO - PROCESS | 28602 | 12:53:10 INFO - PROCESS | 28602 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:1.49 (2.5%) stddev-sans-first:1.54 12:53:10 INFO - PROCESS | 28602 | Values: 59.0 60.0 59.0 59.0 59.0 60.0 60.0 60.0 60.0 64.0 12:53:10 INFO - PROCESS | 28602 | 12:53:10 INFO - PROCESS | 28602 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.50 stddev:1.55 (2.0%) stddev-sans-first:1.64 12:53:10 INFO - PROCESS | 28602 | Values: 79.0 79.0 79.0 78.0 78.0 78.0 78.0 78.0 83.0 78.0 12:53:10 INFO - PROCESS | 28602 | 12:53:10 INFO - PROCESS | 28602 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:124.00 stddev:15.83 (12.8%) stddev-sans-first:16.61 12:53:10 INFO - PROCESS | 28602 | Values: 123.0 120.0 121.0 132.0 120.0 123.0 123.0 136.0 172.0 125.0 12:53:10 INFO - PROCESS | 28602 | 12:53:10 INFO - PROCESS | 28602 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:160.50 stddev:2.72 (1.7%) stddev-sans-first:2.06 12:53:10 INFO - PROCESS | 28602 | Values: 167.0 160.0 159.0 160.0 161.0 164.0 160.0 165.0 160.0 160.0 12:53:10 INFO - PROCESS | 28602 | 12:53:10 INFO - PROCESS | 28602 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.50 stddev:2.12 (3.3%) stddev-sans-first:2.19 12:53:10 INFO - PROCESS | 28602 | Values: 66.0 66.0 64.0 63.0 64.0 64.0 64.0 69.0 65.0 61.0 12:53:10 INFO - PROCESS | 28602 | -------- Summary: end -------- 12:53:10 INFO - PROCESS | 28602 | 12:53:11 INFO - TEST-INFO | 28602: exit 0 12:53:11 INFO - TEST-OK | kraken | took 61820ms 12:53:11 INFO - SUITE-END | took 1178s 12:53:12 INFO - Completed test suite (00:19:39) 12:53:12 INFO - javascript benchmark 12:53:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2975.8660860261284, 3012.819230846148, 3020.7734419918497, 3033.2416895776055, 3064.494358430859, 5138.640295179339, 5225.399079105904, 5228.0, 5288.550473209777, 5329.120695085311, 5219.660722053064, 5267.315249017632, 5365.463453654643, 5393.649412788176, 5435.972820135904, 4783.952160478386, 4829.782659780319, 4841.491643377448, 4876.561109500144, 4949.455559888409, 4862.246351815475, 4897.3878265216845, 4966.950330496703, 5020.523050310215, 5022.974885125569, 4894.755262236874, 4906.362172917534, 4944.986277813057, 4967.403911530621, 4999.525045120708, 4714.38712967312, 4754.286856971447, 4782.450018247911, 4835.05716385305, 4840.273958906157, 4786.736729479877, 4806.375171227718, 4806.831760888387, 4810.11012962603, 4870.09903167915, 5337.066013447631, 5380.977614253279, 5403.972980135074, 5404.432534583891, 5406.378266499363, 5460.372057213432, 5536.833894983117, 5621.269234999465, 5658.943410565883, 5761.049426844607, 5760.423957604248, 5778.855528611776, 5795.1017592273265, 5798.710064496759, 5841.415858414167, 5400.243965844785, 5404.540614047811, 5404.972975135099, 5406.621536492447, 5407.459254074601, 5602.439756024365, 5645.661260324394, 5758.222639943554, 5776.566757493205, 5797.420257974253, 5576.1356989666665, 5583.664980101125, 5590.301212348457, 5657.8019769307875, 5659.745311460994, 5639.238702775073, 5659.349174844946, 5667.376588575254, 5667.744951477193, 5669.064604340238, 5555.111182210827, 5593.524550413179, 5660.462256085665, 5661.66030038199, 5664.405237450091, 5629.521490673339, 5637.7181140942785, 5674.432556744293, 5695.914561281584, 5749.022666146765, 4371.562843715603, 4373.540778218305, 4413.691041627056, 4417.271150260235, 4426.64586833059, 3911.9608803912165, 3922.1371298314325, 3925.156091440354, 3925.646691797752, 3968.265870813909, 5283.762230699628, 5330.040592693353, 5337.8131765388025, 5444.50999410055, 5506.559475241971, 5692.089265717465, 5692.971535142297, 5700.600957932905, 5701.344345400332, 5702.087665973508, 5401.378841433207, 5439.020976224318, 5452.100403433389, 5461.044317244467, 5462.0, 4950.801967921315, 5003.7998480061115, 5006.724630145304, 5006.774695138727, 5061.848144555669, 5916.585838991229, 5920.585559010828, 5925.762969481259, 5933.673647949404, 5954.583179177416, 5545.7781688732, 5604.467575580314, 5656.123300888369, 5726.770929162787, 5746.540276777764, 5936.851578710567, 5943.227380440515, 5945.464908158114, 5945.851353716192, 5998.820035398945, 5605.915911261416, 5650.23721797552, 5652.434756524314, 5653.067243904709, 5656.490915817596, 5540.584456165884, 5600.187972744011, 5695.886082278248, 5730.541556675373, 5735.971320143372, 5623.971880140573, 5627.577931655224, 5628.409017053151, 5671.149327600893, 5696.060150075191, 5538.889222215614, 5567.665940043448, 5570.805021824217, 5571.13647384656, 5586.994341018656, 5384.165454354581, 5435.83692489226, 5464.562834973272, 5516.297014462804, 5524.889502209853, 5621.2411324472305, 5627.493525582717, 5646.2942132233475, 5726.198332233574, 5732.082866741302, 5532.474414930575, 5541.307336582927, 5548.861278468071, 5549.639273447213, 5551.861203469945], "value": 5263.380834912869, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.9549283803716, 610.8564487345474, 617.5214208988036, 621.9004959206528, 642.0, 32161.839190804072, 42441.36337954933, 43649.34525982113, 43674.126517469675, 47216.291755623606, 44629.0, 44696.553034469645, 44804.0, 44991.10017799642, 45169.09661806762, 8030.317423019051, 8828.955855220715, 8978.191962723353, 8982.461052336848, 8983.95508022459, 8036.598170091501, 10753.51609177585, 11118.054965327958, 11125.332480051182, 11125.388103654295, 10969.177311701615, 11024.0, 11030.448477576128, 11042.0, 11043.447827608628, 10840.620578279762, 10871.402072885989, 10895.83656245157, 10910.23628346016, 10911.181661375389, 10576.36541807494, 10622.734431639194, 10623.25637205396, 10631.415272160028, 10634.57461701531, 41149.794251028856, 41312.0, 41339.793301033606, 41377.37933930993, 41491.377629335584, 3331.566896303489, 3373.4939759036097, 3838.9808050959846, 4018.819153138116, 4134.937975930364, 31125.37749245025, 31142.22144446407, 31430.0, 31440.842795786102, 33274.500882486784, 4300.419443375167, 4406.713563618355, 4548.385967894358, 4581.496035436099, 4582.564656357641, 359334.0, 360870.0, 361623.0, 362272.0, 363078.0, 57930.710346447995, 57965.13052304134, 58278.70860645754, 58360.0, 58394.70802645959, 60387.0, 60415.69792151099, 60427.18718438454, 60542.394576054554, 60546.69726651339, 14119.0, 14164.220967846868, 14188.574342769733, 14198.077124987049, 14246.715065698629, 10809.081228095543, 10813.56745730162, 10922.890771092187, 10997.670069897917, 12132.757344853053, 15928.362865485482, 16475.6704865902, 16756.413525526546, 16884.915575422045, 16889.577760556083, 6259.685466052089, 6286.151369565142, 6311.684415779193, 6381.298057213703, 6392.232932048091, 920.8756817829641, 955.4506158958627, 1031.2162756305263, 1065.893410658928, 1086.3916206923989, 31278.218044548612, 32329.35341293208, 32900.67099329024, 33291.33669306498, 35609.465858012154, 1034.7464871106476, 1044.185535282481, 1116.0290547223967, 1123.601121601836, 1150.2408410449063, 15860.92069539645, 16750.581235468966, 16826.0, 16903.408380706616, 17142.0, 510941.0, 514844.0, 515252.0, 515946.0, 518934.0, 56259.71870140623, 56775.0, 56817.14774278389, 56889.43110568841, 56902.43097569054, 1230.975380492385, 1283.7047479079863, 1285.68500717323, 1298.7857003594302, 1340.3499302838115, 29082.12753617395, 32361.0, 32837.34325313528, 32840.671593284715, 33292.50061249132, 48818.0, 49402.50597493979, 49427.258591121885, 49453.75273123611, 49459.0, 384486.0, 387811.0, 388222.0, 388265.0, 388710.0, 27367.452650947267, 28370.43259134847, 28371.432571348043, 28420.715792842635, 28452.85773571119, 46110.76944615255, 46168.07663846637, 47153.0, 47212.7639361801, 47664.0, 39914.401283981344, 40785.59214407818, 41138.79430602828, 41804.163916720885, 42621.57378426176, 40251.396229056, 40498.0, 40818.79590602147, 41568.58431415647, 41909.79045104755, 39825.20349592934, 41633.58366416297, 42003.57996419997, 42496.78751606222, 42523.36214956716, 31261.687383126788, 36338.45492317565, 36833.447498288086, 36927.81536092302, 37033.259334813694, 27743.0, 27810.443791124468, 27966.44067118687, 28203.576946345413, 28282.434351312448], "value": 20101.873649895897, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.47737599488704, 392.5074032089727, 405.5923796584433, 410.11824577159115, 423.83894120234305, 13699.246541440218, 15500.06999580026, 19297.0, 19515.60968780627, 20203.59592808143, 18530.814691853077, 18905.24379024841, 19056.618867622637, 19524.121414536345, 19526.707099393487, 4349.369341445488, 5032.547070763621, 5185.55922746567, 5192.844214673566, 5207.791688332462, 5069.44236134025, 5092.643514953955, 5127.154019586782, 5127.410347810012, 5134.512221338967, 4932.125792198959, 5122.948770512285, 5124.308218390525, 5127.5128862758165, 5130.871728206806, 5006.399232092136, 5072.0, 5076.44159142494, 5081.339425874649, 5081.745912704387, 4932.704037757746, 4955.182394904872, 4958.628102892298, 4960.23116416956, 4960.851174464772, 20766.377008689764, 21852.016659250214, 21873.78126218749, 22176.445588860246, 22223.0, 2089.226986015169, 2100.2859027930426, 2123.384218576611, 2152.1929276521305, 2201.1085510368325, 9362.36654848511, 9530.761730956781, 9715.417074975525, 9952.154066904322, 10036.247281453847, 1743.6338368942538, 1812.8187181281899, 1895.3176856331709, 1906.4852489827808, 1927.296536764085, 73080.26919730788, 80951.99999999942, 81017.59491202566, 81782.59108704478, 82823.58588207081, 10739.946300268448, 10989.505472253768, 11181.881811818754, 11185.217034807485, 11238.7190320241, 15767.68464630724, 15771.68456630861, 15786.052836829827, 15790.763138552931, 15799.526014219591, 7668.501547399401, 7773.727919522903, 7988.241117093867, 8108.675652973933, 8179.304759095425, 7451.44114191427, 7459.962700186465, 7537.057867766529, 7736.419768517271, 7739.806504837424, 4779.426468823764, 4785.138675038457, 4801.831935882227, 4807.326974223612, 4891.388576427947, 1977.6835706286925, 2011.215625905898, 2014.405750303664, 2014.8992550372423, 2029.9086541105685, 919.5723988345452, 926.5129467205173, 1015.5988384588194, 1020.9795804084025, 1047.3087762076993, 18549.721754173697, 19399.0, 19570.315038973567, 19602.0, 19786.802131978497, 1006.6476733143488, 1007.4308015970953, 1022.9283950123569, 1034.1054987435964, 1034.5758239121924, 10194.337368071052, 10722.78554428907, 10772.784544309226, 10840.728981775519, 10843.457827108614, 451814.0, 461141.0, 464916.0, 464953.0, 466615.0, 94263.52868235615, 98248.50875745718, 98734.5063274679, 98752.50623746835, 100500.0, 1010.8079464901646, 1052.5053224984244, 1075.1022895882027, 1076.8546246256656, 1081.7025318037602, 17552.82447175512, 17569.297228110732, 18292.72560911614, 18311.35910243135, 18463.35378261808, 39850.0, 40131.799341003105, 41204.58795412008, 41409.79295103626, 41678.0, 56570.717146414005, 57517.0, 57653.13520297115, 58854.7057264711, 59804.0, 8075.152109028468, 8186.631601578062, 8272.751817445485, 8282.627281772215, 8614.569271536273, 10923.726906827074, 13144.80282795778, 13170.209787412787, 13490.662733431744, 13764.105333153313, 11262.38056906878, 11610.12924030718, 11705.122115841175, 11889.821652675044, 12396.0, 10781.299215550964, 11125.299995528185, 11187.32876027441, 11330.886691132982, 11370.886291137314, 12011.63965081049, 12065.155439119528, 12123.272603643809, 12137.939310303393, 12494.625161245178, 7848.568328741746, 8045.034595848536, 8107.918920810716, 8226.0, 8500.659973600987, 10735.677929662123, 11288.661340159808, 11340.829887551528, 11740.765184696429, 11810.881891181321], "value": 8977.277134971464, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.548906116451, 1474.0860666386834, 1490.5677353567462, 1650.4223521767376, 1818.154558130469, 7865.567393793339, 8530.0, 8845.33659975502, 8854.070322616113, 9009.90990090099, 9063.139001794836, 9114.088591140882, 9123.771905702344, 9136.725898223047, 9144.451332920029, 2404.362843846382, 2404.843685160468, 2421.2978236311446, 2423.684920960273, 2425.915092971746, 2377.108584280895, 2396.6405039244078, 2437.6709144265565, 2440.7803297703203, 2444.2300675287315, 2372.757743931985, 2388.152205966883, 2398.8200884933613, 2412.95174096518, 2422.697162854643, 2336.754640762721, 2342.7540108288554, 2346.483773569812, 2372.146027430124, 2395.2574701842486, 2296.402935236834, 2308.3075077476856, 2310.838241323108, 2312.6184179610345, 2314.328844635054, 8675.869861952076, 8753.47479151253, 8829.514376709278, 9045.954770226106, 9073.0, 5147.330846989905, 5357.946420535823, 5368.30212072432, 5369.40936496985, 5378.0, 3576.6959808416054, 3615.891523254307, 3654.689351405134, 3661.4141737322166, 3665.596784353719, 1147.5983405807983, 1148.4430051425052, 1153.2907262033789, 1175.9118066144988, 1194.1103877611235, 12295.139340246187, 12342.382880855921, 12392.380380981005, 12416.627501174979, 12501.49994000239, 4401.405810215644, 4623.907521849612, 4757.833475828329, 4803.663743537919, 4820.325154478376, 9646.938836727953, 9655.22758179344, 9659.275554333453, 9661.13049825519, 9661.855072173923, 5298.470152984671, 5306.495882891119, 5321.813736519203, 5324.494173053554, 5325.094733895247, 4367.978160109179, 4518.412606361152, 4789.3055506952, 4869.440014398389, 4893.559579637778, 3903.4144878268485, 3926.784026878549, 3977.622125898035, 3987.4218238355274, 4049.8380064797666, 1220.3166226912779, 1221.993890030562, 1228.6621179175797, 1233.7964235900977, 1248.126311581878, 996.1831298335441, 1003.8544411060501, 1014.8934361891895, 1016.3698506925754, 1032.865727455426, 6145.815625531151, 6225.501959843202, 6265.686715664198, 6270.592411493239, 6518.641474718841, 440.467034887783, 447.9888002799956, 450.7025363260233, 452.7736131934033, 459.7839015662633, 4305.913881722348, 4370.431843860278, 4379.1241751649795, 4434.5343738907595, 4476.462824461086, 10969.83545246822, 11300.604478843201, 11350.432478376048, 11377.658670239905, 11385.658430247106, 10575.471226438647, 11082.113430925669, 11242.55029798799, 11264.774704505864, 11288.209825312313, 8056.959715201504, 8261.504309741435, 8266.751997440086, 8271.2142346477, 8282.958585207036, 6289.937100628935, 6463.870722585616, 6502.642354670538, 6545.476361891133, 6721.495887808532, 10277.715285589302, 10584.947075264883, 10624.575016999233, 10724.356538607708, 10736.838947415952, 10820.89179108199, 10824.079953204066, 10927.344359338465, 10952.890471095507, 10956.123510119012, 7170.533915295489, 7464.738734144279, 7465.888011679937, 7964.880526791987, 8076.83846323082, 8487.702930397407, 9054.909450905407, 9056.27549796028, 9058.003619601706, 9060.365774395992, 7865.567393793396, 7919.247671471201, 8016.118226995142, 8126.553039582644, 8178.059523154913, 7820.921790782019, 7831.530108193527, 7855.882161767692, 7866.331361834308, 8046.798830029296, 7228.421726261781, 7334.6699398526125, 7345.595992220479, 7345.926540734525, 7347.7795666130105, 4998.400191976986, 5073.239014147907, 5132.12753831842, 5285.550728188147, 5444.292242008513, 5444.6188766785945, 5460.31746031746, 5536.501714845684, 5564.610477266552, 5677.0], "value": 4657.016286498427, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.421271159374, 312.99996511146895, 315.6448994880759, 322.8643969532796, 325.9796835903622, 5110.872228194297, 5212.2963399941, 5280.419153893074, 5337.973310133449, 5363.168708850129, 5068.46781087986, 5154.94323663649, 5181.404138524071, 5185.222216667502, 5240.213967904807, 4061.878143655695, 4067.4102255172984, 4073.7352072115364, 4079.3473044312914, 4081.3469844824835, 3908.609139086083, 4070.3949472337727, 4074.982883472685, 4118.588141185887, 4121.505419349667, 4060.314969287757, 4065.2885744994655, 4070.837166513336, 4082.4080508326424, 4095.344744840826, 4033.7176397652174, 4049.1496785674894, 4050.25070361984, 4067.6949228807957, 4071.7149799514045, 3409.710174635159, 3496.230829217568, 3506.63180366063, 3521.4893840393, 3588.22853086585, 5106.872328191825, 5110.693358398471, 5115.948840511622, 5119.692818430906, 5127.384713834326, 4534.88662783433, 4601.83893563727, 4602.6087782538525, 4603.309503574457, 4626.79703277147, 5194.818181363672, 5375.784968601251, 5422.783088676449, 5440.809571664972, 5451.291332126838, 3850.210706805098, 3853.7880416577077, 3859.9614003859883, 3860.4595356650093, 3884.0, 5650.180723795027, 5652.802151924704, 5681.630694004918, 5692.914606280868, 5694.202811606337, 3856.46009558662, 3914.706397020235, 3922.646961773454, 3961.187956468917, 4009.719319647597, 4009.538903026131, 4019.2162528307285, 4029.9395509067385, 4034.3141665916864, 4037.5558688544825, 4622.214223581999, 4622.422197225347, 4623.722576645412, 4648.97675511627, 4653.650976176733, 5364.892702145935, 5432.945670543323, 5472.972635136878, 5504.0, 5540.722963851791, 1347.9663008424673, 1376.3393571085735, 1377.7864431013209, 1379.544750232421, 1379.744747221747, 867.7093173786726, 877.4077497689034, 900.2123142250531, 913.7441516375426, 913.7624217703445, 4741.502142275081, 4752.3584316116885, 4777.856664300077, 4809.615230781529, 4821.927671084936, 4979.502049794992, 5002.174206414633, 5009.89980200394, 5023.120953833065, 5054.342935418372, 4419.690621656453, 4738.47876733559, 4755.216793702361, 4755.667103302736, 4760.714357138583, 2611.4385407137556, 2625.6324114623967, 2637.472505498908, 2638.6569745932907, 2644.3917898883365, 5102.647798333444, 5108.19049522761, 5129.973660404194, 5134.2812006319145, 5155.252488389163, 5015.3480047593575, 5036.823711170165, 5068.23976403535, 5373.865653358619, 5814.738336774855, 5840.620359676607, 5852.4147585241135, 5853.678047707332, 5854.326752423441, 5894.911576326273, 5584.497395234448, 5632.324121105494, 5670.177824215548, 5670.262865827416, 5676.17695434168, 5496.945030549643, 5548.472895074961, 5584.274044374368, 5610.438956104357, 5620.325560932714, 5838.036723940672, 5847.561432892465, 5854.5609079320075, 5856.765729370948, 5864.533866533367, 3741.943870841994, 3824.4454554090057, 3839.328117579357, 3977.2642061218767, 4009.5565596384695, 5477.917831232615, 5486.256871564218, 5524.972375138099, 5541.974734674098, 5555.30558680165, 5415.106507426231, 5445.53712934405, 5454.945450545602, 5475.780968761205, 5476.397596264487, 5270.73646317675, 5395.3525576931015, 5415.050581790473, 5415.238228503413, 5424.698072462502, 5360.731963401737, 5372.534715108811, 5377.408485066718, 5383.2463455117095, 5395.271638328775, 5256.132738098324, 5406.2701535292235, 5441.0478166319945, 5470.6991115487435, 5497.147942068986, 5309.867253318698, 5367.248585198154, 5373.677579345252, 5390.110631745718, 5402.351717793733], "value": 4078.2753771778857, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.9344858962693, 740.0601236429734, 743.6765007221856, 790.1150711203451, 832.8292699996501, 14835.0, 15688.058716477019, 16036.75944860828, 16088.276027578759, 16103.677926441464, 14488.20314882681, 14727.410903563845, 14784.260786960636, 14785.55643330699, 14838.18389988553, 786.1548835002367, 804.0793291681022, 807.90709068457, 808.6118663041714, 809.6194788449419, 670.9161354830646, 687.6286805125252, 786.3709032773787, 803.9477433966773, 806.4959400374765, 855.5508358111979, 857.8927634045745, 857.9056303806576, 858.1675774498726, 858.5149390594295, 851.7998270406449, 851.8722191671268, 853.1937319233327, 853.7524118005801, 854.5171977832536, 511.47829214201676, 524.7376311844077, 600.9248843894513, 613.5674349583533, 620.3052581109187, 14443.0, 14459.493917712934, 14506.347214375379, 14510.201938893357, 14518.0, 12869.806952895715, 13034.608961731163, 13191.966055991737, 13475.865241347658, 13540.661483462894, 12312.630621081382, 12525.812112818316, 12595.370231488389, 12595.811062834066, 12822.294773787438, 4259.382389553529, 4281.143771245732, 4296.806643701009, 4365.083332500179, 4505.346724724929, 66722.33277667259, 68755.96866047013, 70311.0, 83163.58418207931, 83571.16428835694, 10979.451027448597, 11138.721531961766, 11500.25248358854, 11508.424578771028, 11552.537898483966, 21450.463738406666, 21482.14071437125, 21514.13943442276, 21620.56758864814, 21720.0, 8287.709930152536, 8471.745847624581, 8587.355948303903, 8643.697470588499, 8711.25954293892, 4608.170529304691, 4718.952810471851, 4733.810647574127, 4812.422509298836, 4937.950620493821, 3281.0812972367776, 3346.9163270917934, 3365.0914253151514, 3404.7957122572725, 3425.845836937344, 569.954134163814, 573.2032474859948, 575.576950941058, 578.8957987562195, 598.5843480169455, 636.2142753699178, 650.3561474140566, 663.6449499517735, 705.8706070287601, 709.9006139140421, 8092.225586903755, 8524.616392262364, 8782.253508451726, 9211.355205135576, 9221.031791661913, 586.3374386942727, 589.9705014749331, 601.2424345324922, 612.4120843989731, 628.84593274648, 4239.872803815891, 4324.805383757738, 4327.740335579875, 4335.176316499855, 4415.227335216325, 98185.50907245418, 127179.0, 127466.0, 133667.0, 134004.0, 93717.0, 96059.0, 96318.51840740751, 97135.51432242793, 97713.5114324438, 58810.0, 86376.56811716026, 86670.96651617163, 88547.55726221327, 93071.53464232771, 8785.780355491164, 8850.0, 9226.769330766785, 9229.86155207659, 9383.390079644802, 50700.74649626728, 50815.237771432716, 50919.23621145612, 52849.0, 52980.20529692135, 68720.3127968714, 75311.24688753042, 75968.0, 76724.0, 76911.0, 12238.510459581874, 12256.571020014257, 12603.306818125091, 12647.114701970773, 12659.620211393672, 13616.319184040956, 13731.313434328444, 14091.436342546593, 14297.0, 14660.266986650839, 13351.732965340832, 13397.53108641193, 13743.106698064594, 13835.79246311286, 14300.141991480545, 13203.933980330037, 13606.25165615861, 14086.22525761093, 14263.286835658384, 14726.0, 13910.443582256596, 14182.858171418155, 14544.0, 14601.26993650292, 14985.175815330262, 10269.948650256702, 10810.783784324427, 11064.944675276573, 11355.659330220107, 11426.885731142915, 10709.410982396043, 11314.773704525698, 11346.773064538498, 11472.770544589228, 11512.251703639236], "value": 7425.117028987265, "unit": "score"}], "name": "dromaeo_css", "value": 7153.13905838367, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 111.0, 112.0, 111.0, 110.0, 112.0, 112.0, 111.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 117.0, 157.0, 123.0, 120.0, 120.0, 116.0, 162.0, 118.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 160.0, 160.0, 162.0, 160.0, 161.0, 163.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 109.0, 76.0, 75.0, 75.0, 75.0, 96.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 125.0, 82.0, 82.0, 83.0, 102.0, 82.0, 82.0, 106.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 118.0, 116.0, 116.0, 117.0, 118.0, 118.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 63.0, 51.0, 51.0, 51.0, 53.0, 52.0, 52.0, 52.0, 51.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 64.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 78.0, 78.0, 78.0, 78.0, 78.0, 83.0, 78.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 120.0, 121.0, 132.0, 120.0, 123.0, 123.0, 136.0, 172.0, 125.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 160.0, 159.0, 160.0, 161.0, 164.0, 160.0, 165.0, 160.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 64.0, 63.0, 64.0, 64.0, 64.0, 69.0, 65.0, 61.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1477.1999999999998, "alertThreshold": 2.0}]} 12:53:12 INFO - Return code: 0 12:53:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:53:12 INFO - # TBPL SUCCESS # 12:53:12 INFO - Running post-action listener: _resource_record_post_action 12:53:12 INFO - [mozharness: 2016-09-29 19:53:12.364504Z] Finished run-tests step (success) 12:53:12 INFO - Running post-run listener: _resource_record_post_run 12:53:12 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392892416; Read time: 12; Write time: 321308 12:53:12 INFO - TinderboxPrint: CPU usage
13.1% 12:53:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:53:12 INFO - TinderboxPrint: I/O write bytes / time
392,892,416 / 321,308 12:53:12 INFO - TinderboxPrint: CPU idle
8,294.5 (86.9%) 12:53:12 INFO - TinderboxPrint: CPU user
1,197.8 (12.6%) 12:53:12 INFO - TinderboxPrint: Swap in / out
0 / 0 12:53:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103100416; Read time: 0; Write time: 73252 12:53:12 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287199232; Read time: 0; Write time: 247852 12:53:12 INFO - Running post-run listener: _upload_blobber_files 12:53:12 INFO - Blob upload gear active. 12:53:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:53:12 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 12:53:12 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'] 12:53:12 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 12:53:13 INFO - (blobuploader) - INFO - Open directory for files ... 12:53:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:53:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:53:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:53:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:53:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:53:14 INFO - (blobuploader) - INFO - Done attempting. 12:53:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:53:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:53:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:53:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:53:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:53:18 INFO - (blobuploader) - INFO - Done attempting. 12:53:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:53:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:53:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:53:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:53:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:53:18 INFO - (blobuploader) - INFO - Done attempting. 12:53:18 INFO - (blobuploader) - INFO - Iteration through files over. 12:53:18 INFO - Return code: 0 12:53:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:53:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:53:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1716d216456ebe85dcfe79eb57fd723385d1ed8a10b6513a9c8c510dc0cd57038287f6d3b790cdc75df7d7b70f2ea8caa6098c611cf67aed5502a979382dbac4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/859684c0bfa50319c51056caadd8b5b4eadfed073204d8d229340bdf8108c2d3f233c855bbfd796df379ff49d8cefd8ca972e5dbccfe1f4190555aa8e128c521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6ec15616015798ed92e77b2fa3adf8e472f633b9b88f52ace59855a326aa071b818d726a9bee85dc15fbdfce8a3ff95bf204432c793195afdbdaab792ac9e088"} 12:53:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:53:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:53:18 INFO - Contents: 12:53:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1716d216456ebe85dcfe79eb57fd723385d1ed8a10b6513a9c8c510dc0cd57038287f6d3b790cdc75df7d7b70f2ea8caa6098c611cf67aed5502a979382dbac4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/859684c0bfa50319c51056caadd8b5b4eadfed073204d8d229340bdf8108c2d3f233c855bbfd796df379ff49d8cefd8ca972e5dbccfe1f4190555aa8e128c521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6ec15616015798ed92e77b2fa3adf8e472f633b9b88f52ace59855a326aa071b818d726a9bee85dc15fbdfce8a3ff95bf204432c793195afdbdaab792ac9e088"} 12:53:18 INFO - Running post-run listener: copy_logs_to_upload_dir 12:53:18 INFO - Copying logs to upload dir... 12:53:18 INFO - mkdir: /builds/slave/test/build/upload/logs 12:53:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.640185 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-29 12:53:18.498490) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 12:53:18.502082) ========= 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=920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1716d216456ebe85dcfe79eb57fd723385d1ed8a10b6513a9c8c510dc0cd57038287f6d3b790cdc75df7d7b70f2ea8caa6098c611cf67aed5502a979382dbac4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/859684c0bfa50319c51056caadd8b5b4eadfed073204d8d229340bdf8108c2d3f233c855bbfd796df379ff49d8cefd8ca972e5dbccfe1f4190555aa8e128c521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6ec15616015798ed92e77b2fa3adf8e472f633b9b88f52ace59855a326aa071b818d726a9bee85dc15fbdfce8a3ff95bf204432c793195afdbdaab792ac9e088"} build_url:https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011554 build_url: 'https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1716d216456ebe85dcfe79eb57fd723385d1ed8a10b6513a9c8c510dc0cd57038287f6d3b790cdc75df7d7b70f2ea8caa6098c611cf67aed5502a979382dbac4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/859684c0bfa50319c51056caadd8b5b4eadfed073204d8d229340bdf8108c2d3f233c855bbfd796df379ff49d8cefd8ca972e5dbccfe1f4190555aa8e128c521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6ec15616015798ed92e77b2fa3adf8e472f633b9b88f52ace59855a326aa071b818d726a9bee85dc15fbdfce8a3ff95bf204432c793195afdbdaab792ac9e088"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 12:53:18.527796) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:53:18.528124) ========= 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=920470bf432669ad7e3a5387000001ca-1475177556.993474-405483890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:53:18.610472) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 12:53:18.610802) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 12:53:18.611101) ========= ========= Total master_lag: 0.16 =========