builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1475777969.01 results: success (0) buildid: 20161006093016 builduid: 75d1746684a34a19913dc8ca260ddfb5 revision: 7ff5c0b99e1936648eb6209703b8670da757f851 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 11:19:29.010465) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 11:19:29.011211) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 11:19:29.011637) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 11:19:29.026242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 11:19:29.026609) ========= 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=14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 11:19:29-- 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% 222M=0s 2016-10-06 11:19:29 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119637 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 11:19:29.160173) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 11:19:29.160501) ========= 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=14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017423 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 11:19:29.210569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 11:19:29.211005) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7ff5c0b99e1936648eb6209703b8670da757f851 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 7ff5c0b99e1936648eb6209703b8670da757f851 --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=14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 11:19:29,282 truncating revision to first 12 chars 2016-10-06 11:19:29,282 Setting DEBUG logging. 2016-10-06 11:19:29,282 attempt 1/10 2016-10-06 11:19:29,282 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7ff5c0b99e19?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 11:19:30,553 unpacking tar archive at: fx-team-7ff5c0b99e19/testing/mozharness/ program finished with exit code 0 elapsedTime=1.592782 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 11:19:30.817601) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 11:19:30.817987) ========= script_repo_revision: 7ff5c0b99e1936648eb6209703b8670da757f851 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 11:19:30.818473) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 11:19:30.818783) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 11:19:30.828431) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-06 11:19:30.828787) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:19:30 INFO - MultiFileLogger online at 20161006 11:19:30 in /builds/slave/test 11:19:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:19:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:19:30 INFO - {'append_to_log': False, 11:19:30 INFO - 'base_work_dir': '/builds/slave/test', 11:19:30 INFO - 'blob_upload_branch': 'Fx-Team', 11:19:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:19:30 INFO - 'branch': 'Fx-Team', 11:19:30 INFO - 'buildbot_json_path': 'buildprops.json', 11:19:30 INFO - 'config_files': ('talos/linux_config.py',), 11:19:30 INFO - 'default_actions': ('clobber', 11:19:30 INFO - 'read-buildbot-config', 11:19:30 INFO - 'download-and-extract', 11:19:30 INFO - 'populate-webroot', 11:19:30 INFO - 'create-virtualenv', 11:19:30 INFO - 'install', 11:19:30 INFO - 'run-tests'), 11:19:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:19:30 INFO - 'download_minidump_stackwalk': True, 11:19:30 INFO - 'download_symbols': 'ondemand', 11:19:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:19:30 INFO - 'tooltool.py': '/tools/tooltool.py', 11:19:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:19:30 INFO - '/tools/misc-python/virtualenv.py')}, 11:19:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:19:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:19:30 INFO - 'installer_path': 'installer.exe', 11:19:30 INFO - 'log_level': 'info', 11:19:30 INFO - 'log_name': 'talos', 11:19:30 INFO - 'log_to_console': True, 11:19:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:19:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:19:30 INFO - 'opt_config_files': (), 11:19:30 INFO - 'pip_index': False, 11:19:30 INFO - 'sps_profile': False, 11:19:30 INFO - 'sps_profile_interval': 0, 11:19:30 INFO - 'suite': 'dromaeojs', 11:19:30 INFO - 'system_bits': '32', 11:19:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:19:30 INFO - 'title': 'talos-linux64-ix-036', 11:19:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:19:30 INFO - 'use_talos_json': True, 11:19:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:19:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:19:30 INFO - 'work_dir': 'build'} 11:19:30 INFO - [mozharness: 2016-10-06 18:19:30.996268Z] Running clobber step. 11:19:30 INFO - Running pre-action listener: _resource_record_pre_action 11:19:30 INFO - Running main action method: clobber 11:19:30 INFO - rmtree: /builds/slave/test/build 11:19:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:19:31 INFO - Running post-action listener: _resource_record_post_action 11:19:31 INFO - [mozharness: 2016-10-06 18:19:31.463847Z] Finished clobber step (success) 11:19:31 INFO - [mozharness: 2016-10-06 18:19:31.463947Z] Running read-buildbot-config step. 11:19:31 INFO - Running pre-action listener: _resource_record_pre_action 11:19:31 INFO - Running main action method: read_buildbot_config 11:19:31 INFO - Using buildbot properties: 11:19:31 INFO - { 11:19:31 INFO - "project": "", 11:19:31 INFO - "product": "firefox", 11:19:31 INFO - "script_repo_revision": "production", 11:19:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:19:31 INFO - "repository": "", 11:19:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:19:31 INFO - "buildid": "20161006093016", 11:19:31 INFO - "pgo_build": "True", 11:19:31 INFO - "basedir": "/builds/slave/test", 11:19:31 INFO - "buildnumber": 510, 11:19:31 INFO - "slavename": "talos-linux64-ix-036", 11:19:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:19:31 INFO - "platform": "ubuntu64_hw", 11:19:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:19:31 INFO - "branch": "fx-team", 11:19:31 INFO - "repo_path": "integration/fx-team", 11:19:31 INFO - "revision": "7ff5c0b99e1936648eb6209703b8670da757f851", 11:19:31 INFO - "stage_platform": "linux64-pgo", 11:19:31 INFO - "builduid": "75d1746684a34a19913dc8ca260ddfb5", 11:19:31 INFO - "slavebuilddir": "test" 11:19:31 INFO - } 11:19:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 11:19:31 INFO - Running post-action listener: _resource_record_post_action 11:19:31 INFO - [mozharness: 2016-10-06 18:19:31.466388Z] Finished read-buildbot-config step (success) 11:19:31 INFO - [mozharness: 2016-10-06 18:19:31.466478Z] Running download-and-extract step. 11:19:31 INFO - Running pre-action listener: _resource_record_pre_action 11:19:31 INFO - Running main action method: download_and_extract 11:19:31 INFO - mkdir: /builds/slave/test/build/tests 11:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:31 INFO - trying https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:19:31 INFO - Downloading https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/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 11:19:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/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 11:19:32 INFO - Downloaded 1361 bytes. 11:19:32 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:19:32 INFO - Using the following test package requirements: 11:19:32 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:19:32 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:19:32 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:19:32 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:32 INFO - u'jsshell-linux-x86_64.zip'], 11:19:32 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:19:32 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:19:32 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:19:32 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:19:32 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:19:32 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:19:32 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:19:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:19:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:19:32 INFO - Fetch https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:19:32 INFO - Http code: 200 11:19:32 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 11:19:32 INFO - x-amz-cf-id: IuJvy5c4u-vVI8lxn7fmw6sSSV0gjPXVAxkwNFkuzW1RbI1QMAtQYw== 11:19:32 INFO - x-amz-version-id: HAFY0vqa4Ktt9ZgsBY6rS7I6meKQXRNp 11:19:32 INFO - Expected file size: 22017942 11:19:32 INFO - Obtained file size: 22017942 11:19:36 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 11:19:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:19:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:19:37 INFO - Fetch https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:19:37 INFO - Http code: 200 11:19:37 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 11:19:37 INFO - x-amz-cf-id: N3OHe2NsRgl79jcoEXugAyxAF2a3boATvAkFfPEqaJqXrqCfZ-pDcA== 11:19:37 INFO - x-amz-version-id: HAFY0vqa4Ktt9ZgsBY6rS7I6meKQXRNp 11:19:37 INFO - Expected file size: 22017942 11:19:37 INFO - Obtained file size: 22017942 11:19:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 11:19:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:19:42 INFO - Fetch https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:19:42 INFO - Http code: 200 11:19:42 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 11:19:42 INFO - x-amz-cf-id: 5iFDd1SKlu1JhOp5_gzXIAEHt70TXz79ZnY-vAzRM8wewX3yOBUyGQ== 11:19:42 INFO - x-amz-version-id: npIBOPJWXB.HC5HcRmTnEaPltIQC_c2R 11:19:43 INFO - Expected file size: 14409006 11:19:43 INFO - Obtained file size: 14409006 11:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:43 INFO - trying https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:19:43 INFO - Downloading https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/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 11:19:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/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 11:19:44 INFO - Downloaded 59698595 bytes. 11:19:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:19:44 INFO - mkdir: /builds/slave/test/properties 11:19:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:19:44 INFO - Writing to file /builds/slave/test/properties/build_url 11:19:44 INFO - Contents: 11:19:44 INFO - build_url:https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:19:45 INFO - Running post-action listener: _resource_record_post_action 11:19:45 INFO - Running post-action listener: set_extra_try_arguments 11:19:45 INFO - [mozharness: 2016-10-06 18:19:45.094245Z] Finished download-and-extract step (success) 11:19:45 INFO - [mozharness: 2016-10-06 18:19:45.094472Z] Running populate-webroot step. 11:19:45 INFO - Running pre-action listener: _resource_record_pre_action 11:19:45 INFO - Running main action method: populate_webroot 11:19:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:19:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:19:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:19:45 INFO - '--tppagecycles', 11:19:45 INFO - '7'], 11:19:45 INFO - 'tests': ['tsvgm']}}, 11:19:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:19:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:19:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:19:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:19:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:19:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:19:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:45 INFO - 'talos_options': ['--disable-e10s'], 11:19:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:19:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:19:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:45 INFO - 'talos_options': ['--disable-e10s'], 11:19:45 INFO - 'tests': ['damp', 'tps']}, 11:19:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:45 INFO - 'tests': ['damp', 'tps']}, 11:19:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:19:45 INFO - 'tests': ['dromaeo_dom']}, 11:19:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:19:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:19:45 INFO - 'tests': ['basic_compositor_video']}, 11:19:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:19:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:19:45 INFO - 'tests': ['a11yr', 11:19:45 INFO - 'ts_paint', 11:19:45 INFO - 'tpaint', 11:19:45 INFO - 'sessionrestore', 11:19:45 INFO - 'sessionrestore_no_auto_restore', 11:19:45 INFO - 'tabpaint']}, 11:19:45 INFO - 'other-e10s': {'tests': ['a11yr', 11:19:45 INFO - 'ts_paint', 11:19:45 INFO - 'tpaint', 11:19:45 INFO - 'sessionrestore', 11:19:45 INFO - 'sessionrestore_no_auto_restore', 11:19:45 INFO - 'tabpaint']}, 11:19:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:19:45 INFO - 'ts_paint', 11:19:45 INFO - 'tpaint', 11:19:45 INFO - 'sessionrestore', 11:19:45 INFO - 'sessionrestore_no_auto_restore', 11:19:45 INFO - 'tabpaint']}, 11:19:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:19:45 INFO - 'ts_paint', 11:19:45 INFO - 'tpaint', 11:19:45 INFO - 'sessionrestore', 11:19:45 INFO - 'sessionrestore_no_auto_restore', 11:19:45 INFO - 'tabpaint']}, 11:19:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:19:45 INFO - 'tests': ['a11yr', 11:19:45 INFO - 'ts_paint', 11:19:45 INFO - 'tpaint', 11:19:45 INFO - 'sessionrestore', 11:19:45 INFO - 'sessionrestore_no_auto_restore', 11:19:45 INFO - 'tabpaint']}, 11:19:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:19:45 INFO - 'tests': ['a11yr', 11:19:45 INFO - 'ts_paint', 11:19:45 INFO - 'tpaint', 11:19:45 INFO - 'sessionrestore', 11:19:45 INFO - 'sessionrestore_no_auto_restore', 11:19:45 INFO - 'tabpaint']}, 11:19:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:19:45 INFO - 'tests': ['tsvgx', 11:19:45 INFO - 'tsvgr_opacity', 11:19:45 INFO - 'tart', 11:19:45 INFO - 'tscrollx', 11:19:45 INFO - 'cart']}, 11:19:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:19:45 INFO - 'tsvgr_opacity', 11:19:45 INFO - 'tart', 11:19:45 INFO - 'tscrollx', 11:19:45 INFO - 'cart']}, 11:19:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:45 INFO - 'talos_options': ['--disable-e10s'], 11:19:45 INFO - 'tests': ['tp5o']}, 11:19:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:45 INFO - 'tests': ['tp5o']}, 11:19:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:45 INFO - 'talos_options': ['--disable-e10s', 11:19:45 INFO - '--xperf_path', 11:19:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:19:45 INFO - 'tests': ['tp5n']}, 11:19:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:45 INFO - 'talos_options': ['--xperf_path', 11:19:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:19:45 INFO - 'tests': ['tp5n']}}, 11:19:45 INFO - 'talos.zip': {'path': '', 11:19:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:19:45 INFO - Running post-action listener: _resource_record_post_action 11:19:45 INFO - [mozharness: 2016-10-06 18:19:45.114665Z] Finished populate-webroot step (success) 11:19:45 INFO - [mozharness: 2016-10-06 18:19:45.114753Z] Running create-virtualenv step. 11:19:45 INFO - Running pre-action listener: _resource_record_pre_action 11:19:45 INFO - Running main action method: create_virtualenv 11:19:45 INFO - Creating virtualenv /builds/slave/test/build/venv 11:19:45 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 11:19:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:19:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:19:45 INFO - Using real prefix '/usr' 11:19:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:19:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:19:47 INFO - Installing pip.................done. 11:19:47 INFO - Return code: 0 11:19:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:19:47 INFO - Reading from file tmpfile_stdout 11:19:47 INFO - Output received: 11:19:47 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) 11:19:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:19:47 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')]} 11:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:47 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')]} 11:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:47 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 0x7fd4dbae1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', '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 11:19:47 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 11:19:47 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 11:19:47 INFO - Using env: {'DISPLAY': ':0', 11:19:47 INFO - 'HOME': '/home/cltbld', 11:19:47 INFO - 'LANG': 'en_US.UTF-8', 11:19:47 INFO - 'LANGUAGE': 'en_US:en', 11:19:47 INFO - 'LOGNAME': 'cltbld', 11:19:47 INFO - 'MAIL': '/var/mail/cltbld', 11:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:47 INFO - 'MOZ_NO_REMOTE': '1', 11:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:47 INFO - 'NO_EM_RESTART': '1', 11:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:47 INFO - 'PWD': '/builds/slave/test', 11:19:47 INFO - 'SHELL': '/bin/bash', 11:19:47 INFO - 'SHLVL': '1', 11:19:47 INFO - 'TERM': 'linux', 11:19:47 INFO - 'TMOUT': '86400', 11:19:47 INFO - 'USER': 'cltbld', 11:19:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', 11:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:47 INFO - '_': '/tools/buildbot/bin/python'} 11:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:48 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 11:19:48 INFO - Cleaning up... 11:19:48 INFO - Return code: 0 11:19:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:19:48 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')]} 11:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:48 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')]} 11:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:48 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 0x7fd4dbae1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', '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 11:19:48 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 11:19:48 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 11:19:48 INFO - Using env: {'DISPLAY': ':0', 11:19:48 INFO - 'HOME': '/home/cltbld', 11:19:48 INFO - 'LANG': 'en_US.UTF-8', 11:19:48 INFO - 'LANGUAGE': 'en_US:en', 11:19:48 INFO - 'LOGNAME': 'cltbld', 11:19:48 INFO - 'MAIL': '/var/mail/cltbld', 11:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:48 INFO - 'MOZ_NO_REMOTE': '1', 11:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:48 INFO - 'NO_EM_RESTART': '1', 11:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:48 INFO - 'PWD': '/builds/slave/test', 11:19:48 INFO - 'SHELL': '/bin/bash', 11:19:48 INFO - 'SHLVL': '1', 11:19:48 INFO - 'TERM': 'linux', 11:19:48 INFO - 'TMOUT': '86400', 11:19:48 INFO - 'USER': 'cltbld', 11:19:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', 11:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:48 INFO - '_': '/tools/buildbot/bin/python'} 11:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:48 INFO - Downloading/unpacking psutil>=3.1.1 11:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:19:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:19:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:19:50 INFO - Installing collected packages: psutil 11:19:50 INFO - Running setup.py install for psutil 11:19:50 INFO - building 'psutil._psutil_linux' extension 11:19:50 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 11:19:50 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 11:19:50 INFO - building 'psutil._psutil_posix' extension 11:19:50 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 11:19:50 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 11:19:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:19:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:19:50 INFO - Successfully installed psutil 11:19:50 INFO - Cleaning up... 11:19:50 INFO - Return code: 0 11:19:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:19:50 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')]} 11:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:50 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')]} 11:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:50 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 0x7fd4dbae1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', '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 11:19:50 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 11:19:50 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 11:19:50 INFO - Using env: {'DISPLAY': ':0', 11:19:50 INFO - 'HOME': '/home/cltbld', 11:19:50 INFO - 'LANG': 'en_US.UTF-8', 11:19:50 INFO - 'LANGUAGE': 'en_US:en', 11:19:50 INFO - 'LOGNAME': 'cltbld', 11:19:50 INFO - 'MAIL': '/var/mail/cltbld', 11:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:50 INFO - 'MOZ_NO_REMOTE': '1', 11:19:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:50 INFO - 'NO_EM_RESTART': '1', 11:19:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:50 INFO - 'PWD': '/builds/slave/test', 11:19:50 INFO - 'SHELL': '/bin/bash', 11:19:50 INFO - 'SHLVL': '1', 11:19:50 INFO - 'TERM': 'linux', 11:19:50 INFO - 'TMOUT': '86400', 11:19:50 INFO - 'USER': 'cltbld', 11:19:50 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', 11:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:50 INFO - '_': '/tools/buildbot/bin/python'} 11:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:19:51 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 11:19:51 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 11:19:51 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 11:19:51 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 11:19:51 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 11:19:51 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 11:19:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:19:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:19:53 INFO - Installing collected packages: mozsystemmonitor 11:19:53 INFO - Running setup.py install for mozsystemmonitor 11:19:53 INFO - Successfully installed mozsystemmonitor 11:19:53 INFO - Cleaning up... 11:19:53 INFO - Return code: 0 11:19:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:19:53 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')]} 11:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:53 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')]} 11:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:53 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 0x7fd4dbae1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', '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 11:19:53 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 11:19:53 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 11:19:53 INFO - Using env: {'DISPLAY': ':0', 11:19:53 INFO - 'HOME': '/home/cltbld', 11:19:53 INFO - 'LANG': 'en_US.UTF-8', 11:19:53 INFO - 'LANGUAGE': 'en_US:en', 11:19:53 INFO - 'LOGNAME': 'cltbld', 11:19:53 INFO - 'MAIL': '/var/mail/cltbld', 11:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:53 INFO - 'MOZ_NO_REMOTE': '1', 11:19:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:53 INFO - 'NO_EM_RESTART': '1', 11:19:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:53 INFO - 'PWD': '/builds/slave/test', 11:19:53 INFO - 'SHELL': '/bin/bash', 11:19:53 INFO - 'SHLVL': '1', 11:19:53 INFO - 'TERM': 'linux', 11:19:53 INFO - 'TMOUT': '86400', 11:19:53 INFO - 'USER': 'cltbld', 11:19:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', 11:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:53 INFO - '_': '/tools/buildbot/bin/python'} 11:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:53 INFO - Downloading/unpacking jsonschema==2.5.1 11:19:53 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 11:19:53 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 11:19:53 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 11:19:53 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 11:19:53 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 11:19:53 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 11:19:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:19:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:19:55 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 11:19:55 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 11:19:55 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 11:19:55 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 11:19:55 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 11:19:55 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 11:19:55 INFO - Downloading functools32-3.2.3-2.tar.gz 11:19:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:19:55 INFO - warning: no files found matching '*.txt' 11:19:55 INFO - no previously-included directories found matching 'build' 11:19:55 INFO - no previously-included directories found matching 'dist' 11:19:55 INFO - no previously-included directories found matching '.git*' 11:19:55 INFO - Installing collected packages: jsonschema, functools32 11:19:55 INFO - Running setup.py install for functools32 11:19:55 INFO - warning: no files found matching '*.txt' 11:19:55 INFO - no previously-included directories found matching 'build' 11:19:55 INFO - no previously-included directories found matching 'dist' 11:19:55 INFO - no previously-included directories found matching '.git*' 11:19:55 INFO - Successfully installed jsonschema functools32 11:19:55 INFO - Cleaning up... 11:19:55 INFO - Return code: 0 11:19:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:19:55 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')]} 11:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:55 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')]} 11:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:55 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 0x7fd4dbae1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', '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 11:19:55 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 11:19:55 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 11:19:55 INFO - Using env: {'DISPLAY': ':0', 11:19:55 INFO - 'HOME': '/home/cltbld', 11:19:55 INFO - 'LANG': 'en_US.UTF-8', 11:19:55 INFO - 'LANGUAGE': 'en_US:en', 11:19:55 INFO - 'LOGNAME': 'cltbld', 11:19:55 INFO - 'MAIL': '/var/mail/cltbld', 11:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:55 INFO - 'MOZ_NO_REMOTE': '1', 11:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:55 INFO - 'NO_EM_RESTART': '1', 11:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:55 INFO - 'PWD': '/builds/slave/test', 11:19:55 INFO - 'SHELL': '/bin/bash', 11:19:55 INFO - 'SHLVL': '1', 11:19:55 INFO - 'TERM': 'linux', 11:19:55 INFO - 'TMOUT': '86400', 11:19:55 INFO - 'USER': 'cltbld', 11:19:55 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', 11:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:55 INFO - '_': '/tools/buildbot/bin/python'} 11:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:19:56 INFO - Cleaning up... 11:19:56 INFO - Return code: 0 11:19:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:19: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')]} 11:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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')]} 11:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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', '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 0x7fd4dbae1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', '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 11:19: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:19: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 blobuploader==1.2.4 11:19:56 INFO - Using env: {'DISPLAY': ':0', 11:19:56 INFO - 'HOME': '/home/cltbld', 11:19:56 INFO - 'LANG': 'en_US.UTF-8', 11:19:56 INFO - 'LANGUAGE': 'en_US:en', 11:19:56 INFO - 'LOGNAME': 'cltbld', 11:19:56 INFO - 'MAIL': '/var/mail/cltbld', 11:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:56 INFO - 'MOZ_NO_REMOTE': '1', 11:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:56 INFO - 'NO_EM_RESTART': '1', 11:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:56 INFO - 'PWD': '/builds/slave/test', 11:19:56 INFO - 'SHELL': '/bin/bash', 11:19:56 INFO - 'SHLVL': '1', 11:19:56 INFO - 'TERM': 'linux', 11:19:56 INFO - 'TMOUT': '86400', 11:19:56 INFO - 'USER': 'cltbld', 11:19:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', 11:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:56 INFO - '_': '/tools/buildbot/bin/python'} 11:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:56 INFO - Downloading/unpacking blobuploader==1.2.4 11:19: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 11:19: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 11:19: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 11:19: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 11:19: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 11:19: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 11:19:58 INFO - Downloading blobuploader-1.2.4.tar.gz 11:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:19:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:19:58 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 11:19:58 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 11:19:58 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 11:19:58 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 11:19:58 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 11:19:58 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 11:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:19:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:19:58 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 11:19:58 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 11:19:58 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 11:19:58 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 11:19:58 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 11:19:58 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 11:19:58 INFO - Downloading docopt-0.6.1.tar.gz 11:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:19:58 INFO - Installing collected packages: blobuploader, requests, docopt 11:19:58 INFO - Running setup.py install for blobuploader 11:19:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:19:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:19:59 INFO - Running setup.py install for requests 11:19:59 INFO - Running setup.py install for docopt 11:19:59 INFO - Successfully installed blobuploader requests docopt 11:19:59 INFO - Cleaning up... 11:19:59 INFO - Return code: 0 11:19:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19: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')]} 11:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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')]} 11:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:59 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 0x7fd4dbae1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', '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 11:19:59 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 11:19:59 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 11:19:59 INFO - Using env: {'DISPLAY': ':0', 11:19:59 INFO - 'HOME': '/home/cltbld', 11:19:59 INFO - 'LANG': 'en_US.UTF-8', 11:19:59 INFO - 'LANGUAGE': 'en_US:en', 11:19:59 INFO - 'LOGNAME': 'cltbld', 11:19:59 INFO - 'MAIL': '/var/mail/cltbld', 11:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:59 INFO - 'MOZ_NO_REMOTE': '1', 11:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:59 INFO - 'NO_EM_RESTART': '1', 11:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:59 INFO - 'PWD': '/builds/slave/test', 11:19:59 INFO - 'SHELL': '/bin/bash', 11:19:59 INFO - 'SHLVL': '1', 11:19:59 INFO - 'TERM': 'linux', 11:19:59 INFO - 'TMOUT': '86400', 11:19:59 INFO - 'USER': 'cltbld', 11:19:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', 11:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:59 INFO - '_': '/tools/buildbot/bin/python'} 11:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:19:59 INFO - Running setup.py (path:/tmp/pip-AGaaDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:19:59 INFO - Running setup.py (path:/tmp/pip-cE1K0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:19:59 INFO - Running setup.py (path:/tmp/pip-Uav5jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:00 INFO - Running setup.py (path:/tmp/pip-jYeB2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:00 INFO - Running setup.py (path:/tmp/pip-m6evDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:00 INFO - Running setup.py (path:/tmp/pip-a78bBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:00 INFO - Running setup.py (path:/tmp/pip-_W1BXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:00 INFO - Running setup.py (path:/tmp/pip-Yhrxll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:00 INFO - Running setup.py (path:/tmp/pip-1VgeSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:00 INFO - Running setup.py (path:/tmp/pip-W54fVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:00 INFO - Running setup.py (path:/tmp/pip-pHOFF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:00 INFO - Running setup.py (path:/tmp/pip-JlaOvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:00 INFO - Running setup.py (path:/tmp/pip-fPEkVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:00 INFO - Running setup.py (path:/tmp/pip-OJ2UjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:00 INFO - Running setup.py (path:/tmp/pip-1WfMji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:00 INFO - Running setup.py (path:/tmp/pip-vteUa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:00 INFO - Running setup.py (path:/tmp/pip-XDgO7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:20:01 INFO - Running setup.py install for manifestparser 11:20:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:20:01 INFO - Running setup.py install for mozcrash 11:20:01 INFO - Running setup.py install for mozdebug 11:20:01 INFO - Running setup.py install for mozdevice 11:20:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:20:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:20:01 INFO - Running setup.py install for mozfile 11:20:01 INFO - Running setup.py install for mozhttpd 11:20:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:20:01 INFO - Running setup.py install for mozinfo 11:20:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:20:01 INFO - Running setup.py install for mozInstall 11:20:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:20:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:20:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:20:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:20:01 INFO - Running setup.py install for mozleak 11:20:01 INFO - Running setup.py install for mozlog 11:20:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:20:02 INFO - Running setup.py install for moznetwork 11:20:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:20:02 INFO - Running setup.py install for mozprocess 11:20:02 INFO - Running setup.py install for mozprofile 11:20:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:20:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:20:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:20:02 INFO - Running setup.py install for mozrunner 11:20:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:20:02 INFO - Running setup.py install for mozscreenshot 11:20:02 INFO - Running setup.py install for moztest 11:20:02 INFO - Running setup.py install for mozversion 11:20:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:20:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:20:02 INFO - Cleaning up... 11:20:02 INFO - Return code: 0 11:20:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:02 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')]} 11:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:02 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')]} 11:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:02 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 0x7fd4dbae1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', '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 11:20:02 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 11:20:02 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 11:20:02 INFO - Using env: {'DISPLAY': ':0', 11:20:02 INFO - 'HOME': '/home/cltbld', 11:20:02 INFO - 'LANG': 'en_US.UTF-8', 11:20:02 INFO - 'LANGUAGE': 'en_US:en', 11:20:02 INFO - 'LOGNAME': 'cltbld', 11:20:02 INFO - 'MAIL': '/var/mail/cltbld', 11:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:02 INFO - 'MOZ_NO_REMOTE': '1', 11:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:02 INFO - 'NO_EM_RESTART': '1', 11:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:02 INFO - 'PWD': '/builds/slave/test', 11:20:02 INFO - 'SHELL': '/bin/bash', 11:20:02 INFO - 'SHLVL': '1', 11:20:02 INFO - 'TERM': 'linux', 11:20:02 INFO - 'TMOUT': '86400', 11:20:02 INFO - 'USER': 'cltbld', 11:20:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', 11:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:02 INFO - '_': '/tools/buildbot/bin/python'} 11:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:03 INFO - Running setup.py (path:/tmp/pip-tdsT8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:03 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)) 11:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:03 INFO - Running setup.py (path:/tmp/pip-DEAyU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:03 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)) 11:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:03 INFO - Running setup.py (path:/tmp/pip-CTOeEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:03 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)) 11:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:03 INFO - Running setup.py (path:/tmp/pip-y7V8nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:03 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)) 11:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:03 INFO - Running setup.py (path:/tmp/pip-Rg4Qlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:03 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)) 11:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:03 INFO - Running setup.py (path:/tmp/pip-PVmr9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:03 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)) 11:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:03 INFO - Running setup.py (path:/tmp/pip-CHPHAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:03 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)) 11:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:03 INFO - Running setup.py (path:/tmp/pip-vy9de9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:03 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)) 11:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:03 INFO - Running setup.py (path:/tmp/pip-vM_EME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:03 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)) 11:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:03 INFO - Running setup.py (path:/tmp/pip-mVMTXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:03 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)) 11:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:03 INFO - Running setup.py (path:/tmp/pip-dDspGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:03 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)) 11:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:03 INFO - Running setup.py (path:/tmp/pip-t7kYs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:03 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)) 11:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:03 INFO - Running setup.py (path:/tmp/pip-NZ8YPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:04 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)) 11:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:04 INFO - Running setup.py (path:/tmp/pip-XDc3Me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:04 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)) 11:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:04 INFO - Running setup.py (path:/tmp/pip-vn7TDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:04 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)) 11:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:04 INFO - Running setup.py (path:/tmp/pip-kY1mEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:04 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)) 11:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:04 INFO - Running setup.py (path:/tmp/pip-zIbfEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:04 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)) 11:20:04 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)) 11:20:04 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)) 11:20:04 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)) 11:20:04 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)) 11:20:04 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)) 11:20:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:20: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 11:20: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 11:20: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 11:20: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 11:20: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 11:20: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 11:20:06 INFO - Downloading blessings-1.6.tar.gz 11:20:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:20:06 INFO - Installing collected packages: blessings 11:20:06 INFO - Running setup.py install for blessings 11:20:06 INFO - Successfully installed blessings 11:20:06 INFO - Cleaning up... 11:20:06 INFO - Return code: 0 11:20:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:20:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:20:06 INFO - Reading from file tmpfile_stdout 11:20:06 INFO - Current package versions: 11:20:06 INFO - argparse == 1.2.1 11:20:06 INFO - blessings == 1.6 11:20:06 INFO - blobuploader == 1.2.4 11:20:06 INFO - docopt == 0.6.1 11:20:06 INFO - functools32 == 3.2.3-2 11:20:06 INFO - jsonschema == 2.5.1 11:20:06 INFO - manifestparser == 1.1 11:20:06 INFO - mozInstall == 1.12 11:20:06 INFO - mozcrash == 0.17 11:20:06 INFO - mozdebug == 0.1 11:20:06 INFO - mozdevice == 0.48 11:20:06 INFO - mozfile == 1.2 11:20:06 INFO - mozhttpd == 0.7 11:20:06 INFO - mozinfo == 0.9 11:20:06 INFO - mozleak == 0.1 11:20:06 INFO - mozlog == 3.4 11:20:06 INFO - moznetwork == 0.27 11:20:06 INFO - mozprocess == 0.23 11:20:06 INFO - mozprofile == 0.28 11:20:06 INFO - mozrunner == 6.12 11:20:06 INFO - mozscreenshot == 0.1 11:20:06 INFO - mozsystemmonitor == 0.3 11:20:06 INFO - moztest == 0.7 11:20:06 INFO - mozversion == 1.4 11:20:06 INFO - psutil == 3.1.1 11:20:06 INFO - requests == 1.2.3 11:20:06 INFO - wsgiref == 0.1.2 11:20:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:06 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 0x7fd4dbae1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', '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 11:20:06 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 11:20:06 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 11:20:06 INFO - Using env: {'DISPLAY': ':0', 11:20:06 INFO - 'HOME': '/home/cltbld', 11:20:06 INFO - 'LANG': 'en_US.UTF-8', 11:20:06 INFO - 'LANGUAGE': 'en_US:en', 11:20:06 INFO - 'LOGNAME': 'cltbld', 11:20:06 INFO - 'MAIL': '/var/mail/cltbld', 11:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:06 INFO - 'MOZ_NO_REMOTE': '1', 11:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:06 INFO - 'NO_EM_RESTART': '1', 11:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:06 INFO - 'PWD': '/builds/slave/test', 11:20:06 INFO - 'SHELL': '/bin/bash', 11:20:06 INFO - 'SHLVL': '1', 11:20:06 INFO - 'TERM': 'linux', 11:20:06 INFO - 'TMOUT': '86400', 11:20:06 INFO - 'USER': 'cltbld', 11:20:06 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', 11:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:06 INFO - '_': '/tools/buildbot/bin/python'} 11:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:06 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)) 11:20:06 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)) 11:20:06 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)) 11:20:06 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)) 11:20:06 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)) 11:20:06 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)) 11:20:06 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)) 11:20:06 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)) 11:20:06 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)) 11:20:06 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)) 11:20:06 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)) 11:20:06 INFO - Cleaning up... 11:20:06 INFO - Return code: 0 11:20:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4dbae1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', '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 11:20:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:20:06 INFO - Using env: {'DISPLAY': ':0', 11:20:06 INFO - 'HOME': '/home/cltbld', 11:20:06 INFO - 'LANG': 'en_US.UTF-8', 11:20:06 INFO - 'LANGUAGE': 'en_US:en', 11:20:06 INFO - 'LOGNAME': 'cltbld', 11:20:06 INFO - 'MAIL': '/var/mail/cltbld', 11:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:06 INFO - 'MOZ_NO_REMOTE': '1', 11:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:06 INFO - 'NO_EM_RESTART': '1', 11:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:06 INFO - 'PWD': '/builds/slave/test', 11:20:06 INFO - 'SHELL': '/bin/bash', 11:20:06 INFO - 'SHLVL': '1', 11:20:06 INFO - 'TERM': 'linux', 11:20:06 INFO - 'TMOUT': '86400', 11:20:06 INFO - 'USER': 'cltbld', 11:20:06 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', 11:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:06 INFO - '_': '/tools/buildbot/bin/python'} 11:20:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:20:07 INFO - Cleaning up... 11:20:07 INFO - Return code: 0 11:20:07 INFO - Running post-action listener: _resource_record_post_action 11:20:07 INFO - Running post-action listener: _start_resource_monitoring 11:20:07 INFO - Starting resource monitoring. 11:20:07 INFO - [mozharness: 2016-10-06 18:20:07.176812Z] Finished create-virtualenv step (success) 11:20:07 INFO - [mozharness: 2016-10-06 18:20:07.177277Z] Running install step. 11:20:07 INFO - Running pre-action listener: _resource_record_pre_action 11:20:07 INFO - Running main action method: install 11:20:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:20:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:20:07 INFO - Reading from file tmpfile_stdout 11:20:07 INFO - Detecting whether we're running mozinstall >=1.0... 11:20:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:20:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:20:07 INFO - Reading from file tmpfile_stdout 11:20:07 INFO - Output received: 11:20:07 INFO - Usage: mozinstall [options] installer 11:20:07 INFO - Options: 11:20:07 INFO - -h, --help show this help message and exit 11:20:07 INFO - -d DEST, --destination=DEST 11:20:07 INFO - Directory to install application into. [default: 11:20:07 INFO - "/builds/slave/test"] 11:20:07 INFO - --app=APP Application being installed. [default: firefox] 11:20:07 INFO - mkdir: /builds/slave/test/build/application 11:20:07 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'] 11:20:07 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 11:20:24 INFO - Reading from file tmpfile_stdout 11:20:24 INFO - Output received: 11:20:24 INFO - /builds/slave/test/build/application/firefox/firefox 11:20:24 INFO - Running post-action listener: _resource_record_post_action 11:20:24 INFO - [mozharness: 2016-10-06 18:20:24.497765Z] Finished install step (success) 11:20:24 INFO - [mozharness: 2016-10-06 18:20:24.498010Z] Running run-tests step. 11:20:24 INFO - Running pre-action listener: _resource_record_pre_action 11:20:24 INFO - Running main action method: run_tests 11:20:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:20:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:20:24 INFO - Python 2.7.3 11:20:24 INFO - Return code: 0 11:20:24 INFO - grabbing minidump binary from tooltool 11:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:24 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 0x20e3930>, '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 0x20e4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e4cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:20:24 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 11:20:24 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 11:20:24 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 11:20:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:20:24 INFO - Return code: 0 11:20:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:20:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:20:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:20:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:20:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:20:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 11:20:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 11:20:24 INFO - Using env: {'DISPLAY': ':0', 11:20:24 INFO - 'HOME': '/home/cltbld', 11:20:24 INFO - 'LANG': 'en_US.UTF-8', 11:20:24 INFO - 'LANGUAGE': 'en_US:en', 11:20:24 INFO - 'LOGNAME': 'cltbld', 11:20:24 INFO - 'MAIL': '/var/mail/cltbld', 11:20:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:20:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:24 INFO - 'MOZ_NO_REMOTE': '1', 11:20:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:20:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:24 INFO - 'NO_EM_RESTART': '1', 11:20:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:24 INFO - 'PWD': '/builds/slave/test', 11:20:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:20:24 INFO - 'SHELL': '/bin/bash', 11:20:24 INFO - 'SHLVL': '1', 11:20:24 INFO - 'TERM': 'linux', 11:20:24 INFO - 'TMOUT': '86400', 11:20:24 INFO - 'USER': 'cltbld', 11:20:24 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445', 11:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:24 INFO - '_': '/tools/buildbot/bin/python'} 11:20:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 11:20:24 INFO - mozversion application_buildid: 20161006093016 11:20:24 INFO - mozversion application_changeset: 7ff5c0b99e1936648eb6209703b8670da757f851 11:20:24 INFO - mozversion application_display_name: Nightly 11:20:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:20:24 INFO - mozversion application_name: Firefox 11:20:24 INFO - mozversion application_remotingname: firefox 11:20:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:20:24 INFO - mozversion application_vendor: Mozilla 11:20:24 INFO - mozversion application_version: 52.0a1 11:20:24 INFO - mozversion platform_buildid: 20161006093016 11:20:24 INFO - mozversion platform_changeset: 7ff5c0b99e1936648eb6209703b8670da757f851 11:20:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:20:24 INFO - mozversion platform_version: 52.0a1 11:20:24 INFO - using testdate: 1475778024 11:20:24 INFO - actual date: 1475778024 11:20:24 INFO - starting webserver on 'localhost:36177' 11:20:24 INFO - SUITE-START | Running 2 tests 11:20:24 INFO - TEST-START | dromaeo_css 11:20:24 INFO - operating with platform_type : linux_ 11:20:24 INFO - Initialising browser for dromaeo_css test... 11:20:24 INFO - TEST-INFO | started process 4825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDzHpN0/profile http://localhost:36177/getInfo.html) 11:20:29 INFO - PROCESS | 4825 | __metrics Screen width/height:1600/1200 11:20:29 INFO - PROCESS | 4825 | colorDepth:24 11:20:29 INFO - PROCESS | 4825 | Browser inner width/height: 1024/697 11:20:29 INFO - PROCESS | 4825 | __metrics 11:20:29 INFO - PROCESS | 4825 | 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" 11:20:29 INFO - PROCESS | 4825 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:20:30 INFO - PROCESS | 4825 | console.error: PushService: 11:20:30 INFO - PROCESS | 4825 | stateChangeProcessEnqueue: Error transitioning state 11:20:30 INFO - PROCESS | 4825 | UnknownError 11:20:31 INFO - TEST-INFO | 4825: exit 0 11:20:31 INFO - Browser initialized. 11:20:31 INFO - Running cycle 1/1 for dromaeo_css test... 11:20:31 INFO - TEST-INFO | started process 4910 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDzHpN0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:20:43 INFO - PROCESS | 4910 | RSS: Main: 178200576 11:20:43 INFO - PROCESS | 4910 | 11:21:34 INFO - PROCESS | 4910 | 1475778094939 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] 11:23:45 INFO - PROCESS | 4910 | Cycle 1(1): loaded http://localhost:36177/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36177/tests/dromaeo/cssquery-ext.html) 11:23:46 INFO - PROCESS | 4910 | RSS: Main: 289411072 11:23:46 INFO - PROCESS | 4910 | 11:26:48 INFO - PROCESS | 4910 | Cycle 1(1): loaded http://localhost:36177/tests/dromaeo/cssquery-ext.html (next: http://localhost:36177/tests/dromaeo/cssquery-jquery.html) 11:26:49 INFO - PROCESS | 4910 | RSS: Main: 278171648 11:26:49 INFO - PROCESS | 4910 | 11:29:51 INFO - PROCESS | 4910 | Cycle 1(1): loaded http://localhost:36177/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36177/tests/dromaeo/cssquery-mootools.html) 11:29:51 INFO - PROCESS | 4910 | RSS: Main: 217731072 11:29:51 INFO - PROCESS | 4910 | 11:32:53 INFO - PROCESS | 4910 | Cycle 1(1): loaded http://localhost:36177/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36177/tests/dromaeo/cssquery-prototype.html) 11:32:54 INFO - PROCESS | 4910 | RSS: Main: 217243648 11:32:54 INFO - PROCESS | 4910 | 11:35:57 INFO - PROCESS | 4910 | Cycle 1(1): loaded http://localhost:36177/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36177/tests/dromaeo/cssquery-yui.html) 11:35:57 INFO - PROCESS | 4910 | RSS: Main: 215728128 11:35:57 INFO - PROCESS | 4910 | 11:39:01 INFO - PROCESS | 4910 | Cycle 1(1): loaded http://localhost:36177/tests/dromaeo/cssquery-yui.html (next: http://localhost:36177/tests/dromaeo/cssquery-dojo.html) 11:39:01 INFO - PROCESS | 4910 | RSS: Main: 306913280 11:39:01 INFO - PROCESS | 4910 | 11:39:01 INFO - PROCESS | 4910 | __start_tp_report 11:39:01 INFO - PROCESS | 4910 | _x_x_mozilla_page_load 11:39:01 INFO - PROCESS | 4910 | _x_x_mozilla_page_load_details 11:39:01 INFO - PROCESS | 4910 | |i|pagename|runs| 11:39:01 INFO - PROCESS | 4910 | |0;dojo.html;2987.9701202987967;3027.303720144368;3028.4700177468935;3065.509518477044;3066.7853250272474;4980.551750342468;5088.7964481420695;5162.7934882604695;5224.45143259958;5240.973795131029;5033.395992480899;5115.514026167518;5145.845624631258;5177.6634518756255;5195.03891780021;4681.602063824562;4714.599259062984;4738.857834264978;4808.182608956486;4819;4708.717476951377;4766.571008609225;4784.449788274358;4811.615070794328;4857.829975950843;4728.432588089417;4747.620190384761;4768.809247630091;4779.522047795227;4830.541098595628;4577.862664120082;4611.746353950532;4653.720776753372;4697.741624210667;4716.882077948045;4679.906401871977;4691.132140554008;4692.2257827458425;4735.692180008323;4753.4771175171045;5121.2318152277085;5169.353830771153;5176.767045482925;5188.169892817131;5204.869878253036;5302.761375738101;5361.410244873061;5462.180672899057;5519.972400137974;5527.060399732055;5541.362743284533;5552.639078459928;5563.638363506359;5636.605437619368;5638.097904335286;5176.870578235536;5179.948200518022;5182.32629758129;5184.611154163415;5245.318108645852;5549.528290095387;5602.579806514446;5668;5674.347450043216;5676.432356764373;5429.67421954684;5498.945010549924;5503.229547863302;5516.255305533701;5574.526165275997;5522.861928451741;5558.666480011212;5581.079121944915;5582.665040097607;5585.413531579207;5404.216388623628;5511.476409741068;5573.554115670737;5578.3584887738425;5591.049521581341;5458.099413596791;5487.670739755627;5516;5539.41836107211;5547.334319881559;4324.1567894260315;4356.281213599784;4364.454443194601;4368.148211098805;4370.409994650745;3855.8264878079995;3860.208657225262;3865.8260378283044;3908.4528166056775;3912;5321.388040375329;5327.9733601331745;5331.226972089103;5331.573474122061;5384.542313903362;5449.264349312872;5455.345358556999;5484.945150548523;5486.533644640251;5535.8339249821765;5272.130098533776;5280.102382594891;5293.973530132324;5294.54996325309;5344.732763361816;4823.083614113307;4827.662063655511;4830.372051633265;4833.130036593377;4886.65793394459;5555.916661250004;5684;5751.079827227707;5769.221155144086;5771.711414429262;5514.476124768141;5538.44615538459;5556.91664625039;5579.776808927598;5639.88720225585;5765.654060756368;5774.566907481872;5784.4504772046585;5784.566157538117;5787.5369970401425;5296.735163241746;5470.753816078366;5471.8084867029465;5482.23248745168;5485.698286594116;5432.320959880015;5479.315085614298;5507.972460137674;5512.80705175317;5609.915851262316;5332.520073193431;5343.839684809462;5371.5702743781185;5373.462653734595;5373.758180881948;5352.277442545206;5353.705546194841;5357.1696387060065;5365.570754339566;5370.650907690988;5156.278121063129;5211.166213405837;5346.919796202982;5400.891982160413;5434.64674796137;5497.065498865282;5511.421300763523;5526.723663816712;5528.668279903219;5568.192612071146;5241.842744717512;5297.735113244245;5398.865028374322;5414.431484694051;5414.972925135349 11:39:01 INFO - PROCESS | 4910 | |1;ext.html;563.2677519225007;592.2360155399534;594.0940066398741;601.293480160811;613.3069631316612;30375.392492150142;30888.227794305152;41613.375799363;42362.36456453148;42407.15185696284;39907.60092399075;44071.33892991608;44498.77750611243;44588.55411445884;44613.33080003803;8752.737417877473;8917.063708310632;8921;8925.73222803317;8929.374943753939;7975.840483190333;8158.632861521216;10296.794064118712;10497.790044199111;10499.580016799318;10695.78608427831;10782.622608208714;10791.29856559325;10796.892031079668;10803.4058126803;7980.680772769082;10528.368297902112;10582.047615714622;10598.894011059907;10604.045635892806;7988.4408091433625;10042.096211341015;10332.896671033268;10335.328203666737;10654.09440197584;41394.79302603468;41690.58309416897;41898;41959.370609440884;42011;3440.3807314683345;3513.350030244413;3554.8578056877695;3590.35373632746;4002.8598999035185;31168.688313116807;31299.904503342274;31731;31838.20404489883;31941.201469963205;4163.854265100737;4293.141371725667;4297.0779869688595;4348.086901750637;4462.241418958784;325521;325548;326410;327306;327896;34799.65200348015;54357.45642543603;54621.453785461636;54764;54808.17787733187;35222.64777352194;36544;37001;37146.62853371486;37159;14910.627234319229;14930.40278388874;14989.175595342143;14999.475018374305;15103.244837758288;11133.165012623924;11385.544578216945;12231.877681223074;12280.877191228152;12288.201266917622;8362.205590469017;8602.91397086021;8605.139486051345;8612.224899759052;8675.522846243517;3280.1963518937537;3300.422426075427;3307.8676852926096;3356.1777364545355;3396.286779776225;908.5366463103733;977.296346630425;1075.2580719303655;1101.801675698366;1148.4257871064467;29665.85167074194;31315.686843131734;31385;31723.84138079295;32102.839485802888;1090.4711215060688;1099.9010089092021;1100.8238681810872;1131.7340425000284;1132.405487119269;15770.921145394199;16651.41720039793;16771.748423773653;16793.328266869434;16901;150086.24956875146;150645;150858.24570877076;151740.2412987928;151828;33615.99152025443;33720.49419258713;33731.83134084363;33734.831325843705;33798.831005845306;1205.5479195301762;1239.0645062977574;1285.081166965624;1302.374860067154;1303.8239837621988;27485.450290994468;31624.683753163095;31866;32088.83955580207;32362.190945226557;47873;53580.46419535755;54908.725456372464;55048;60732;467624;471315;472213;472719;473741;34022.48966265458;34415.48376774401;42665.306816250806;43124;43679;39458.60541394664;46475.76762116303;46591.30113048375;46633.53366466292;46773.766131169126;38087.23825523419;38233.4264986031;38991.415128772525;39791.80104099461;40206.59793402028;38618.42072368861;39094.4135837957;39148.80425597854;39723.80138099407;40164.79917600393;39529;40142.397864032646;40225;40375.1924961505;40444.797776010935;33480.832595836866;35660.82671366597;35887.28225435529;36084.09789755277;36250.27499450049;26994.460110798067;27350.726492735615;27490.450190995667;27595;27803 11:39:01 INFO - PROCESS | 4910 | |2;jquery.html;369.76335145506897;385.7087898636529;388.16738096782404;399.1179493319763;416.41493701349617;16592.419265325716;18690.15894284757;18808.811911880875;18820.62358752824;18848.151833167507;18253.452396428096;18473.261069557237;18797.530061748465;18861.15124819383;18872.33946811862;5385.246065550826;5477.4796394342475;5705.229793977802;5713.200151978726;5718;5428.45715428458;5501.9174712379345;5503.394626591072;5545.805896793613;5556.777728890839;5520.806771762989;5521.696306703129;5522.0336441122845;5523.364813046491;5526.336839579256;5697.290812756178;5795.913061304083;5806.187133801272;5818.883622327572;5821.56338274629;5469.15228139639;5624.803131890364;5641.210230567724;5647.29408823897;5697.230873832021;13788.241646709426;14054.508092216724;14101.435942562286;15436.614084647974;22247.888760556256;2201.2405720026563;2285.645724912641;2324.697789287382;2353.7881590656925;2359.622460406327;9939.50302484873;10030.197584193247;10036.397816130982;10529.684109476728;10611.734706632318;1834.8899066055947;1843.9213060359705;1869.7475840761458;1881.6142690748363;1894.479018269973;77847.61076194639;79070.20929790685;79811.20188798096;80437.19562804414;81178.59410702968;8582.957085214659;9056.320775941831;9323.673671421468;10796.136309095253;11792.23350482216;12673.619791406272;12718.872811271955;12731.745365092645;12738.29939353326;12894.355282236038;7691.846163076819;7718.807029824299;7827.452078354574;7828.2954534092205;7996.72011479607;7670.923290767021;7799.766007019798;7893.921060789434;8005.319547838499;8034;4030.9596904031173;4045.4943132108488;4112.91774164515;4186.958130418718;4225.345071513921;1937.5156210947264;1945.1538580717433;1984.7221389005551;1990.9402717918485;2024.7772744998038;897.2014906733012;906.9365144439957;942.58997336159;948.7533241357297;958.712386284112;17772;19443.805561944482;19645.50886227856;19667.90166049189;19793.505162371057;933.4865823796885;934.9766255843658;936.6721647423348;969.5588507229194;991.3655260633201;10169.796604068026;10784.40685762275;10863.348199108079;10928.781424371467;10929.890701093047;402647;406076;407198;415145;420425;83725;85575;89767;92569.5371523138;92901;991.9504024798731;1027.119114122135;1028.6708253359002;1029.5933106422922;1033.4832583708146;17116.400925968028;17261.741073884154;17869.46391608202;18085.186166622272;18356.724649130007;40107.1978560433;41201.587984119775;41752.824717528005;42047.186642612105;42241.78879105585;55175.44824551703;58730.412695872496;58848.70575647095;60688.39311606828;61491.38508614856;8083.434159608771;8158.4289099762445;8386.916130838614;8426.95786521088;8498.915010849812;9140.862887056566;12119.515219391478;12746.617601471971;12960.740785184433;13029.543965961146;10575.68272951782;11118.888811111785;11265.943670281596;11351.602693905674;11829.231099978819;10978.890211097787;10996.835047474455;11083.501242443948;11104.389258590854;11289.604863830054;10940.56237750513;11298.548058077586;11334.14993875446;11585.6524304271;11614.709632258922;7294.671739771617;7447.515911465737;7580.128285247267;7824.9608751955875;8900.955495222483;10052.949735251277;10619.469026548797;11045.613403530839;11466.31202127875;11521.654350369503 11:39:01 INFO - PROCESS | 4910 | |3;mootools.html;1338.1302153600152;1416.8583141685833;1459.2776575595078;1583.5510507885285;1766.6908291049072;7652.961735191323;8227.341812654988;8420.452670576407;8426.620802063906;8637.65449382024;8393;8508.276796472308;8516.23353898149;8519.57402129894;8521.488710677364;2257.638777795553;2286.7941885230325;2294.7934685878267;2296.1274715608047;2298.6322188449853;2208.823294136473;2252.538229662915;2255.571441426124;2256.5261295128043;2261.547690461906;2234.218023691711;2246.887655617221;2257.097161135551;2280.8631482111127;2283.292179424384;2148.8603240789457;2172.6415141501634;2176.075168053571;2179.1936983316195;2183.1922188790168;2119.109973811003;2124.5326028273907;2125.27740568206;2127.4043267885017;2128.4785227619177;8383.664653413856;8429.873551896726;8438.2827459666;8989.730308090768;9317.627294908196;5072;5191.169412893956;5192.740362981874;5197.402298735618;5199.376074871002;3200.3439294944483;3374.6287908330064;3433.261848702516;3433.399155147864;3454.602720687128;1051.0413186878989;1079.865016872891;1081.4862940103467;1087.12486448409;1105.0717397386154;12652.17760845542;12686.746265074738;12775.297358645365;12799.872001280055;12804;4210.936835947402;4302.806373713191;4431.667624928144;4438.17893689662;4468.798904049326;9819.410835349901;9860.753481163028;9862.01379862008;9865.704028879145;9869.555869985868;5145.742712864417;5150.175971844487;5152.845414637567;5154;5158.380994280636;3946.625070618287;4141.855035073758;4227.556106608823;4271.722338048017;4827.61379089672;3485.19840436701;3844.1927195288745;3881.378979363288;3892.844286228519;3911.198204368098;1118.7762447510531;1163.6043745126697;1165.7027457998327;1172.9296242225323;1184.3130984029242;842.5534466732641;869.599984007351;890.4479222881855;916.5508900638639;931.459753343073;5639.2668953035845;5832.62087964281;5930.377310382434;5961.582689211714;5987;898.4025622960788;932.5896605493562;932.883389576303;939.201678573221;964.8890377606525;3835.463035175078;3944.2703099926607;3996.9600303997167;4026.939595906064;4052.696047796427;10374.481275936172;11377.431128443544;11391.829122563167;11411.657650270505;11439.656810295704;11069.667909962714;11319.151063670257;11319.886801132048;11324.263922844988;11330.263532870502;8219.876701849476;8450.323974082181;8454;8468.110848360957;8473.872891906627;5593.300837395325;5643.379228284967;5683.516901063456;5700.173474846041;5761.337446193741;10167.288289819642;10387.37675739458;10424.322419042737;10434;10449.969508842654;9059.864102038342;10449;10475.476226188508;10631.627893023708;10754.516046777757;6676.599404035774;7184.820379490346;7269.200387957426;7432;7441.330280274801;8028.357731381592;8107.594620269081;8311.542865142475;8369.874451883348;8449.324054075536;7020.824479388056;7052.259512751088;7068.787936361918;7310.159331676712;7403.370713489414;7138.357547820513;7211.855762884608;7269.672864720995;7270.636468176675;7292.088488938883;6843.315668433117;6917.827054323682;6921.82695432598;6925.58446493212;6927.515073944775;4853.320535125156;4913.224514508827;4927.778249978688;4928.137575924127;5149.48505149482;4952.108620448354;5039.319691841554;5066.316047333563;5088.7201203932655;5173.275741396133 11:39:01 INFO - PROCESS | 4910 | |4;prototype.html;310.56210742852585;316.8463295301777;320.4328338840254;326.06257011093106;331.09940960587204;5260;5267.420583735786;5271.130263506521;5273.4179746076115;5306.310179676641;5173.534381905628;5174.266620682076;5202.427732949382;5216.183261039044;5224.085784987631;3814.1608846053823;3957.663598594123;3959.247742928834;4048.251073551388;4105.563052931465;4053.9797301013455;4056.492938382702;4066.166435880652;4069.125138095309;4076.429299898017;4013.8996525086814;4017.5982401759884;4022.275990321741;4054.1891621675636;4056.2090392373498;3814.4278358246206;3886.164474637938;3930.842766289359;4018.718689691723;4070.61329173728;3599.3341231872187;3599.892003239907;3613.6567026132475;3616.72874534411;3624.821932871801;5039.949600504021;5066.569341605968;5070.315507406527;5094.872628184288;5138.974305128488;4476.261416866213;4552.430946131733;4593.724376537419;4608.423947006624;4658.1848176568965;5362.6782393056155;5366.248725178478;5366.758495867695;5369;5369.167778994262;3903.1217975955465;3922.921541569181;3926.430667553189;3926.8429262829454;3933.5869733678123;5277.8416647500635;5561.388247292794;5573.934336115161;5596.496315331599;5662.178984047331;3926.09699769049;3926.332523471017;3960.2475529649273;3967.682585393162;3983.541892682321;4007.1384652299894;4011.1576568920855;4019.3569028955226;4028.395740638869;4031.3952907064177;4481.910361792811;4570.565796249351;4627.30590411441;4639.953600463952;4640.976795116003;5399.70301633414;5411.269478620415;5429.484199001088;5431.1757885899115;5441.782328706887;1376.5457399058287;1394.093839004635;1395.337214822951;1396.9034308068117;1397.9231142287272;845.1084106267946;880.423322723617;884.3941899798658;888.9865553269278;893.4148132972913;5048.899022019613;5163.225516172529;5184.662996905189;5321.574274058066;5326.082610260303;5584.274044374205;5587.580931430159;5591.832245032656;5593.720313984284;5595.804146854922;5138.820141295037;5216.400113986864;5287.41838397776;5322.8935421292135;5331.360236771612;2876.280929767558;2910.272431892027;2924.736773690378;2932.4281765055607;2936.6329208848892;5738.225339579187;5738.397468265855;5764;5780.248567686174;5800.738966746507;5345.919811202835;5629.155626655953;5630.127330263816;5661.603687741901;5667.234923285386;5796.217510636095;5814.011618024946;5822.710168754725;5832.562557808096;5835.708214589169;5394.595405344537;5577.581681373995;5602.439756024365;5612.85967850807;5628.690422026828;5569.303837020372;5575.498205161555;5596.832095037155;5605.635633683797;5606.775728970795;5890.764369425175;5900.498457631149;5903.439173278532;5922.644641321534;5933.258342707161;3956.0307724607655;4026.255142798592;4075.144219713775;4099.852041428405;4127.215828992482;5576.191452239484;5579.46995035471;5591.440855914376;5594.237815088234;5598.640815510661;5474.808381706621;5504.504594586507;5509.3664228612615;5512.724363781715;5519.2824932758485;5226.947730522798;5385;5433.744995826688;5448.782048718007;5516.172574113915;5439.836804895859;5443.8094666686475;5493.945060549343;5505.669659820263;5506.531944784738;5256.6320357574605;5371;5444.101723215784;5502.312210973629;5591.496765291144;5377.247185394126;5403.648762830403;5408.296921400193;5409.29679141709;5423.322084739408 11:39:01 INFO - PROCESS | 4910 | |5;yui.html;695.9652017399129;733.0799846193026;734.6473692627538;742.8551432470671;772.9149793522712;15264.313105910232;16018.199090045495;16487.83512164878;16491.257893394795;16493.83506164938;16300.755488667679;16564.66870662586;16569.50291491254;16573.17134143291;16588.66822663546;789.0097927101508;810.8013536683521;813.8168911994813;813.9226773456512;814.6293436486415;657.1686816177539;667.3793372163885;785.5286827903241;807.7657479331016;810.9270165685087;859.4198915731887;861.8621020636699;862.1550880137438;862.1938487514194;862.2024627219797;858.9484630922165;859.072202021815;859.4456575508793;859.6217664227751;860.1011942520081;500.0648786768729;507.2543361258943;603.0501959413897;612.9754809807603;627.6798832595364;15358.385664573403;15379.307931143125;15391.307391167313;15403.306851191723;15415.30631121591;13104;13181.275029873354;13570.864291357058;13589.660258493617;13777.228610718046;12371.731462885784;12455.252684838939;12483.812742808865;12655.557055503014;12782.488700451971;4277.893052673677;4348.543402942677;4366.28741414673;4389.692721509496;4400.713953593006;80054;80478;81173;81208.59395702984;81253.18746812515;10385.84421233682;10595.046445819913;10668.199885008655;11144.442777861075;11260.605878794202;18157.818421815613;20410.591788164154;20479.38561843147;20994.89502552508;20998.580028399345;8069.83860322802;8106.47307924983;8145.837083258301;8145.8370832584205;8149.022117345957;4529.5243999380245;4574.193193688475;4796.712197268105;4802.27965805132;4825.324454576362;3332.8333583320737;3409.130671678706;3428.6057103432927;3438.381091403571;3445.3109378123972;572.3589579670795;594.551113908996;595.0419824083223;597.2683462758173;600.216717184079;614.2966303582373;625.918630578022;649.2695717318018;680.0479328939425;681.9215790184093;7985.8402831944195;8660.653573856975;8908.510031948304;9130.589123489459;9570.377925434825;614.5728718540571;655.6131882189532;674.2212744280364;701.3652644356865;740.0712106306551;4133.4626498555;4311.784410779448;4388.451443569554;4416.24923762961;4511.975585065828;112845;114458.42770786093;114877;117222.41388793002;118607.03482413008;92381.53809231045;93372;97144.54283185757;97949;99593.50203249083;75987.24012759802;82455;82632;83413.58293208617;85619;8529.189726975927;8805.427647203167;8932.151445612657;8936.525473297093;9073.13805188506;49343;49538;50007.49992500029;51242;51400.228996564336;67529.66235168793;70940.29059709336;75351.24648753442;76437;78066.6096669513;12630.431630576462;12663.366831658564;12688.365581721062;12691.746165076831;12730.17253878495;14151.575452736435;14179.220142891827;14493.760044443296;14526.927365363106;14717.116972981656;12544.74910501803;13747.587572372844;14397.856021439651;14445.49440769568;14621.268936552917;13252;13256;13356.532521361705;13551.441584217548;13818.861811381757;12666.809997849856;14184;14192.36134373935;14628.853711462749;14649.194294313915;10522.158227341948;10641.627543035956;10644.201684873511;10874.945625271823;11181.944090279496;10614.469276536296;11464.598739044428;11486.483108259981;11528.444071815766;11670 11:39:01 INFO - PROCESS | 4910 | __end_tp_report 11:39:01 INFO - PROCESS | 4910 | __start_cc_report 11:39:01 INFO - PROCESS | 4910 | _x_x_mozilla_cycle_collect,1094 11:39:01 INFO - PROCESS | 4910 | __end_cc_report 11:39:01 INFO - PROCESS | 4910 | __startTimestamp1475779141549__endTimestamp 11:39:01 INFO - PROCESS | 4910 | 11:39:01 INFO - PROCESS | 4910 | ------- Summary: start ------- 11:39:01 INFO - PROCESS | 4910 | Number of tests: 6 11:39:01 INFO - PROCESS | 4910 | 11:39:01 INFO - PROCESS | 4910 | [#0] dojo.html Cycles:165 Average:5158.17 Median:5346.92 stddev:563.26 (10.5%) stddev-sans-first:538.65 11:39:01 INFO - PROCESS | 4910 | Values: 2988.0 3027.3 3028.5 3065.5 3066.8 4980.6 5088.8 5162.8 5224.5 5241.0 5033.4 5115.5 5145.8 5177.7 5195.0 4681.6 4714.6 4738.9 4808.2 4819.0 4708.7 4766.6 4784.4 4811.6 4857.8 4728.4 4747.6 4768.8 4779.5 4830.5 4577.9 4611.7 4653.7 4697.7 4716.9 4679.9 4691.1 4692.2 4735.7 4753.5 5121.2 5169.4 5176.8 5188.2 5204.9 5302.8 5361.4 5462.2 5520.0 5527.1 5541.4 5552.6 5563.6 5636.6 5638.1 5176.9 5179.9 5182.3 5184.6 5245.3 5549.5 5602.6 5668.0 5674.3 5676.4 5429.7 5498.9 5503.2 5516.3 5574.5 5522.9 5558.7 5581.1 5582.7 5585.4 5404.2 5511.5 5573.6 5578.4 5591.0 5458.1 5487.7 5516.0 5539.4 5547.3 4324.2 4356.3 4364.5 4368.1 4370.4 3855.8 3860.2 3865.8 3908.5 3912.0 5321.4 5328.0 5331.2 5331.6 5384.5 5449.3 5455.3 5484.9 5486.5 5535.8 5272.1 5280.1 5294.0 5294.5 5344.7 4823.1 4827.7 4830.4 4833.1 4886.7 5555.9 5684.0 5751.1 5769.2 5771.7 5514.5 5538.4 5556.9 5579.8 5639.9 5765.7 5774.6 5784.5 5784.6 5787.5 5296.7 5470.8 5471.8 5482.2 5485.7 5432.3 5479.3 5508.0 5512.8 5609.9 5332.5 5343.8 5371.6 5373.5 5373.8 5352.3 5353.7 5357.2 5365.6 5370.7 5156.3 5211.2 5346.9 5400.9 5434.6 5497.1 5511.4 5526.7 5528.7 5568.2 5241.8 5297.7 5398.9 5414.4 5415.0 11:39:01 INFO - PROCESS | 4910 | 11:39:01 INFO - PROCESS | 4910 | [#1] ext.html Cycles:180 Average:47885.98 Median:19156.50 stddev:91071.67 (475.4%) stddev-sans-first:91257.84 11:39:01 INFO - PROCESS | 4910 | Values: 563.3 592.2 594.1 601.3 613.3 30375.4 30888.2 41613.4 42362.4 42407.2 39907.6 44071.3 44498.8 44588.6 44613.3 8752.7 8917.1 8921.0 8925.7 8929.4 7975.8 8158.6 10296.8 10497.8 10499.6 10695.8 10782.6 10791.3 10796.9 10803.4 7980.7 10528.4 10582.0 10598.9 10604.0 7988.4 10042.1 10332.9 10335.3 10654.1 41394.8 41690.6 41898.0 41959.4 42011.0 3440.4 3513.4 3554.9 3590.4 4002.9 31168.7 31299.9 31731.0 31838.2 31941.2 4163.9 4293.1 4297.1 4348.1 4462.2 325521.0 325548.0 326410.0 327306.0 327896.0 34799.7 54357.5 54621.5 54764.0 54808.2 35222.6 36544.0 37001.0 37146.6 37159.0 14910.6 14930.4 14989.2 14999.5 15103.2 11133.2 11385.5 12231.9 12280.9 12288.2 8362.2 8602.9 8605.1 8612.2 8675.5 3280.2 3300.4 3307.9 3356.2 3396.3 908.5 977.3 1075.3 1101.8 1148.4 29665.9 31315.7 31385.0 31723.8 32102.8 1090.5 1099.9 1100.8 1131.7 1132.4 15770.9 16651.4 16771.7 16793.3 16901.0 150086.2 150645.0 150858.2 151740.2 151828.0 33616.0 33720.5 33731.8 33734.8 33798.8 1205.5 1239.1 1285.1 1302.4 1303.8 27485.5 31624.7 31866.0 32088.8 32362.2 47873.0 53580.5 54908.7 55048.0 60732.0 467624.0 471315.0 472213.0 472719.0 473741.0 34022.5 34415.5 42665.3 43124.0 43679.0 39458.6 46475.8 46591.3 46633.5 46773.8 38087.2 38233.4 38991.4 39791.8 40206.6 38618.4 39094.4 39148.8 39723.8 40164.8 39529.0 40142.4 40225.0 40375.2 40444.8 33480.8 35660.8 35887.3 36084.1 36250.3 26994.5 27350.7 27490.5 27595.0 27803.0 11:39:01 INFO - PROCESS | 4910 | 11:39:01 INFO - PROCESS | 4910 | [#2] jquery.html Cycles:180 Average:26192.14 Median:4038.23 stddev:68169.89 (1688.1%) stddev-sans-first:68333.55 11:39:01 INFO - PROCESS | 4910 | Values: 369.8 385.7 388.2 399.1 416.4 16592.4 18690.2 18808.8 18820.6 18848.2 18253.5 18473.3 18797.5 18861.2 18872.3 5385.2 5477.5 5705.2 5713.2 5718.0 5428.5 5501.9 5503.4 5545.8 5556.8 5520.8 5521.7 5522.0 5523.4 5526.3 5697.3 5795.9 5806.2 5818.9 5821.6 5469.2 5624.8 5641.2 5647.3 5697.2 13788.2 14054.5 14101.4 15436.6 22247.9 2201.2 2285.6 2324.7 2353.8 2359.6 9939.5 10030.2 10036.4 10529.7 10611.7 1834.9 1843.9 1869.7 1881.6 1894.5 77847.6 79070.2 79811.2 80437.2 81178.6 8583.0 9056.3 9323.7 10796.1 11792.2 12673.6 12718.9 12731.7 12738.3 12894.4 7691.8 7718.8 7827.5 7828.3 7996.7 7670.9 7799.8 7893.9 8005.3 8034.0 4031.0 4045.5 4112.9 4187.0 4225.3 1937.5 1945.2 1984.7 1990.9 2024.8 897.2 906.9 942.6 948.8 958.7 17772.0 19443.8 19645.5 19667.9 19793.5 933.5 935.0 936.7 969.6 991.4 10169.8 10784.4 10863.3 10928.8 10929.9 402647.0 406076.0 407198.0 415145.0 420425.0 83725.0 85575.0 89767.0 92569.5 92901.0 992.0 1027.1 1028.7 1029.6 1033.5 17116.4 17261.7 17869.5 18085.2 18356.7 40107.2 41201.6 41752.8 42047.2 42241.8 55175.4 58730.4 58848.7 60688.4 61491.4 8083.4 8158.4 8386.9 8427.0 8498.9 9140.9 12119.5 12746.6 12960.7 13029.5 10575.7 11118.9 11265.9 11351.6 11829.2 10978.9 10996.8 11083.5 11104.4 11289.6 10940.6 11298.5 11334.1 11585.7 11614.7 7294.7 7447.5 7580.1 7825.0 8901.0 10052.9 10619.5 11045.6 11466.3 11521.7 11:39:01 INFO - PROCESS | 4910 | 11:39:01 INFO - PROCESS | 4910 | [#3] mootools.html Cycles:180 Average:5687.24 Median:4920.50 stddev:3346.69 (68.0%) stddev-sans-first:3340.12 11:39:01 INFO - PROCESS | 4910 | Values: 1338.1 1416.9 1459.3 1583.6 1766.7 7653.0 8227.3 8420.5 8426.6 8637.7 8393.0 8508.3 8516.2 8519.6 8521.5 2257.6 2286.8 2294.8 2296.1 2298.6 2208.8 2252.5 2255.6 2256.5 2261.5 2234.2 2246.9 2257.1 2280.9 2283.3 2148.9 2172.6 2176.1 2179.2 2183.2 2119.1 2124.5 2125.3 2127.4 2128.5 8383.7 8429.9 8438.3 8989.7 9317.6 5072.0 5191.2 5192.7 5197.4 5199.4 3200.3 3374.6 3433.3 3433.4 3454.6 1051.0 1079.9 1081.5 1087.1 1105.1 12652.2 12686.7 12775.3 12799.9 12804.0 4210.9 4302.8 4431.7 4438.2 4468.8 9819.4 9860.8 9862.0 9865.7 9869.6 5145.7 5150.2 5152.8 5154.0 5158.4 3946.6 4141.9 4227.6 4271.7 4827.6 3485.2 3844.2 3881.4 3892.8 3911.2 1118.8 1163.6 1165.7 1172.9 1184.3 842.6 869.6 890.4 916.6 931.5 5639.3 5832.6 5930.4 5961.6 5987.0 898.4 932.6 932.9 939.2 964.9 3835.5 3944.3 3997.0 4026.9 4052.7 10374.5 11377.4 11391.8 11411.7 11439.7 11069.7 11319.2 11319.9 11324.3 11330.3 8219.9 8450.3 8454.0 8468.1 8473.9 5593.3 5643.4 5683.5 5700.2 5761.3 10167.3 10387.4 10424.3 10434.0 10450.0 9059.9 10449.0 10475.5 10631.6 10754.5 6676.6 7184.8 7269.2 7432.0 7441.3 8028.4 8107.6 8311.5 8369.9 8449.3 7020.8 7052.3 7068.8 7310.2 7403.4 7138.4 7211.9 7269.7 7270.6 7292.1 6843.3 6917.8 6921.8 6925.6 6927.5 4853.3 4913.2 4927.8 4928.1 5149.5 4952.1 5039.3 5066.3 5088.7 5173.3 11:39:01 INFO - PROCESS | 4910 | 11:39:01 INFO - PROCESS | 4910 | [#4] prototype.html Cycles:180 Average:4590.07 Median:5275.63 stddev:1360.63 (25.8%) stddev-sans-first:1325.99 11:39:01 INFO - PROCESS | 4910 | Values: 310.6 316.8 320.4 326.1 331.1 5260.0 5267.4 5271.1 5273.4 5306.3 5173.5 5174.3 5202.4 5216.2 5224.1 3814.2 3957.7 3959.2 4048.3 4105.6 4054.0 4056.5 4066.2 4069.1 4076.4 4013.9 4017.6 4022.3 4054.2 4056.2 3814.4 3886.2 3930.8 4018.7 4070.6 3599.3 3599.9 3613.7 3616.7 3624.8 5039.9 5066.6 5070.3 5094.9 5139.0 4476.3 4552.4 4593.7 4608.4 4658.2 5362.7 5366.2 5366.8 5369.0 5369.2 3903.1 3922.9 3926.4 3926.8 3933.6 5277.8 5561.4 5573.9 5596.5 5662.2 3926.1 3926.3 3960.2 3967.7 3983.5 4007.1 4011.2 4019.4 4028.4 4031.4 4481.9 4570.6 4627.3 4640.0 4641.0 5399.7 5411.3 5429.5 5431.2 5441.8 1376.5 1394.1 1395.3 1396.9 1397.9 845.1 880.4 884.4 889.0 893.4 5048.9 5163.2 5184.7 5321.6 5326.1 5584.3 5587.6 5591.8 5593.7 5595.8 5138.8 5216.4 5287.4 5322.9 5331.4 2876.3 2910.3 2924.7 2932.4 2936.6 5738.2 5738.4 5764.0 5780.2 5800.7 5345.9 5629.2 5630.1 5661.6 5667.2 5796.2 5814.0 5822.7 5832.6 5835.7 5394.6 5577.6 5602.4 5612.9 5628.7 5569.3 5575.5 5596.8 5605.6 5606.8 5890.8 5900.5 5903.4 5922.6 5933.3 3956.0 4026.3 4075.1 4099.9 4127.2 5576.2 5579.5 5591.4 5594.2 5598.6 5474.8 5504.5 5509.4 5512.7 5519.3 5226.9 5385.0 5433.7 5448.8 5516.2 5439.8 5443.8 5493.9 5505.7 5506.5 5256.6 5371.0 5444.1 5502.3 5591.5 5377.2 5403.6 5408.3 5409.3 5423.3 11:39:01 INFO - PROCESS | 4910 | 11:39:01 INFO - PROCESS | 4910 | [#5] yui.html Cycles:180 Average:20650.78 Median:4551.86 stddev:29721.56 (653.0%) stddev-sans-first:29767.17 11:39:01 INFO - PROCESS | 4910 | Values: 696.0 733.1 734.6 742.9 772.9 15264.3 16018.2 16487.8 16491.3 16493.8 16300.8 16564.7 16569.5 16573.2 16588.7 789.0 810.8 813.8 813.9 814.6 657.2 667.4 785.5 807.8 810.9 859.4 861.9 862.2 862.2 862.2 858.9 859.1 859.4 859.6 860.1 500.1 507.3 603.1 613.0 627.7 15358.4 15379.3 15391.3 15403.3 15415.3 13104.0 13181.3 13570.9 13589.7 13777.2 12371.7 12455.3 12483.8 12655.6 12782.5 4277.9 4348.5 4366.3 4389.7 4400.7 80054.0 80478.0 81173.0 81208.6 81253.2 10385.8 10595.0 10668.2 11144.4 11260.6 18157.8 20410.6 20479.4 20994.9 20998.6 8069.8 8106.5 8145.8 8145.8 8149.0 4529.5 4574.2 4796.7 4802.3 4825.3 3332.8 3409.1 3428.6 3438.4 3445.3 572.4 594.6 595.0 597.3 600.2 614.3 625.9 649.3 680.0 681.9 7985.8 8660.7 8908.5 9130.6 9570.4 614.6 655.6 674.2 701.4 740.1 4133.5 4311.8 4388.5 4416.2 4512.0 112845.0 114458.4 114877.0 117222.4 118607.0 92381.5 93372.0 97144.5 97949.0 99593.5 75987.2 82455.0 82632.0 83413.6 85619.0 8529.2 8805.4 8932.2 8936.5 9073.1 49343.0 49538.0 50007.5 51242.0 51400.2 67529.7 70940.3 75351.2 76437.0 78066.6 12630.4 12663.4 12688.4 12691.7 12730.2 14151.6 14179.2 14493.8 14526.9 14717.1 12544.7 13747.6 14397.9 14445.5 14621.3 13252.0 13256.0 13356.5 13551.4 13818.9 12666.8 14184.0 14192.4 14628.9 14649.2 10522.2 10641.6 10644.2 10874.9 11181.9 10614.5 11464.6 11486.5 11528.4 11670.0 11:39:01 INFO - PROCESS | 4910 | -------- Summary: end -------- 11:39:01 INFO - PROCESS | 4910 | 11:39:02 INFO - TEST-INFO | 4910: exit 0 11:39:02 INFO - TEST-OK | dromaeo_css | took 1117719ms 11:39:02 INFO - TEST-START | kraken 11:39:02 INFO - operating with platform_type : linux_ 11:39:02 INFO - Initialising browser for kraken test... 11:39:02 INFO - TEST-INFO | started process 5213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdEXAVq/profile http://localhost:36177/getInfo.html) 11:39:06 INFO - PROCESS | 5213 | __metrics Screen width/height:1600/1200 11:39:06 INFO - PROCESS | 5213 | colorDepth:24 11:39:06 INFO - PROCESS | 5213 | Browser inner width/height: 1024/697 11:39:06 INFO - PROCESS | 5213 | __metrics 11:39:07 INFO - PROCESS | 5213 | 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" 11:39:07 INFO - PROCESS | 5213 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:39:08 INFO - PROCESS | 5213 | console.error: PushService: 11:39:08 INFO - PROCESS | 5213 | stateChangeProcessEnqueue: Error transitioning state 11:39:08 INFO - PROCESS | 5213 | UnknownError 11:39:08 INFO - TEST-INFO | 5213: exit 0 11:39:08 INFO - Browser initialized. 11:39:08 INFO - Running cycle 1/1 for kraken test... 11:39:08 INFO - TEST-INFO | started process 5295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdEXAVq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:39:20 INFO - PROCESS | 5295 | RSS: Main: 173457408 11:39:20 INFO - PROCESS | 5295 | 11:39:23 INFO - PROCESS | 5295 | Cycle 1(1): loaded http://localhost:36177/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36177/tests/kraken/driver.html?testName=audio-beat-detection) 11:39:24 INFO - PROCESS | 5295 | RSS: Main: 232726528 11:39:24 INFO - PROCESS | 5295 | 11:39:27 INFO - PROCESS | 5295 | Cycle 1(1): loaded http://localhost:36177/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36177/tests/kraken/driver.html?testName=audio-dft) 11:39:27 INFO - PROCESS | 5295 | RSS: Main: 216690688 11:39:27 INFO - PROCESS | 5295 | 11:39:30 INFO - PROCESS | 5295 | Cycle 1(1): loaded http://localhost:36177/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36177/tests/kraken/driver.html?testName=audio-fft) 11:39:31 INFO - PROCESS | 5295 | RSS: Main: 298807296 11:39:31 INFO - PROCESS | 5295 | 11:39:33 INFO - PROCESS | 5295 | Cycle 1(1): loaded http://localhost:36177/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36177/tests/kraken/driver.html?testName=audio-oscillator) 11:39:34 INFO - PROCESS | 5295 | RSS: Main: 210579456 11:39:34 INFO - PROCESS | 5295 | 11:39:36 INFO - PROCESS | 5295 | Cycle 1(1): loaded http://localhost:36177/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36177/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:39:36 INFO - PROCESS | 5295 | RSS: Main: 213594112 11:39:36 INFO - PROCESS | 5295 | 11:39:39 INFO - PROCESS | 5295 | Cycle 1(1): loaded http://localhost:36177/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36177/tests/kraken/driver.html?testName=imaging-darkroom) 11:39:40 INFO - PROCESS | 5295 | RSS: Main: 249769984 11:39:40 INFO - PROCESS | 5295 | 11:39:43 INFO - PROCESS | 5295 | Cycle 1(1): loaded http://localhost:36177/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36177/tests/kraken/driver.html?testName=imaging-desaturate) 11:39:44 INFO - PROCESS | 5295 | RSS: Main: 248389632 11:39:44 INFO - PROCESS | 5295 | 11:39:47 INFO - PROCESS | 5295 | Cycle 1(1): loaded http://localhost:36177/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36177/tests/kraken/driver.html?testName=json-parse-financial) 11:39:47 INFO - PROCESS | 5295 | RSS: Main: 248680448 11:39:47 INFO - PROCESS | 5295 | 11:39:49 INFO - PROCESS | 5295 | Cycle 1(1): loaded http://localhost:36177/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36177/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:39:49 INFO - PROCESS | 5295 | RSS: Main: 210567168 11:39:49 INFO - PROCESS | 5295 | 11:39:51 INFO - PROCESS | 5295 | Cycle 1(1): loaded http://localhost:36177/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36177/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:39:52 INFO - PROCESS | 5295 | RSS: Main: 217346048 11:39:52 INFO - PROCESS | 5295 | 11:39:54 INFO - PROCESS | 5295 | Cycle 1(1): loaded http://localhost:36177/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36177/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:39:54 INFO - PROCESS | 5295 | RSS: Main: 227389440 11:39:54 INFO - PROCESS | 5295 | 11:39:57 INFO - PROCESS | 5295 | Cycle 1(1): loaded http://localhost:36177/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36177/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:39:58 INFO - PROCESS | 5295 | RSS: Main: 235487232 11:39:58 INFO - PROCESS | 5295 | 11:40:01 INFO - PROCESS | 5295 | Cycle 1(1): loaded http://localhost:36177/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36177/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:40:01 INFO - PROCESS | 5295 | RSS: Main: 232992768 11:40:01 INFO - PROCESS | 5295 | 11:40:03 INFO - PROCESS | 5295 | Cycle 1(1): loaded http://localhost:36177/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36177/tests/kraken/driver.html?testName=ai-astar) 11:40:03 INFO - PROCESS | 5295 | RSS: Main: 282591232 11:40:03 INFO - PROCESS | 5295 | 11:40:03 INFO - PROCESS | 5295 | __start_tp_report 11:40:03 INFO - PROCESS | 5295 | _x_x_mozilla_page_load 11:40:03 INFO - PROCESS | 5295 | _x_x_mozilla_page_load_details 11:40:03 INFO - PROCESS | 5295 | |i|pagename|runs| 11:40:03 INFO - PROCESS | 5295 | |0;ai-astar;108;111;110;109;112;110;109;109;110;111 11:40:03 INFO - PROCESS | 5295 | |1;audio-beat-detection;149;125;126;168;124;122;121;122;169;122 11:40:03 INFO - PROCESS | 5295 | |2;audio-dft;161;161;161;159;161;163;161;162;160;160 11:40:03 INFO - PROCESS | 5295 | |3;audio-fft;75;75;76;103;77;77;75;76;110;77 11:40:03 INFO - PROCESS | 5295 | |4;audio-oscillator;83;83;116;83;83;82;102;82;82;119 11:40:03 INFO - PROCESS | 5295 | |5;imaging-gaussian-blur;117;116;116;117;117;117;116;117;116;117 11:40:03 INFO - PROCESS | 5295 | |6;imaging-darkroom;146;147;147;146;146;146;147;146;145;145 11:40:03 INFO - PROCESS | 5295 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;96;95 11:40:03 INFO - PROCESS | 5295 | |8;json-parse-financial;51;49;50;51;52;52;52;51;51;51 11:40:03 INFO - PROCESS | 5295 | |9;json-stringify-tinderbox;60;60;60;61;60;61;61;60;60;61 11:40:03 INFO - PROCESS | 5295 | |10;stanford-crypto-aes;79;80;79;79;80;80;80;86;85;80 11:40:03 INFO - PROCESS | 5295 | |11;stanford-crypto-ccm;132;130;135;129;131;132;132;126;166;128 11:40:03 INFO - PROCESS | 5295 | |12;stanford-crypto-pbkdf2;170;166;169;165;164;170;163;166;165;166 11:40:03 INFO - PROCESS | 5295 | |13;stanford-crypto-sha256-iterative;67;63;65;65;65;66;64;66;64;64 11:40:03 INFO - PROCESS | 5295 | __end_tp_report 11:40:03 INFO - PROCESS | 5295 | __start_cc_report 11:40:03 INFO - PROCESS | 5295 | _x_x_mozilla_cycle_collect,1665 11:40:03 INFO - PROCESS | 5295 | __end_cc_report 11:40:03 INFO - PROCESS | 5295 | __startTimestamp1475779203531__endTimestamp 11:40:03 INFO - PROCESS | 5295 | 11:40:03 INFO - PROCESS | 5295 | ------- Summary: start ------- 11:40:03 INFO - PROCESS | 5295 | Number of tests: 14 11:40:03 INFO - PROCESS | 5295 | 11:40:03 INFO - PROCESS | 5295 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:1.20 (1.1%) stddev-sans-first:1.05 11:40:03 INFO - PROCESS | 5295 | Values: 108.0 111.0 110.0 109.0 112.0 110.0 109.0 109.0 110.0 111.0 11:40:03 INFO - PROCESS | 5295 | 11:40:03 INFO - PROCESS | 5295 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:125.50 stddev:19.57 (15.6%) stddev-sans-first:20.07 11:40:03 INFO - PROCESS | 5295 | Values: 149.0 125.0 126.0 168.0 124.0 122.0 121.0 122.0 169.0 122.0 11:40:03 INFO - PROCESS | 5295 | 11:40:03 INFO - PROCESS | 5295 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 11:40:03 INFO - PROCESS | 5295 | Values: 161.0 161.0 161.0 159.0 161.0 163.0 161.0 162.0 160.0 160.0 11:40:03 INFO - PROCESS | 5295 | 11:40:03 INFO - PROCESS | 5295 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:12.99 (17.1%) stddev-sans-first:13.52 11:40:03 INFO - PROCESS | 5295 | Values: 75.0 75.0 76.0 103.0 77.0 77.0 75.0 76.0 110.0 77.0 11:40:03 INFO - PROCESS | 5295 | 11:40:03 INFO - PROCESS | 5295 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:82.50 stddev:15.01 (18.2%) stddev-sans-first:15.60 11:40:03 INFO - PROCESS | 5295 | Values: 83.0 83.0 116.0 83.0 83.0 82.0 102.0 82.0 82.0 119.0 11:40:03 INFO - PROCESS | 5295 | 11:40:03 INFO - PROCESS | 5295 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:40:03 INFO - PROCESS | 5295 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 11:40:03 INFO - PROCESS | 5295 | 11:40:03 INFO - PROCESS | 5295 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 11:40:03 INFO - PROCESS | 5295 | Values: 146.0 147.0 147.0 146.0 146.0 146.0 147.0 146.0 145.0 145.0 11:40:03 INFO - PROCESS | 5295 | 11:40:03 INFO - PROCESS | 5295 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:40:03 INFO - PROCESS | 5295 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 11:40:03 INFO - PROCESS | 5295 | 11:40:03 INFO - PROCESS | 5295 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.00 stddev:0.94 (1.8%) stddev-sans-first:1.00 11:40:03 INFO - PROCESS | 5295 | Values: 51.0 49.0 50.0 51.0 52.0 52.0 52.0 51.0 51.0 51.0 11:40:03 INFO - PROCESS | 5295 | 11:40:03 INFO - PROCESS | 5295 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 11:40:03 INFO - PROCESS | 5295 | Values: 60.0 60.0 60.0 61.0 60.0 61.0 61.0 60.0 60.0 61.0 11:40:03 INFO - PROCESS | 5295 | 11:40:03 INFO - PROCESS | 5295 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.00 stddev:2.53 (3.2%) stddev-sans-first:2.60 11:40:03 INFO - PROCESS | 5295 | Values: 79.0 80.0 79.0 79.0 80.0 80.0 80.0 86.0 85.0 80.0 11:40:03 INFO - PROCESS | 5295 | 11:40:03 INFO - PROCESS | 5295 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:132.00 stddev:11.48 (8.7%) stddev-sans-first:12.16 11:40:03 INFO - PROCESS | 5295 | Values: 132.0 130.0 135.0 129.0 131.0 132.0 132.0 126.0 166.0 128.0 11:40:03 INFO - PROCESS | 5295 | 11:40:03 INFO - PROCESS | 5295 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:166.00 stddev:2.46 (1.5%) stddev-sans-first:2.24 11:40:03 INFO - PROCESS | 5295 | Values: 170.0 166.0 169.0 165.0 164.0 170.0 163.0 166.0 165.0 166.0 11:40:03 INFO - PROCESS | 5295 | 11:40:03 INFO - PROCESS | 5295 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.20 (1.8%) stddev-sans-first:1.00 11:40:03 INFO - PROCESS | 5295 | Values: 67.0 63.0 65.0 65.0 65.0 66.0 64.0 66.0 64.0 64.0 11:40:03 INFO - PROCESS | 5295 | -------- Summary: end -------- 11:40:03 INFO - PROCESS | 5295 | 11:40:04 INFO - TEST-INFO | 5295: exit 0 11:40:04 INFO - TEST-OK | kraken | took 62303ms 11:40:04 INFO - SUITE-END | took 1180s 11:40:05 INFO - Completed test suite (00:19:40) 11:40:05 INFO - javascript benchmark 11:40:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2987.9701202987967, 3027.303720144368, 3028.4700177468935, 3065.509518477044, 3066.7853250272474, 4980.551750342468, 5088.7964481420695, 5162.7934882604695, 5224.45143259958, 5240.973795131029, 5033.395992480899, 5115.514026167518, 5145.845624631258, 5177.6634518756255, 5195.03891780021, 4681.602063824562, 4714.599259062984, 4738.857834264978, 4808.182608956486, 4819.0, 4708.717476951377, 4766.571008609225, 4784.449788274358, 4811.615070794328, 4857.829975950843, 4728.432588089417, 4747.620190384761, 4768.809247630091, 4779.522047795227, 4830.541098595628, 4577.862664120082, 4611.746353950532, 4653.720776753372, 4697.741624210667, 4716.882077948045, 4679.906401871977, 4691.132140554008, 4692.2257827458425, 4735.692180008323, 4753.4771175171045, 5121.2318152277085, 5169.353830771153, 5176.767045482925, 5188.169892817131, 5204.869878253036, 5302.761375738101, 5361.410244873061, 5462.180672899057, 5519.972400137974, 5527.060399732055, 5541.362743284533, 5552.639078459928, 5563.638363506359, 5636.605437619368, 5638.097904335286, 5176.870578235536, 5179.948200518022, 5182.32629758129, 5184.611154163415, 5245.318108645852, 5549.528290095387, 5602.579806514446, 5668.0, 5674.347450043216, 5676.432356764373, 5429.67421954684, 5498.945010549924, 5503.229547863302, 5516.255305533701, 5574.526165275997, 5522.861928451741, 5558.666480011212, 5581.079121944915, 5582.665040097607, 5585.413531579207, 5404.216388623628, 5511.476409741068, 5573.554115670737, 5578.3584887738425, 5591.049521581341, 5458.099413596791, 5487.670739755627, 5516.0, 5539.41836107211, 5547.334319881559, 4324.1567894260315, 4356.281213599784, 4364.454443194601, 4368.148211098805, 4370.409994650745, 3855.8264878079995, 3860.208657225262, 3865.8260378283044, 3908.4528166056775, 3912.0, 5321.388040375329, 5327.9733601331745, 5331.226972089103, 5331.573474122061, 5384.542313903362, 5449.264349312872, 5455.345358556999, 5484.945150548523, 5486.533644640251, 5535.8339249821765, 5272.130098533776, 5280.102382594891, 5293.973530132324, 5294.54996325309, 5344.732763361816, 4823.083614113307, 4827.662063655511, 4830.372051633265, 4833.130036593377, 4886.65793394459, 5555.916661250004, 5684.0, 5751.079827227707, 5769.221155144086, 5771.711414429262, 5514.476124768141, 5538.44615538459, 5556.91664625039, 5579.776808927598, 5639.88720225585, 5765.654060756368, 5774.566907481872, 5784.4504772046585, 5784.566157538117, 5787.5369970401425, 5296.735163241746, 5470.753816078366, 5471.8084867029465, 5482.23248745168, 5485.698286594116, 5432.320959880015, 5479.315085614298, 5507.972460137674, 5512.80705175317, 5609.915851262316, 5332.520073193431, 5343.839684809462, 5371.5702743781185, 5373.462653734595, 5373.758180881948, 5352.277442545206, 5353.705546194841, 5357.1696387060065, 5365.570754339566, 5370.650907690988, 5156.278121063129, 5211.166213405837, 5346.919796202982, 5400.891982160413, 5434.64674796137, 5497.065498865282, 5511.421300763523, 5526.723663816712, 5528.668279903219, 5568.192612071146, 5241.842744717512, 5297.735113244245, 5398.865028374322, 5414.431484694051, 5414.972925135349], "value": 5121.673885761202, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.2677519225007, 592.2360155399534, 594.0940066398741, 601.293480160811, 613.3069631316612, 30375.392492150142, 30888.227794305152, 41613.375799363, 42362.36456453148, 42407.15185696284, 39907.60092399075, 44071.33892991608, 44498.77750611243, 44588.55411445884, 44613.33080003803, 8752.737417877473, 8917.063708310632, 8921.0, 8925.73222803317, 8929.374943753939, 7975.840483190333, 8158.632861521216, 10296.794064118712, 10497.790044199111, 10499.580016799318, 10695.78608427831, 10782.622608208714, 10791.29856559325, 10796.892031079668, 10803.4058126803, 7980.680772769082, 10528.368297902112, 10582.047615714622, 10598.894011059907, 10604.045635892806, 7988.4408091433625, 10042.096211341015, 10332.896671033268, 10335.328203666737, 10654.09440197584, 41394.79302603468, 41690.58309416897, 41898.0, 41959.370609440884, 42011.0, 3440.3807314683345, 3513.350030244413, 3554.8578056877695, 3590.35373632746, 4002.8598999035185, 31168.688313116807, 31299.904503342274, 31731.0, 31838.20404489883, 31941.201469963205, 4163.854265100737, 4293.141371725667, 4297.0779869688595, 4348.086901750637, 4462.241418958784, 325521.0, 325548.0, 326410.0, 327306.0, 327896.0, 34799.65200348015, 54357.45642543603, 54621.453785461636, 54764.0, 54808.17787733187, 35222.64777352194, 36544.0, 37001.0, 37146.62853371486, 37159.0, 14910.627234319229, 14930.40278388874, 14989.175595342143, 14999.475018374305, 15103.244837758288, 11133.165012623924, 11385.544578216945, 12231.877681223074, 12280.877191228152, 12288.201266917622, 8362.205590469017, 8602.91397086021, 8605.139486051345, 8612.224899759052, 8675.522846243517, 3280.1963518937537, 3300.422426075427, 3307.8676852926096, 3356.1777364545355, 3396.286779776225, 908.5366463103733, 977.296346630425, 1075.2580719303655, 1101.801675698366, 1148.4257871064467, 29665.85167074194, 31315.686843131734, 31385.0, 31723.84138079295, 32102.839485802888, 1090.4711215060688, 1099.9010089092021, 1100.8238681810872, 1131.7340425000284, 1132.405487119269, 15770.921145394199, 16651.41720039793, 16771.748423773653, 16793.328266869434, 16901.0, 150086.24956875146, 150645.0, 150858.24570877076, 151740.2412987928, 151828.0, 33615.99152025443, 33720.49419258713, 33731.83134084363, 33734.831325843705, 33798.831005845306, 1205.5479195301762, 1239.0645062977574, 1285.081166965624, 1302.374860067154, 1303.8239837621988, 27485.450290994468, 31624.683753163095, 31866.0, 32088.83955580207, 32362.190945226557, 47873.0, 53580.46419535755, 54908.725456372464, 55048.0, 60732.0, 467624.0, 471315.0, 472213.0, 472719.0, 473741.0, 34022.48966265458, 34415.48376774401, 42665.306816250806, 43124.0, 43679.0, 39458.60541394664, 46475.76762116303, 46591.30113048375, 46633.53366466292, 46773.766131169126, 38087.23825523419, 38233.4264986031, 38991.415128772525, 39791.80104099461, 40206.59793402028, 38618.42072368861, 39094.4135837957, 39148.80425597854, 39723.80138099407, 40164.79917600393, 39529.0, 40142.397864032646, 40225.0, 40375.1924961505, 40444.797776010935, 33480.832595836866, 35660.82671366597, 35887.28225435529, 36084.09789755277, 36250.27499450049, 26994.460110798067, 27350.726492735615, 27490.450190995667, 27595.0, 27803.0], "value": 18087.781957114534, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.76335145506897, 385.7087898636529, 388.16738096782404, 399.1179493319763, 416.41493701349617, 16592.419265325716, 18690.15894284757, 18808.811911880875, 18820.62358752824, 18848.151833167507, 18253.452396428096, 18473.261069557237, 18797.530061748465, 18861.15124819383, 18872.33946811862, 5385.246065550826, 5477.4796394342475, 5705.229793977802, 5713.200151978726, 5718.0, 5428.45715428458, 5501.9174712379345, 5503.394626591072, 5545.805896793613, 5556.777728890839, 5520.806771762989, 5521.696306703129, 5522.0336441122845, 5523.364813046491, 5526.336839579256, 5697.290812756178, 5795.913061304083, 5806.187133801272, 5818.883622327572, 5821.56338274629, 5469.15228139639, 5624.803131890364, 5641.210230567724, 5647.29408823897, 5697.230873832021, 13788.241646709426, 14054.508092216724, 14101.435942562286, 15436.614084647974, 22247.888760556256, 2201.2405720026563, 2285.645724912641, 2324.697789287382, 2353.7881590656925, 2359.622460406327, 9939.50302484873, 10030.197584193247, 10036.397816130982, 10529.684109476728, 10611.734706632318, 1834.8899066055947, 1843.9213060359705, 1869.7475840761458, 1881.6142690748363, 1894.479018269973, 77847.61076194639, 79070.20929790685, 79811.20188798096, 80437.19562804414, 81178.59410702968, 8582.957085214659, 9056.320775941831, 9323.673671421468, 10796.136309095253, 11792.23350482216, 12673.619791406272, 12718.872811271955, 12731.745365092645, 12738.29939353326, 12894.355282236038, 7691.846163076819, 7718.807029824299, 7827.452078354574, 7828.2954534092205, 7996.72011479607, 7670.923290767021, 7799.766007019798, 7893.921060789434, 8005.319547838499, 8034.0, 4030.9596904031173, 4045.4943132108488, 4112.91774164515, 4186.958130418718, 4225.345071513921, 1937.5156210947264, 1945.1538580717433, 1984.7221389005551, 1990.9402717918485, 2024.7772744998038, 897.2014906733012, 906.9365144439957, 942.58997336159, 948.7533241357297, 958.712386284112, 17772.0, 19443.805561944482, 19645.50886227856, 19667.90166049189, 19793.505162371057, 933.4865823796885, 934.9766255843658, 936.6721647423348, 969.5588507229194, 991.3655260633201, 10169.796604068026, 10784.40685762275, 10863.348199108079, 10928.781424371467, 10929.890701093047, 402647.0, 406076.0, 407198.0, 415145.0, 420425.0, 83725.0, 85575.0, 89767.0, 92569.5371523138, 92901.0, 991.9504024798731, 1027.119114122135, 1028.6708253359002, 1029.5933106422922, 1033.4832583708146, 17116.400925968028, 17261.741073884154, 17869.46391608202, 18085.186166622272, 18356.724649130007, 40107.1978560433, 41201.587984119775, 41752.824717528005, 42047.186642612105, 42241.78879105585, 55175.44824551703, 58730.412695872496, 58848.70575647095, 60688.39311606828, 61491.38508614856, 8083.434159608771, 8158.4289099762445, 8386.916130838614, 8426.95786521088, 8498.915010849812, 9140.862887056566, 12119.515219391478, 12746.617601471971, 12960.740785184433, 13029.543965961146, 10575.68272951782, 11118.888811111785, 11265.943670281596, 11351.602693905674, 11829.231099978819, 10978.890211097787, 10996.835047474455, 11083.501242443948, 11104.389258590854, 11289.604863830054, 10940.56237750513, 11298.548058077586, 11334.14993875446, 11585.6524304271, 11614.709632258922, 7294.671739771617, 7447.515911465737, 7580.128285247267, 7824.9608751955875, 8900.955495222483, 10052.949735251277, 10619.469026548797, 11045.613403530839, 11466.31202127875, 11521.654350369503], "value": 8785.298536749662, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.1302153600152, 1416.8583141685833, 1459.2776575595078, 1583.5510507885285, 1766.6908291049072, 7652.961735191323, 8227.341812654988, 8420.452670576407, 8426.620802063906, 8637.65449382024, 8393.0, 8508.276796472308, 8516.23353898149, 8519.57402129894, 8521.488710677364, 2257.638777795553, 2286.7941885230325, 2294.7934685878267, 2296.1274715608047, 2298.6322188449853, 2208.823294136473, 2252.538229662915, 2255.571441426124, 2256.5261295128043, 2261.547690461906, 2234.218023691711, 2246.887655617221, 2257.097161135551, 2280.8631482111127, 2283.292179424384, 2148.8603240789457, 2172.6415141501634, 2176.075168053571, 2179.1936983316195, 2183.1922188790168, 2119.109973811003, 2124.5326028273907, 2125.27740568206, 2127.4043267885017, 2128.4785227619177, 8383.664653413856, 8429.873551896726, 8438.2827459666, 8989.730308090768, 9317.627294908196, 5072.0, 5191.169412893956, 5192.740362981874, 5197.402298735618, 5199.376074871002, 3200.3439294944483, 3374.6287908330064, 3433.261848702516, 3433.399155147864, 3454.602720687128, 1051.0413186878989, 1079.865016872891, 1081.4862940103467, 1087.12486448409, 1105.0717397386154, 12652.17760845542, 12686.746265074738, 12775.297358645365, 12799.872001280055, 12804.0, 4210.936835947402, 4302.806373713191, 4431.667624928144, 4438.17893689662, 4468.798904049326, 9819.410835349901, 9860.753481163028, 9862.01379862008, 9865.704028879145, 9869.555869985868, 5145.742712864417, 5150.175971844487, 5152.845414637567, 5154.0, 5158.380994280636, 3946.625070618287, 4141.855035073758, 4227.556106608823, 4271.722338048017, 4827.61379089672, 3485.19840436701, 3844.1927195288745, 3881.378979363288, 3892.844286228519, 3911.198204368098, 1118.7762447510531, 1163.6043745126697, 1165.7027457998327, 1172.9296242225323, 1184.3130984029242, 842.5534466732641, 869.599984007351, 890.4479222881855, 916.5508900638639, 931.459753343073, 5639.2668953035845, 5832.62087964281, 5930.377310382434, 5961.582689211714, 5987.0, 898.4025622960788, 932.5896605493562, 932.883389576303, 939.201678573221, 964.8890377606525, 3835.463035175078, 3944.2703099926607, 3996.9600303997167, 4026.939595906064, 4052.696047796427, 10374.481275936172, 11377.431128443544, 11391.829122563167, 11411.657650270505, 11439.656810295704, 11069.667909962714, 11319.151063670257, 11319.886801132048, 11324.263922844988, 11330.263532870502, 8219.876701849476, 8450.323974082181, 8454.0, 8468.110848360957, 8473.872891906627, 5593.300837395325, 5643.379228284967, 5683.516901063456, 5700.173474846041, 5761.337446193741, 10167.288289819642, 10387.37675739458, 10424.322419042737, 10434.0, 10449.969508842654, 9059.864102038342, 10449.0, 10475.476226188508, 10631.627893023708, 10754.516046777757, 6676.599404035774, 7184.820379490346, 7269.200387957426, 7432.0, 7441.330280274801, 8028.357731381592, 8107.594620269081, 8311.542865142475, 8369.874451883348, 8449.324054075536, 7020.824479388056, 7052.259512751088, 7068.787936361918, 7310.159331676712, 7403.370713489414, 7138.357547820513, 7211.855762884608, 7269.672864720995, 7270.636468176675, 7292.088488938883, 6843.315668433117, 6917.827054323682, 6921.82695432598, 6925.58446493212, 6927.515073944775, 4853.320535125156, 4913.224514508827, 4927.778249978688, 4928.137575924127, 5149.48505149482, 4952.108620448354, 5039.319691841554, 5066.316047333563, 5088.7201203932655, 5173.275741396133], "value": 4502.538059913032, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.56210742852585, 316.8463295301777, 320.4328338840254, 326.06257011093106, 331.09940960587204, 5260.0, 5267.420583735786, 5271.130263506521, 5273.4179746076115, 5306.310179676641, 5173.534381905628, 5174.266620682076, 5202.427732949382, 5216.183261039044, 5224.085784987631, 3814.1608846053823, 3957.663598594123, 3959.247742928834, 4048.251073551388, 4105.563052931465, 4053.9797301013455, 4056.492938382702, 4066.166435880652, 4069.125138095309, 4076.429299898017, 4013.8996525086814, 4017.5982401759884, 4022.275990321741, 4054.1891621675636, 4056.2090392373498, 3814.4278358246206, 3886.164474637938, 3930.842766289359, 4018.718689691723, 4070.61329173728, 3599.3341231872187, 3599.892003239907, 3613.6567026132475, 3616.72874534411, 3624.821932871801, 5039.949600504021, 5066.569341605968, 5070.315507406527, 5094.872628184288, 5138.974305128488, 4476.261416866213, 4552.430946131733, 4593.724376537419, 4608.423947006624, 4658.1848176568965, 5362.6782393056155, 5366.248725178478, 5366.758495867695, 5369.0, 5369.167778994262, 3903.1217975955465, 3922.921541569181, 3926.430667553189, 3926.8429262829454, 3933.5869733678123, 5277.8416647500635, 5561.388247292794, 5573.934336115161, 5596.496315331599, 5662.178984047331, 3926.09699769049, 3926.332523471017, 3960.2475529649273, 3967.682585393162, 3983.541892682321, 4007.1384652299894, 4011.1576568920855, 4019.3569028955226, 4028.395740638869, 4031.3952907064177, 4481.910361792811, 4570.565796249351, 4627.30590411441, 4639.953600463952, 4640.976795116003, 5399.70301633414, 5411.269478620415, 5429.484199001088, 5431.1757885899115, 5441.782328706887, 1376.5457399058287, 1394.093839004635, 1395.337214822951, 1396.9034308068117, 1397.9231142287272, 845.1084106267946, 880.423322723617, 884.3941899798658, 888.9865553269278, 893.4148132972913, 5048.899022019613, 5163.225516172529, 5184.662996905189, 5321.574274058066, 5326.082610260303, 5584.274044374205, 5587.580931430159, 5591.832245032656, 5593.720313984284, 5595.804146854922, 5138.820141295037, 5216.400113986864, 5287.41838397776, 5322.8935421292135, 5331.360236771612, 2876.280929767558, 2910.272431892027, 2924.736773690378, 2932.4281765055607, 2936.6329208848892, 5738.225339579187, 5738.397468265855, 5764.0, 5780.248567686174, 5800.738966746507, 5345.919811202835, 5629.155626655953, 5630.127330263816, 5661.603687741901, 5667.234923285386, 5796.217510636095, 5814.011618024946, 5822.710168754725, 5832.562557808096, 5835.708214589169, 5394.595405344537, 5577.581681373995, 5602.439756024365, 5612.85967850807, 5628.690422026828, 5569.303837020372, 5575.498205161555, 5596.832095037155, 5605.635633683797, 5606.775728970795, 5890.764369425175, 5900.498457631149, 5903.439173278532, 5922.644641321534, 5933.258342707161, 3956.0307724607655, 4026.255142798592, 4075.144219713775, 4099.852041428405, 4127.215828992482, 5576.191452239484, 5579.46995035471, 5591.440855914376, 5594.237815088234, 5598.640815510661, 5474.808381706621, 5504.504594586507, 5509.3664228612615, 5512.724363781715, 5519.2824932758485, 5226.947730522798, 5385.0, 5433.744995826688, 5448.782048718007, 5516.172574113915, 5439.836804895859, 5443.8094666686475, 5493.945060549343, 5505.669659820263, 5506.531944784738, 5256.6320357574605, 5371.0, 5444.101723215784, 5502.312210973629, 5591.496765291144, 5377.247185394126, 5403.648762830403, 5408.296921400193, 5409.29679141709, 5423.322084739408], "value": 4151.086928246283, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.9652017399129, 733.0799846193026, 734.6473692627538, 742.8551432470671, 772.9149793522712, 15264.313105910232, 16018.199090045495, 16487.83512164878, 16491.257893394795, 16493.83506164938, 16300.755488667679, 16564.66870662586, 16569.50291491254, 16573.17134143291, 16588.66822663546, 789.0097927101508, 810.8013536683521, 813.8168911994813, 813.9226773456512, 814.6293436486415, 657.1686816177539, 667.3793372163885, 785.5286827903241, 807.7657479331016, 810.9270165685087, 859.4198915731887, 861.8621020636699, 862.1550880137438, 862.1938487514194, 862.2024627219797, 858.9484630922165, 859.072202021815, 859.4456575508793, 859.6217664227751, 860.1011942520081, 500.0648786768729, 507.2543361258943, 603.0501959413897, 612.9754809807603, 627.6798832595364, 15358.385664573403, 15379.307931143125, 15391.307391167313, 15403.306851191723, 15415.30631121591, 13104.0, 13181.275029873354, 13570.864291357058, 13589.660258493617, 13777.228610718046, 12371.731462885784, 12455.252684838939, 12483.812742808865, 12655.557055503014, 12782.488700451971, 4277.893052673677, 4348.543402942677, 4366.28741414673, 4389.692721509496, 4400.713953593006, 80054.0, 80478.0, 81173.0, 81208.59395702984, 81253.18746812515, 10385.84421233682, 10595.046445819913, 10668.199885008655, 11144.442777861075, 11260.605878794202, 18157.818421815613, 20410.591788164154, 20479.38561843147, 20994.89502552508, 20998.580028399345, 8069.83860322802, 8106.47307924983, 8145.837083258301, 8145.8370832584205, 8149.022117345957, 4529.5243999380245, 4574.193193688475, 4796.712197268105, 4802.27965805132, 4825.324454576362, 3332.8333583320737, 3409.130671678706, 3428.6057103432927, 3438.381091403571, 3445.3109378123972, 572.3589579670795, 594.551113908996, 595.0419824083223, 597.2683462758173, 600.216717184079, 614.2966303582373, 625.918630578022, 649.2695717318018, 680.0479328939425, 681.9215790184093, 7985.8402831944195, 8660.653573856975, 8908.510031948304, 9130.589123489459, 9570.377925434825, 614.5728718540571, 655.6131882189532, 674.2212744280364, 701.3652644356865, 740.0712106306551, 4133.4626498555, 4311.784410779448, 4388.451443569554, 4416.24923762961, 4511.975585065828, 112845.0, 114458.42770786093, 114877.0, 117222.41388793002, 118607.03482413008, 92381.53809231045, 93372.0, 97144.54283185757, 97949.0, 99593.50203249083, 75987.24012759802, 82455.0, 82632.0, 83413.58293208617, 85619.0, 8529.189726975927, 8805.427647203167, 8932.151445612657, 8936.525473297093, 9073.13805188506, 49343.0, 49538.0, 50007.49992500029, 51242.0, 51400.228996564336, 67529.66235168793, 70940.29059709336, 75351.24648753442, 76437.0, 78066.6096669513, 12630.431630576462, 12663.366831658564, 12688.365581721062, 12691.746165076831, 12730.17253878495, 14151.575452736435, 14179.220142891827, 14493.760044443296, 14526.927365363106, 14717.116972981656, 12544.74910501803, 13747.587572372844, 14397.856021439651, 14445.49440769568, 14621.268936552917, 13252.0, 13256.0, 13356.532521361705, 13551.441584217548, 13818.861811381757, 12666.809997849856, 14184.0, 14192.36134373935, 14628.853711462749, 14649.194294313915, 10522.158227341948, 10641.627543035956, 10644.201684873511, 10874.945625271823, 11181.944090279496, 10614.469276536296, 11464.598739044428, 11486.483108259981, 11528.444071815766, 11670.0], "value": 7435.49068269871, "unit": "score"}], "name": "dromaeo_css", "value": 6954.313611327715, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 110.0, 109.0, 112.0, 110.0, 109.0, 109.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 125.0, 126.0, 168.0, 124.0, 122.0, 121.0, 122.0, 169.0, 122.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 159.0, 161.0, 163.0, 161.0, 162.0, 160.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 103.0, 77.0, 77.0, 75.0, 76.0, 110.0, 77.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 116.0, 83.0, 83.0, 82.0, 102.0, 82.0, 82.0, 119.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 50.0, 51.0, 52.0, 52.0, 52.0, 51.0, 51.0, 51.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 60.0, 61.0, 61.0, 60.0, 60.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 79.0, 80.0, 80.0, 80.0, 86.0, 85.0, 80.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 130.0, 135.0, 129.0, 131.0, 132.0, 132.0, 126.0, 166.0, 128.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 169.0, 165.0, 164.0, 170.0, 163.0, 166.0, 165.0, 166.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 65.0, 65.0, 65.0, 66.0, 64.0, 66.0, 64.0, 64.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1494.7000000000003, "alertThreshold": 2.0}]} 11:40:05 INFO - Return code: 0 11:40:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:40:05 INFO - # TBPL SUCCESS # 11:40:05 INFO - Running post-action listener: _resource_record_post_action 11:40:05 INFO - [mozharness: 2016-10-06 18:40:05.343290Z] Finished run-tests step (success) 11:40:05 INFO - Running post-run listener: _resource_record_post_run 11:40:05 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399917056; Read time: 12; Write time: 377112 11:40:05 INFO - TinderboxPrint: CPU usage
13.0% 11:40:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:40:05 INFO - TinderboxPrint: I/O write bytes / time
399,917,056 / 377,112 11:40:05 INFO - TinderboxPrint: CPU idle
8,310.8 (86.9%) 11:40:05 INFO - TinderboxPrint: CPU user
1,197.2 (12.5%) 11:40:05 INFO - TinderboxPrint: Swap in / out
0 / 0 11:40:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110534656; Read time: 0; Write time: 103476 11:40:05 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288444416; Read time: 0; Write time: 273592 11:40:05 INFO - Running post-run listener: _upload_blobber_files 11:40:05 INFO - Blob upload gear active. 11:40:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:40:05 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 11:40:05 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:40:05 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:40:06 INFO - (blobuploader) - INFO - Open directory for files ... 11:40:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:40:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:40:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:07 INFO - (blobuploader) - INFO - Done attempting. 11:40:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:40:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:40:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:07 INFO - (blobuploader) - INFO - Done attempting. 11:40:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:40:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:40:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:11 INFO - (blobuploader) - INFO - Done attempting. 11:40:11 INFO - (blobuploader) - INFO - Iteration through files over. 11:40:11 INFO - Return code: 0 11:40:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:40:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:40:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f941de949404d4db95e7d9d2fbd08a78eab400e1431f1e2c8149bed2c4f0ea82f5315285ae1100069332e64a1426dbc1eb9b3b3ff3cc6dc4c687d33ed161269c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a03eb5efdc5b31e63d9cd1ab4c6c3c3a5b9397e367b41fd7ae72ccce5d2db306f07729f66f1980d583b8b4c5b61556901bf0fa58c2eed97318c18861ff2a5e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfc53e318f82dac9dfe06c2f12d5acadc1f2d3b85426127aa705323277bcd2d6b1c3f0df53e2da333e9187ed0eeba95ef670a1818b8cc756bbeb6ba1f924dd21"} 11:40:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:40:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:40:11 INFO - Contents: 11:40:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f941de949404d4db95e7d9d2fbd08a78eab400e1431f1e2c8149bed2c4f0ea82f5315285ae1100069332e64a1426dbc1eb9b3b3ff3cc6dc4c687d33ed161269c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a03eb5efdc5b31e63d9cd1ab4c6c3c3a5b9397e367b41fd7ae72ccce5d2db306f07729f66f1980d583b8b4c5b61556901bf0fa58c2eed97318c18861ff2a5e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfc53e318f82dac9dfe06c2f12d5acadc1f2d3b85426127aa705323277bcd2d6b1c3f0df53e2da333e9187ed0eeba95ef670a1818b8cc756bbeb6ba1f924dd21"} 11:40:11 INFO - Running post-run listener: copy_logs_to_upload_dir 11:40:11 INFO - Copying logs to upload dir... 11:40:11 INFO - mkdir: /builds/slave/test/build/upload/logs 11:40:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.231869 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-06 11:40:11.087318) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 11:40:11.090834) ========= 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=14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f941de949404d4db95e7d9d2fbd08a78eab400e1431f1e2c8149bed2c4f0ea82f5315285ae1100069332e64a1426dbc1eb9b3b3ff3cc6dc4c687d33ed161269c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a03eb5efdc5b31e63d9cd1ab4c6c3c3a5b9397e367b41fd7ae72ccce5d2db306f07729f66f1980d583b8b4c5b61556901bf0fa58c2eed97318c18861ff2a5e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfc53e318f82dac9dfe06c2f12d5acadc1f2d3b85426127aa705323277bcd2d6b1c3f0df53e2da333e9187ed0eeba95ef670a1818b8cc756bbeb6ba1f924dd21"} build_url:https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/cB0LBiD0RD2-VBac7-rMKQ/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/Fx-Team/sha512/f941de949404d4db95e7d9d2fbd08a78eab400e1431f1e2c8149bed2c4f0ea82f5315285ae1100069332e64a1426dbc1eb9b3b3ff3cc6dc4c687d33ed161269c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a03eb5efdc5b31e63d9cd1ab4c6c3c3a5b9397e367b41fd7ae72ccce5d2db306f07729f66f1980d583b8b4c5b61556901bf0fa58c2eed97318c18861ff2a5e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfc53e318f82dac9dfe06c2f12d5acadc1f2d3b85426127aa705323277bcd2d6b1c3f0df53e2da333e9187ed0eeba95ef670a1818b8cc756bbeb6ba1f924dd21"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 11:40:11.117346) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 11:40:11.117716) ========= 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=14ef55db36f7623abb31b9cf000001d5-1475777968.288280-392196445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 11:40:11.201405) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 11:40:11.201758) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 11:40:11.202086) ========= ========= Total master_lag: 0.18 =========