builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1475901368.19 results: success (0) buildid: 20161007200722 builduid: 34be07cfadce426fa95d44f687be693d revision: a835589ae0c63a2d91be150d80b5fc600e44b447 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 21:36:08.191657) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 21:36:08.192392) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 21:36:08.192945) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 21:36:08.211463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:36:08.211912) ========= 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=62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-07 21:36:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-10-07 21:36:08 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098301 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:36:08.328537) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:36:08.329348) ========= 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=62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017620 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:36:08.380836) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 21:36:08.381212) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a835589ae0c63a2d91be150d80b5fc600e44b447 --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 a835589ae0c63a2d91be150d80b5fc600e44b447 --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=62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-07 21:36:08,474 truncating revision to first 12 chars 2016-10-07 21:36:08,474 Setting DEBUG logging. 2016-10-07 21:36:08,474 attempt 1/10 2016-10-07 21:36:08,474 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a835589ae0c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 21:36:09,574 unpacking tar archive at: fx-team-a835589ae0c6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.442015 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 21:36:09.838772) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 21:36:09.839124) ========= script_repo_revision: a835589ae0c63a2d91be150d80b5fc600e44b447 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 21:36:09.839631) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 21:36:09.839965) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 21:36:09.850308) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-07 21:36:09.850632) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:36:10 INFO - MultiFileLogger online at 20161007 21:36:10 in /builds/slave/test 21:36:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 21:36:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:36:10 INFO - {'append_to_log': False, 21:36:10 INFO - 'base_work_dir': '/builds/slave/test', 21:36:10 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:36:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:36:10 INFO - 'branch': 'Fx-Team-Non-PGO', 21:36:10 INFO - 'buildbot_json_path': 'buildprops.json', 21:36:10 INFO - 'config_files': ('talos/linux_config.py',), 21:36:10 INFO - 'default_actions': ('clobber', 21:36:10 INFO - 'read-buildbot-config', 21:36:10 INFO - 'download-and-extract', 21:36:10 INFO - 'populate-webroot', 21:36:10 INFO - 'create-virtualenv', 21:36:10 INFO - 'install', 21:36:10 INFO - 'run-tests'), 21:36:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:36:10 INFO - 'download_minidump_stackwalk': True, 21:36:10 INFO - 'download_symbols': 'ondemand', 21:36:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:36:10 INFO - 'tooltool.py': '/tools/tooltool.py', 21:36:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:36:10 INFO - '/tools/misc-python/virtualenv.py')}, 21:36:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:36:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:36:10 INFO - 'installer_path': 'installer.exe', 21:36:10 INFO - 'log_level': 'info', 21:36:10 INFO - 'log_name': 'talos', 21:36:10 INFO - 'log_to_console': True, 21:36:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:36:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:36:10 INFO - 'opt_config_files': (), 21:36:10 INFO - 'pip_index': False, 21:36:10 INFO - 'sps_profile': False, 21:36:10 INFO - 'sps_profile_interval': 0, 21:36:10 INFO - 'suite': 'dromaeojs', 21:36:10 INFO - 'system_bits': '32', 21:36:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:36:10 INFO - 'title': 'talos-linux64-ix-018', 21:36:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:36:10 INFO - 'use_talos_json': True, 21:36:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:36:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:36:10 INFO - 'work_dir': 'build'} 21:36:10 INFO - [mozharness: 2016-10-08 04:36:10.048305Z] Running clobber step. 21:36:10 INFO - Running pre-action listener: _resource_record_pre_action 21:36:10 INFO - Running main action method: clobber 21:36:10 INFO - rmtree: /builds/slave/test/build 21:36:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:36:10 INFO - Running post-action listener: _resource_record_post_action 21:36:10 INFO - [mozharness: 2016-10-08 04:36:10.501407Z] Finished clobber step (success) 21:36:10 INFO - [mozharness: 2016-10-08 04:36:10.501509Z] Running read-buildbot-config step. 21:36:10 INFO - Running pre-action listener: _resource_record_pre_action 21:36:10 INFO - Running main action method: read_buildbot_config 21:36:10 INFO - Using buildbot properties: 21:36:10 INFO - { 21:36:10 INFO - "project": "", 21:36:10 INFO - "product": "firefox", 21:36:10 INFO - "script_repo_revision": "production", 21:36:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:36:10 INFO - "repository": "", 21:36:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:36:10 INFO - "buildid": "20161007200722", 21:36:10 INFO - "pgo_build": "False", 21:36:10 INFO - "basedir": "/builds/slave/test", 21:36:10 INFO - "buildnumber": 1972, 21:36:10 INFO - "slavename": "talos-linux64-ix-018", 21:36:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:36:10 INFO - "platform": "ubuntu64_hw", 21:36:10 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:36:10 INFO - "branch": "fx-team", 21:36:10 INFO - "repo_path": "integration/fx-team", 21:36:10 INFO - "revision": "a835589ae0c63a2d91be150d80b5fc600e44b447", 21:36:10 INFO - "stage_platform": "linux64", 21:36:10 INFO - "builduid": "34be07cfadce426fa95d44f687be693d", 21:36:10 INFO - "slavebuilddir": "test" 21:36:10 INFO - } 21:36:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:36:10 INFO - Running post-action listener: _resource_record_post_action 21:36:10 INFO - [mozharness: 2016-10-08 04:36:10.503901Z] Finished read-buildbot-config step (success) 21:36:10 INFO - [mozharness: 2016-10-08 04:36:10.503988Z] Running download-and-extract step. 21:36:10 INFO - Running pre-action listener: _resource_record_pre_action 21:36:10 INFO - Running main action method: download_and_extract 21:36:10 INFO - mkdir: /builds/slave/test/build/tests 21:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:10 INFO - trying https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:36:10 INFO - Downloading https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:36:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:36:11 INFO - Downloaded 1361 bytes. 21:36:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:36:11 INFO - Using the following test package requirements: 21:36:11 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:36:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:36:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:36:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:36:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:36:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:36:11 INFO - u'jsshell-linux-x86_64.zip'], 21:36:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:36:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:36:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:36:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:36:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:36:11 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:36:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:36:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:36:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:36:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:36:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:36:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:36:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:36:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:36:11 INFO - Fetch https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:36:11 INFO - Http code: 200 21:36:11 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 21:36:11 INFO - x-amz-cf-id: RyPVN-7UorQK84k5D0PcbhH0dsSbdSBB4DfZG-MoTS4_D1H26ApuyQ== 21:36:11 INFO - x-amz-version-id: rB8ebGkwq6kRkMaVhSz6k_g3olMleZeK 21:36:11 INFO - Expected file size: 20539066 21:36:11 INFO - Obtained file size: 20539066 21:36:15 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:36:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:36:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:36:15 INFO - Fetch https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:36:16 INFO - Http code: 200 21:36:16 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 21:36:16 INFO - x-amz-cf-id: IJfK84A5rJn4JFjOoOdQKpKLONpqJK8LqmKag1yD8B0j-fhab7-e-A== 21:36:16 INFO - x-amz-version-id: rB8ebGkwq6kRkMaVhSz6k_g3olMleZeK 21:36:16 INFO - Expected file size: 20539066 21:36:16 INFO - Obtained file size: 20539066 21:36:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:36:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:36:21 INFO - Fetch https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:36:21 INFO - Http code: 200 21:36:21 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 21:36:21 INFO - x-amz-cf-id: o3Ws7mPi6TbPsQeegoyNppWivLNJjiJ9hfr-I-y_rxvcqpFgnnMaQg== 21:36:21 INFO - x-amz-version-id: 2BCc5_EHV7.yl3LSl4rG_wGhvAn3lqmS 21:36:22 INFO - Expected file size: 14409006 21:36:22 INFO - Obtained file size: 14409006 21:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:22 INFO - trying https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:36:22 INFO - Downloading https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:36:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:36:23 INFO - Downloaded 55844624 bytes. 21:36:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:36:23 INFO - mkdir: /builds/slave/test/properties 21:36:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:36:23 INFO - Writing to file /builds/slave/test/properties/build_url 21:36:23 INFO - Contents: 21:36:23 INFO - build_url:https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:36:24 INFO - Running post-action listener: _resource_record_post_action 21:36:24 INFO - Running post-action listener: set_extra_try_arguments 21:36:24 INFO - [mozharness: 2016-10-08 04:36:24.187664Z] Finished download-and-extract step (success) 21:36:24 INFO - [mozharness: 2016-10-08 04:36:24.187888Z] Running populate-webroot step. 21:36:24 INFO - Running pre-action listener: _resource_record_pre_action 21:36:24 INFO - Running main action method: populate_webroot 21:36:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:36:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:36:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:36:24 INFO - '--tppagecycles', 21:36:24 INFO - '7'], 21:36:24 INFO - 'tests': ['tsvgm']}}, 21:36:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:36:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:36:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:36:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:36:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:36:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:36:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:36:24 INFO - 'talos_options': ['--disable-e10s'], 21:36:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:36:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:36:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:36:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:36:24 INFO - 'talos_options': ['--disable-e10s'], 21:36:24 INFO - 'tests': ['damp', 'tps']}, 21:36:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:36:24 INFO - 'tests': ['damp', 'tps']}, 21:36:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:36:24 INFO - 'tests': ['dromaeo_dom']}, 21:36:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:36:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:36:24 INFO - 'tests': ['basic_compositor_video']}, 21:36:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:36:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:36:24 INFO - 'tests': ['a11yr', 21:36:24 INFO - 'ts_paint', 21:36:24 INFO - 'tpaint', 21:36:24 INFO - 'sessionrestore', 21:36:24 INFO - 'sessionrestore_no_auto_restore', 21:36:24 INFO - 'tabpaint']}, 21:36:24 INFO - 'other-e10s': {'tests': ['a11yr', 21:36:24 INFO - 'ts_paint', 21:36:24 INFO - 'tpaint', 21:36:24 INFO - 'sessionrestore', 21:36:24 INFO - 'sessionrestore_no_auto_restore', 21:36:24 INFO - 'tabpaint']}, 21:36:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:36:24 INFO - 'ts_paint', 21:36:24 INFO - 'tpaint', 21:36:24 INFO - 'sessionrestore', 21:36:24 INFO - 'sessionrestore_no_auto_restore', 21:36:24 INFO - 'tabpaint']}, 21:36:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:36:24 INFO - 'ts_paint', 21:36:24 INFO - 'tpaint', 21:36:24 INFO - 'sessionrestore', 21:36:24 INFO - 'sessionrestore_no_auto_restore', 21:36:24 INFO - 'tabpaint']}, 21:36:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:36:24 INFO - 'tests': ['a11yr', 21:36:24 INFO - 'ts_paint', 21:36:24 INFO - 'tpaint', 21:36:24 INFO - 'sessionrestore', 21:36:24 INFO - 'sessionrestore_no_auto_restore', 21:36:24 INFO - 'tabpaint']}, 21:36:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:36:24 INFO - 'tests': ['a11yr', 21:36:24 INFO - 'ts_paint', 21:36:24 INFO - 'tpaint', 21:36:24 INFO - 'sessionrestore', 21:36:24 INFO - 'sessionrestore_no_auto_restore', 21:36:24 INFO - 'tabpaint']}, 21:36:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:36:24 INFO - 'tests': ['tsvgx', 21:36:24 INFO - 'tsvgr_opacity', 21:36:24 INFO - 'tart', 21:36:24 INFO - 'tscrollx', 21:36:24 INFO - 'cart']}, 21:36:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:36:24 INFO - 'tsvgr_opacity', 21:36:24 INFO - 'tart', 21:36:24 INFO - 'tscrollx', 21:36:24 INFO - 'cart']}, 21:36:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:36:24 INFO - 'talos_options': ['--disable-e10s'], 21:36:24 INFO - 'tests': ['tp5o']}, 21:36:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:36:24 INFO - 'tests': ['tp5o']}, 21:36:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:36:24 INFO - 'talos_options': ['--disable-e10s', 21:36:24 INFO - '--xperf_path', 21:36:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:36:24 INFO - 'tests': ['tp5n']}, 21:36:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:36:24 INFO - 'talos_options': ['--xperf_path', 21:36:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:36:24 INFO - 'tests': ['tp5n']}}, 21:36:24 INFO - 'talos.zip': {'path': '', 21:36:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:36:24 INFO - Running post-action listener: _resource_record_post_action 21:36:24 INFO - [mozharness: 2016-10-08 04:36:24.204621Z] Finished populate-webroot step (success) 21:36:24 INFO - [mozharness: 2016-10-08 04:36:24.204708Z] Running create-virtualenv step. 21:36:24 INFO - Running pre-action listener: _resource_record_pre_action 21:36:24 INFO - Running main action method: create_virtualenv 21:36:24 INFO - Creating virtualenv /builds/slave/test/build/venv 21:36:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:36:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:36:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:36:24 INFO - Using real prefix '/usr' 21:36:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:36:24 INFO - Installing distribute.............................................................................................................................................................................................done. 21:36:26 INFO - Installing pip.................done. 21:36:26 INFO - Return code: 0 21:36:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:36:26 INFO - Reading from file tmpfile_stdout 21:36:26 INFO - Output received: 21:36:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:36:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dbf504f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf60>, '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 0x18ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18de1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:36:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:36:26 INFO - Using env: {'DISPLAY': ':0', 21:36:26 INFO - 'HOME': '/home/cltbld', 21:36:26 INFO - 'LANG': 'en_US.UTF-8', 21:36:26 INFO - 'LANGUAGE': 'en_US:en', 21:36:26 INFO - 'LOGNAME': 'cltbld', 21:36:26 INFO - 'MAIL': '/var/mail/cltbld', 21:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:26 INFO - 'MOZ_NO_REMOTE': '1', 21:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:36:26 INFO - 'NO_EM_RESTART': '1', 21:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:26 INFO - 'PWD': '/builds/slave/test', 21:36:26 INFO - 'SHELL': '/bin/bash', 21:36:26 INFO - 'SHLVL': '1', 21:36:26 INFO - 'TERM': 'linux', 21:36:26 INFO - 'TMOUT': '86400', 21:36:26 INFO - 'USER': 'cltbld', 21:36:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 21:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:26 INFO - '_': '/tools/buildbot/bin/python'} 21:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:36:27 INFO - Cleaning up... 21:36:27 INFO - Return code: 0 21:36:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:27 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 0x7f0dbf504f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf60>, '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 0x18ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18de1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:36:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:36:27 INFO - Using env: {'DISPLAY': ':0', 21:36:27 INFO - 'HOME': '/home/cltbld', 21:36:27 INFO - 'LANG': 'en_US.UTF-8', 21:36:27 INFO - 'LANGUAGE': 'en_US:en', 21:36:27 INFO - 'LOGNAME': 'cltbld', 21:36:27 INFO - 'MAIL': '/var/mail/cltbld', 21:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:27 INFO - 'MOZ_NO_REMOTE': '1', 21:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:36:27 INFO - 'NO_EM_RESTART': '1', 21:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:27 INFO - 'PWD': '/builds/slave/test', 21:36:27 INFO - 'SHELL': '/bin/bash', 21:36:27 INFO - 'SHLVL': '1', 21:36:27 INFO - 'TERM': 'linux', 21:36:27 INFO - 'TMOUT': '86400', 21:36:27 INFO - 'USER': 'cltbld', 21:36:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 21:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:27 INFO - '_': '/tools/buildbot/bin/python'} 21:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:27 INFO - Downloading/unpacking psutil>=3.1.1 21:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:36:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:36:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:36:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:36:29 INFO - Installing collected packages: psutil 21:36:29 INFO - Running setup.py install for psutil 21:36:29 INFO - building 'psutil._psutil_linux' extension 21:36:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:36:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:36:29 INFO - building 'psutil._psutil_posix' extension 21:36:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:36:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:36:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:36:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:36:29 INFO - Successfully installed psutil 21:36:29 INFO - Cleaning up... 21:36:29 INFO - Return code: 0 21:36:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:29 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 0x7f0dbf504f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf60>, '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 0x18ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18de1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:36:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:36:29 INFO - Using env: {'DISPLAY': ':0', 21:36:29 INFO - 'HOME': '/home/cltbld', 21:36:29 INFO - 'LANG': 'en_US.UTF-8', 21:36:29 INFO - 'LANGUAGE': 'en_US:en', 21:36:29 INFO - 'LOGNAME': 'cltbld', 21:36:29 INFO - 'MAIL': '/var/mail/cltbld', 21:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:29 INFO - 'MOZ_NO_REMOTE': '1', 21:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:36:29 INFO - 'NO_EM_RESTART': '1', 21:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:29 INFO - 'PWD': '/builds/slave/test', 21:36:29 INFO - 'SHELL': '/bin/bash', 21:36:30 INFO - 'SHLVL': '1', 21:36:30 INFO - 'TERM': 'linux', 21:36:30 INFO - 'TMOUT': '86400', 21:36:30 INFO - 'USER': 'cltbld', 21:36:30 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 21:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:30 INFO - '_': '/tools/buildbot/bin/python'} 21:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:36:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:36:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:36:32 INFO - Installing collected packages: mozsystemmonitor 21:36:32 INFO - Running setup.py install for mozsystemmonitor 21:36:32 INFO - Successfully installed mozsystemmonitor 21:36:32 INFO - Cleaning up... 21:36:32 INFO - Return code: 0 21:36:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:32 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 0x7f0dbf504f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf60>, '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 0x18ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18de1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:36:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:36:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:36:32 INFO - Using env: {'DISPLAY': ':0', 21:36:32 INFO - 'HOME': '/home/cltbld', 21:36:32 INFO - 'LANG': 'en_US.UTF-8', 21:36:32 INFO - 'LANGUAGE': 'en_US:en', 21:36:32 INFO - 'LOGNAME': 'cltbld', 21:36:32 INFO - 'MAIL': '/var/mail/cltbld', 21:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:32 INFO - 'MOZ_NO_REMOTE': '1', 21:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:36:32 INFO - 'NO_EM_RESTART': '1', 21:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:32 INFO - 'PWD': '/builds/slave/test', 21:36:32 INFO - 'SHELL': '/bin/bash', 21:36:32 INFO - 'SHLVL': '1', 21:36:32 INFO - 'TERM': 'linux', 21:36:32 INFO - 'TMOUT': '86400', 21:36:32 INFO - 'USER': 'cltbld', 21:36:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 21:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:32 INFO - '_': '/tools/buildbot/bin/python'} 21:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:32 INFO - Downloading/unpacking jsonschema==2.5.1 21:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:36:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:36:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:36:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:34 INFO - Downloading functools32-3.2.3-2.tar.gz 21:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:36:34 INFO - warning: no files found matching '*.txt' 21:36:34 INFO - no previously-included directories found matching 'build' 21:36:34 INFO - no previously-included directories found matching 'dist' 21:36:34 INFO - no previously-included directories found matching '.git*' 21:36:34 INFO - Installing collected packages: jsonschema, functools32 21:36:34 INFO - Running setup.py install for functools32 21:36:34 INFO - warning: no files found matching '*.txt' 21:36:34 INFO - no previously-included directories found matching 'build' 21:36:34 INFO - no previously-included directories found matching 'dist' 21:36:34 INFO - no previously-included directories found matching '.git*' 21:36:34 INFO - Successfully installed jsonschema functools32 21:36:34 INFO - Cleaning up... 21:36:34 INFO - Return code: 0 21:36:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:34 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 0x7f0dbf504f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf60>, '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 0x18ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18de1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:36:34 INFO - Using env: {'DISPLAY': ':0', 21:36:34 INFO - 'HOME': '/home/cltbld', 21:36:34 INFO - 'LANG': 'en_US.UTF-8', 21:36:34 INFO - 'LANGUAGE': 'en_US:en', 21:36:34 INFO - 'LOGNAME': 'cltbld', 21:36:34 INFO - 'MAIL': '/var/mail/cltbld', 21:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:34 INFO - 'MOZ_NO_REMOTE': '1', 21:36:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:36:34 INFO - 'NO_EM_RESTART': '1', 21:36:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:34 INFO - 'PWD': '/builds/slave/test', 21:36:34 INFO - 'SHELL': '/bin/bash', 21:36:34 INFO - 'SHLVL': '1', 21:36:34 INFO - 'TERM': 'linux', 21:36:34 INFO - 'TMOUT': '86400', 21:36:34 INFO - 'USER': 'cltbld', 21:36:34 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 21:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:34 INFO - '_': '/tools/buildbot/bin/python'} 21:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:36:35 INFO - Cleaning up... 21:36:35 INFO - Return code: 0 21:36:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:35 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 0x7f0dbf504f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf60>, '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 0x18ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18de1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:36:35 INFO - Using env: {'DISPLAY': ':0', 21:36:35 INFO - 'HOME': '/home/cltbld', 21:36:35 INFO - 'LANG': 'en_US.UTF-8', 21:36:35 INFO - 'LANGUAGE': 'en_US:en', 21:36:35 INFO - 'LOGNAME': 'cltbld', 21:36:35 INFO - 'MAIL': '/var/mail/cltbld', 21:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:35 INFO - 'MOZ_NO_REMOTE': '1', 21:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:36:35 INFO - 'NO_EM_RESTART': '1', 21:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:35 INFO - 'PWD': '/builds/slave/test', 21:36:35 INFO - 'SHELL': '/bin/bash', 21:36:35 INFO - 'SHLVL': '1', 21:36:35 INFO - 'TERM': 'linux', 21:36:35 INFO - 'TMOUT': '86400', 21:36:35 INFO - 'USER': 'cltbld', 21:36:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 21:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:35 INFO - '_': '/tools/buildbot/bin/python'} 21:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:35 INFO - Downloading/unpacking blobuploader==1.2.4 21:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:36:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:37 INFO - Downloading blobuploader-1.2.4.tar.gz 21:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:36:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:36:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:36:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:36:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:37 INFO - Downloading docopt-0.6.1.tar.gz 21:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:36:37 INFO - Installing collected packages: blobuploader, requests, docopt 21:36:37 INFO - Running setup.py install for blobuploader 21:36:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:36:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:36:38 INFO - Running setup.py install for requests 21:36:38 INFO - Running setup.py install for docopt 21:36:38 INFO - Successfully installed blobuploader requests docopt 21:36:38 INFO - Cleaning up... 21:36:38 INFO - Return code: 0 21:36:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:38 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 0x7f0dbf504f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf60>, '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 0x18ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18de1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:36:38 INFO - Using env: {'DISPLAY': ':0', 21:36:38 INFO - 'HOME': '/home/cltbld', 21:36:38 INFO - 'LANG': 'en_US.UTF-8', 21:36:38 INFO - 'LANGUAGE': 'en_US:en', 21:36:38 INFO - 'LOGNAME': 'cltbld', 21:36:38 INFO - 'MAIL': '/var/mail/cltbld', 21:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:38 INFO - 'MOZ_NO_REMOTE': '1', 21:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:36:38 INFO - 'NO_EM_RESTART': '1', 21:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:38 INFO - 'PWD': '/builds/slave/test', 21:36:38 INFO - 'SHELL': '/bin/bash', 21:36:38 INFO - 'SHLVL': '1', 21:36:38 INFO - 'TERM': 'linux', 21:36:38 INFO - 'TMOUT': '86400', 21:36:38 INFO - 'USER': 'cltbld', 21:36:38 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 21:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:38 INFO - '_': '/tools/buildbot/bin/python'} 21:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:36:38 INFO - Running setup.py (path:/tmp/pip-IzMEcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:36:38 INFO - Running setup.py (path:/tmp/pip-2iZ2VZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:36:38 INFO - Running setup.py (path:/tmp/pip-wyP_oV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:36:39 INFO - Running setup.py (path:/tmp/pip-4yusod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:36:39 INFO - Running setup.py (path:/tmp/pip-VuBSPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:36:39 INFO - Running setup.py (path:/tmp/pip-3Y8oY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:36:39 INFO - Running setup.py (path:/tmp/pip-tXNSv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:36:39 INFO - Running setup.py (path:/tmp/pip-AkrrrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:36:39 INFO - Running setup.py (path:/tmp/pip-8WiDrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:36:39 INFO - Running setup.py (path:/tmp/pip-Un1xD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:36:39 INFO - Running setup.py (path:/tmp/pip-I9B3u5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:36:39 INFO - Running setup.py (path:/tmp/pip-LEEIii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:36:39 INFO - Running setup.py (path:/tmp/pip-s6oCco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:36:39 INFO - Running setup.py (path:/tmp/pip-sL03SR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:36:39 INFO - Running setup.py (path:/tmp/pip-Nq760v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:36:39 INFO - Running setup.py (path:/tmp/pip-1igmhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:36:39 INFO - Running setup.py (path:/tmp/pip-iaZlr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:36:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:36:40 INFO - Running setup.py install for manifestparser 21:36:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:36:40 INFO - Running setup.py install for mozcrash 21:36:40 INFO - Running setup.py install for mozdebug 21:36:40 INFO - Running setup.py install for mozdevice 21:36:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:36:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:36:40 INFO - Running setup.py install for mozfile 21:36:40 INFO - Running setup.py install for mozhttpd 21:36:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:36:40 INFO - Running setup.py install for mozinfo 21:36:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:36:40 INFO - Running setup.py install for mozInstall 21:36:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:36:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:36:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:36:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:36:40 INFO - Running setup.py install for mozleak 21:36:40 INFO - Running setup.py install for mozlog 21:36:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:36:41 INFO - Running setup.py install for moznetwork 21:36:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:36:41 INFO - Running setup.py install for mozprocess 21:36:41 INFO - Running setup.py install for mozprofile 21:36:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:36:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:36:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:36:41 INFO - Running setup.py install for mozrunner 21:36:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:36:41 INFO - Running setup.py install for mozscreenshot 21:36:41 INFO - Running setup.py install for moztest 21:36:41 INFO - Running setup.py install for mozversion 21:36:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:36:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:36:41 INFO - Cleaning up... 21:36:41 INFO - Return code: 0 21:36:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:41 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 0x7f0dbf504f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf60>, '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 0x18ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18de1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:36:41 INFO - Using env: {'DISPLAY': ':0', 21:36:41 INFO - 'HOME': '/home/cltbld', 21:36:41 INFO - 'LANG': 'en_US.UTF-8', 21:36:41 INFO - 'LANGUAGE': 'en_US:en', 21:36:41 INFO - 'LOGNAME': 'cltbld', 21:36:41 INFO - 'MAIL': '/var/mail/cltbld', 21:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:41 INFO - 'MOZ_NO_REMOTE': '1', 21:36:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:36:41 INFO - 'NO_EM_RESTART': '1', 21:36:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:41 INFO - 'PWD': '/builds/slave/test', 21:36:41 INFO - 'SHELL': '/bin/bash', 21:36:41 INFO - 'SHLVL': '1', 21:36:41 INFO - 'TERM': 'linux', 21:36:41 INFO - 'TMOUT': '86400', 21:36:41 INFO - 'USER': 'cltbld', 21:36:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 21:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:41 INFO - '_': '/tools/buildbot/bin/python'} 21:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:36:42 INFO - Running setup.py (path:/tmp/pip-OfjRK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:36:42 INFO - Running setup.py (path:/tmp/pip-PfqRFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:36:42 INFO - Running setup.py (path:/tmp/pip-XaNRHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:36:42 INFO - Running setup.py (path:/tmp/pip-WYW6Px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:36:42 INFO - Running setup.py (path:/tmp/pip-nKqa6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:36:42 INFO - Running setup.py (path:/tmp/pip-wwIfDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:36:42 INFO - Running setup.py (path:/tmp/pip-oprqHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:36:42 INFO - Running setup.py (path:/tmp/pip-16Ph0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:36:42 INFO - Running setup.py (path:/tmp/pip-3o_67_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:36:42 INFO - Running setup.py (path:/tmp/pip-TQqVNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:36:42 INFO - Running setup.py (path:/tmp/pip-Ko09sQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:36:42 INFO - Running setup.py (path:/tmp/pip-F1CCW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:36:42 INFO - Running setup.py (path:/tmp/pip-yjzBbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:36:42 INFO - Running setup.py (path:/tmp/pip-x1tKZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:36:43 INFO - Running setup.py (path:/tmp/pip-taMeTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:36:43 INFO - Running setup.py (path:/tmp/pip-1lyqZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:36:43 INFO - Running setup.py (path:/tmp/pip-mHwiDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:36:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:36:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:36:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:45 INFO - Downloading blessings-1.6.tar.gz 21:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:36:45 INFO - Installing collected packages: blessings 21:36:45 INFO - Running setup.py install for blessings 21:36:45 INFO - Successfully installed blessings 21:36:45 INFO - Cleaning up... 21:36:45 INFO - Return code: 0 21:36:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:36:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:36:45 INFO - Reading from file tmpfile_stdout 21:36:45 INFO - Current package versions: 21:36:45 INFO - argparse == 1.2.1 21:36:45 INFO - blessings == 1.6 21:36:45 INFO - blobuploader == 1.2.4 21:36:45 INFO - docopt == 0.6.1 21:36:45 INFO - functools32 == 3.2.3-2 21:36:45 INFO - jsonschema == 2.5.1 21:36:45 INFO - manifestparser == 1.1 21:36:45 INFO - mozInstall == 1.12 21:36:45 INFO - mozcrash == 0.17 21:36:45 INFO - mozdebug == 0.1 21:36:45 INFO - mozdevice == 0.48 21:36:45 INFO - mozfile == 1.2 21:36:45 INFO - mozhttpd == 0.7 21:36:45 INFO - mozinfo == 0.9 21:36:45 INFO - mozleak == 0.1 21:36:45 INFO - mozlog == 3.4 21:36:45 INFO - moznetwork == 0.27 21:36:45 INFO - mozprocess == 0.23 21:36:45 INFO - mozprofile == 0.28 21:36:45 INFO - mozrunner == 6.12 21:36:45 INFO - mozscreenshot == 0.1 21:36:45 INFO - mozsystemmonitor == 0.3 21:36:45 INFO - moztest == 0.7 21:36:45 INFO - mozversion == 1.4 21:36:45 INFO - psutil == 3.1.1 21:36:45 INFO - requests == 1.2.3 21:36:45 INFO - wsgiref == 0.1.2 21:36:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:45 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 0x7f0dbf504f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf60>, '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 0x18ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18de1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:36:45 INFO - Using env: {'DISPLAY': ':0', 21:36:45 INFO - 'HOME': '/home/cltbld', 21:36:45 INFO - 'LANG': 'en_US.UTF-8', 21:36:45 INFO - 'LANGUAGE': 'en_US:en', 21:36:45 INFO - 'LOGNAME': 'cltbld', 21:36:45 INFO - 'MAIL': '/var/mail/cltbld', 21:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:45 INFO - 'MOZ_NO_REMOTE': '1', 21:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:36:45 INFO - 'NO_EM_RESTART': '1', 21:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:45 INFO - 'PWD': '/builds/slave/test', 21:36:45 INFO - 'SHELL': '/bin/bash', 21:36:45 INFO - 'SHLVL': '1', 21:36:45 INFO - 'TERM': 'linux', 21:36:45 INFO - 'TMOUT': '86400', 21:36:45 INFO - 'USER': 'cltbld', 21:36:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 21:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:45 INFO - '_': '/tools/buildbot/bin/python'} 21:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:36:45 INFO - Cleaning up... 21:36:45 INFO - Return code: 0 21:36:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dbf504f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dcf60>, '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 0x18ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18de1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:36:45 INFO - Using env: {'DISPLAY': ':0', 21:36:45 INFO - 'HOME': '/home/cltbld', 21:36:45 INFO - 'LANG': 'en_US.UTF-8', 21:36:45 INFO - 'LANGUAGE': 'en_US:en', 21:36:45 INFO - 'LOGNAME': 'cltbld', 21:36:45 INFO - 'MAIL': '/var/mail/cltbld', 21:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:45 INFO - 'MOZ_NO_REMOTE': '1', 21:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:36:45 INFO - 'NO_EM_RESTART': '1', 21:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:45 INFO - 'PWD': '/builds/slave/test', 21:36:45 INFO - 'SHELL': '/bin/bash', 21:36:45 INFO - 'SHLVL': '1', 21:36:45 INFO - 'TERM': 'linux', 21:36:45 INFO - 'TMOUT': '86400', 21:36:45 INFO - 'USER': 'cltbld', 21:36:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 21:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:45 INFO - '_': '/tools/buildbot/bin/python'} 21:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:36:46 INFO - Cleaning up... 21:36:46 INFO - Return code: 0 21:36:46 INFO - Running post-action listener: _resource_record_post_action 21:36:46 INFO - Running post-action listener: _start_resource_monitoring 21:36:46 INFO - Starting resource monitoring. 21:36:46 INFO - [mozharness: 2016-10-08 04:36:46.146379Z] Finished create-virtualenv step (success) 21:36:46 INFO - [mozharness: 2016-10-08 04:36:46.146836Z] Running install step. 21:36:46 INFO - Running pre-action listener: _resource_record_pre_action 21:36:46 INFO - Running main action method: install 21:36:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:36:46 INFO - Reading from file tmpfile_stdout 21:36:46 INFO - Detecting whether we're running mozinstall >=1.0... 21:36:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:36:46 INFO - Reading from file tmpfile_stdout 21:36:46 INFO - Output received: 21:36:46 INFO - Usage: mozinstall [options] installer 21:36:46 INFO - Options: 21:36:46 INFO - -h, --help show this help message and exit 21:36:46 INFO - -d DEST, --destination=DEST 21:36:46 INFO - Directory to install application into. [default: 21:36:46 INFO - "/builds/slave/test"] 21:36:46 INFO - --app=APP Application being installed. [default: firefox] 21:36:46 INFO - mkdir: /builds/slave/test/build/application 21:36:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:37:02 INFO - Reading from file tmpfile_stdout 21:37:02 INFO - Output received: 21:37:02 INFO - /builds/slave/test/build/application/firefox/firefox 21:37:02 INFO - Running post-action listener: _resource_record_post_action 21:37:02 INFO - [mozharness: 2016-10-08 04:37:02.641746Z] Finished install step (success) 21:37:02 INFO - [mozharness: 2016-10-08 04:37:02.641990Z] Running run-tests step. 21:37:02 INFO - Running pre-action listener: _resource_record_pre_action 21:37:02 INFO - Running main action method: run_tests 21:37:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:37:02 INFO - Python 2.7.3 21:37:02 INFO - Return code: 0 21:37:02 INFO - grabbing minidump binary from tooltool 21:37: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')]} 21:37:02 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 0x18dcf60>, '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 0x18ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18de1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:37:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:37:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:37:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:37:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:37:02 INFO - Return code: 0 21:37:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:37:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:37:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:37:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:37:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:37:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 21:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 21:37:02 INFO - Using env: {'DISPLAY': ':0', 21:37:02 INFO - 'HOME': '/home/cltbld', 21:37:02 INFO - 'LANG': 'en_US.UTF-8', 21:37:02 INFO - 'LANGUAGE': 'en_US:en', 21:37:02 INFO - 'LOGNAME': 'cltbld', 21:37:02 INFO - 'MAIL': '/var/mail/cltbld', 21:37:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:37:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:02 INFO - 'MOZ_NO_REMOTE': '1', 21:37:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:37:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:37:02 INFO - 'NO_EM_RESTART': '1', 21:37:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:02 INFO - 'PWD': '/builds/slave/test', 21:37:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:37:02 INFO - 'SHELL': '/bin/bash', 21:37:02 INFO - 'SHLVL': '1', 21:37:02 INFO - 'TERM': 'linux', 21:37:02 INFO - 'TMOUT': '86400', 21:37:02 INFO - 'USER': 'cltbld', 21:37:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057', 21:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:02 INFO - '_': '/tools/buildbot/bin/python'} 21:37:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 21:37:02 INFO - mozversion application_buildid: 20161007200722 21:37:02 INFO - mozversion application_changeset: a835589ae0c63a2d91be150d80b5fc600e44b447 21:37:02 INFO - mozversion application_display_name: Nightly 21:37:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:37:02 INFO - mozversion application_name: Firefox 21:37:02 INFO - mozversion application_remotingname: firefox 21:37:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:37:02 INFO - mozversion application_vendor: Mozilla 21:37:02 INFO - mozversion application_version: 52.0a1 21:37:02 INFO - mozversion platform_buildid: 20161007200722 21:37:02 INFO - mozversion platform_changeset: a835589ae0c63a2d91be150d80b5fc600e44b447 21:37:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:37:02 INFO - mozversion platform_version: 52.0a1 21:37:02 INFO - using testdate: 1475901422 21:37:02 INFO - actual date: 1475901422 21:37:02 INFO - starting webserver on 'localhost:60779' 21:37:02 INFO - SUITE-START | Running 2 tests 21:37:02 INFO - TEST-START | dromaeo_css 21:37:02 INFO - operating with platform_type : linux_ 21:37:02 INFO - Initialising browser for dromaeo_css test... 21:37:02 INFO - TEST-INFO | started process 8066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAoA7ft/profile http://localhost:60779/getInfo.html) 21:37:07 INFO - PROCESS | 8066 | __metrics Screen width/height:1600/1200 21:37:07 INFO - PROCESS | 8066 | colorDepth:24 21:37:07 INFO - PROCESS | 8066 | Browser inner width/height: 1024/697 21:37:07 INFO - PROCESS | 8066 | __metrics 21:37:07 INFO - PROCESS | 8066 | 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" 21:37:07 INFO - PROCESS | 8066 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:37:08 INFO - PROCESS | 8066 | console.error: PushService: 21:37:08 INFO - PROCESS | 8066 | stateChangeProcessEnqueue: Error transitioning state 21:37:08 INFO - PROCESS | 8066 | UnknownError 21:37:09 INFO - TEST-INFO | 8066: exit 0 21:37:09 INFO - Browser initialized. 21:37:09 INFO - Running cycle 1/1 for dromaeo_css test... 21:37:09 INFO - TEST-INFO | started process 8145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAoA7ft/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:37:21 INFO - PROCESS | 8145 | RSS: Main: 174022656 21:37:21 INFO - PROCESS | 8145 | 21:38:13 INFO - PROCESS | 8145 | 1475901493073 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:40:25 INFO - PROCESS | 8145 | Cycle 1(1): loaded http://localhost:60779/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60779/tests/dromaeo/cssquery-ext.html) 21:40:26 INFO - PROCESS | 8145 | RSS: Main: 286445568 21:40:26 INFO - PROCESS | 8145 | 21:43:29 INFO - PROCESS | 8145 | Cycle 1(1): loaded http://localhost:60779/tests/dromaeo/cssquery-ext.html (next: http://localhost:60779/tests/dromaeo/cssquery-jquery.html) 21:43:29 INFO - PROCESS | 8145 | RSS: Main: 275718144 21:43:29 INFO - PROCESS | 8145 | 21:46:31 INFO - PROCESS | 8145 | Cycle 1(1): loaded http://localhost:60779/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60779/tests/dromaeo/cssquery-mootools.html) 21:46:32 INFO - PROCESS | 8145 | RSS: Main: 256131072 21:46:32 INFO - PROCESS | 8145 | 21:49:34 INFO - PROCESS | 8145 | Cycle 1(1): loaded http://localhost:60779/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60779/tests/dromaeo/cssquery-prototype.html) 21:49:35 INFO - PROCESS | 8145 | RSS: Main: 218906624 21:49:35 INFO - PROCESS | 8145 | 21:52:38 INFO - PROCESS | 8145 | Cycle 1(1): loaded http://localhost:60779/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60779/tests/dromaeo/cssquery-yui.html) 21:52:39 INFO - PROCESS | 8145 | RSS: Main: 220307456 21:52:39 INFO - PROCESS | 8145 | 21:55:42 INFO - PROCESS | 8145 | Cycle 1(1): loaded http://localhost:60779/tests/dromaeo/cssquery-yui.html (next: http://localhost:60779/tests/dromaeo/cssquery-dojo.html) 21:55:42 INFO - PROCESS | 8145 | RSS: Main: 302735360 21:55:42 INFO - PROCESS | 8145 | 21:55:42 INFO - PROCESS | 8145 | __start_tp_report 21:55:42 INFO - PROCESS | 8145 | _x_x_mozilla_page_load 21:55:42 INFO - PROCESS | 8145 | _x_x_mozilla_page_load_details 21:55:42 INFO - PROCESS | 8145 | |i|pagename|runs| 21:55:42 INFO - PROCESS | 8145 | |0;dojo.html;2569.858657773823;2582.28987028567;2613.7386261373863;2624.068455698227;2633.7102918678943;4514.52597477265;4598.195315819727;4618.907621847566;4619.51495093015;4632.2356811126165;4618.861434156981;4647.465541462733;4651.116287905295;4663.7668116594205;4664.090502352043;4246.490421149459;4257.340112282585;4260.02019535507;4270.935935960963;4295.463067116611;4216.177845320164;4317.913641727164;4330.631896288819;4331.6534677225745;4384.430024096879;4284.914301713964;4298.978505107486;4299.699021068526;4348.260795664729;4351.738895666254;137.5812784387316;4246.660267178619;4253.617174454283;4283.164782867342;4294.463192100988;4197.853075142386;4219.810108545123;4224.176285624305;4227.534971153202;4265.808038638269;4656.068786242731;4656.790444430008;4661.394018777572;4709.293605959099;4720.079584481027;4845.53967373099;4888.364512613373;4906.877328066791;4986.950130498722;4992.326035985132;4962.975185124087;4966.255061740768;4987.326710894019;4988.226824842155;5051.318072060261;4608.055348653518;4645.210314246586;4654.394928659252;4657.04530571232;4707.105649926503;4908.852734417973;4946.1344264753525;5041.823536176216;5083;5133.076046311699;4847.781849816767;4887.022595480918;4892.608591312686;4932.432770231398;4941.209406494943;4967.751612419364;4983.725895075806;4983.875403114951;4986.950130498722;5042.42012168598;4800.255960326155;4856.805727770849;4919.3358896549225;4930.2851086592245;4976.0794253063295;4799.28010798383;4803.423589169322;4860.343853579792;4861.586765124934;4863.148948933923;4096.262672718939;4107.158032603309;4108.8767336979345;4154.979225103855;4162.334026555736;3604.9098772530897;3605.963940360615;3626.1478552540134;3639.3813051781262;3672.5225720656144;4195.4336164618;4218.261804184255;4235.25882970479;4273.059926816096;4276.615104640535;4948.802047918115;4949.925751113737;4953.554180123806;4954.405471343462;4981.501849814989;4272.636825869774;4277.893052673708;4278.4865816102265;4322.502912165141;4329.891752706145;4284.250256205151;4315.309550471972;4316.676249281317;4414.514403415622;4440.156370289635;4673.322368256584;4747.287906813867;4747.572718455355;4748.09786140646;4749.35883655702;4967.254911763264;4987.80048798044;4992.350994370709;4996.725180115129;5058.747062646779;4657.836975705834;4673.836415725569;4676.55572720591;4681.765911704333;4737.28940658904;4724.905501890012;4752.976235118802;4875.951240487691;4910.779014944407;4925.014997000686;4961.5534601886;4997.100521906092;5048.798048078036;5049.924251136163;5065.189569668835;4862.92705609409;4863.10032643962;4866.756662166807;4867.561919427269;4929.359183306147;4642.582167604932;4738.786754596121;4853.6602437829015;4871.472137786371;4930.926036109389;4662;4723.976380118077;4732.6687131900435;4740.288956656529;4768.356271903249;4784.545468180518;4791.928121078117;4793.664443488922;4801.4958429364415;4869.1722407190155;4576.8626941191815;4691.085238378483;4700.435947686299;4714.38712967312;4777.737224452689 21:55:42 INFO - PROCESS | 8145 | |1;ext.html;556.4463358957837;565.2256408720054;570.3526497425421;576.711644177911;578.9218455508507;26805.865970670144;27779;30056.849715751447;37116.257674846485;38367.80816095923;37976.43035354472;38546.03634909121;38717.806410967976;38724;38793.61206387935;7663.501872378305;7763.922360776404;7800.960995195044;7822.843543129134;7823.687052517921;7159.284071592851;7332.890006649878;7606.657700403495;9717.708468745914;9968.700938971842;9966.053224943618;9997.850032249522;10012.849807252896;10030.097291243786;10033.799324013515;9954.65158719445;10009.69970900874;10012.59949602015;10019.398836069859;10028.498575071253;6722.663866806689;6917.169939607279;6919.204291506491;7087.291270872923;9126.224270936978;36193.63806361929;36531.81734091339;36546.81726591376;36561.26877462436;36568.63431365679;2981.835999020053;3019.215004098928;3038.1189455058006;3123.687631236881;3154.68453154685;27321;27431.17706468809;27581.172564823086;27732.342007434945;28071.29821754452;3180.872765089394;3302.306515631696;3340.2150494633743;3343.64582344151;3384.069380920242;241893;243664;243684;243770;244672;44105;45382.09235815265;49999.50000500021;51761.48238517567;52140;55644;56151.71924140353;56153.1577026345;56177;56237.437625624036;13545.932270338586;13629.727405452033;13671.248081355421;13684.247366394944;13685.452581896612;9210.493422861808;9674.03259674027;9702;9705;9717.854232186522;14666.926665366818;16970.236339364757;17277.222524986406;17633.559161021076;18152;6506.837329066811;6683.2648408675;6716.261211266757;6786.353322204344;6888.965555172192;786.6106277392727;857.5283594023387;917.6237742525666;949.0888746803008;1007.536533194724;26356.472870542864;26715.465690686076;27175.1847444577;27178.5923211152;27210;957.1911734584265;969.1665167955553;988.663854289545;992.1021475564626;1016.903394177552;13366.465341386236;14496.420143194155;14534.418623254951;14643.194624295553;14740.557783266519;368668;372636;372926;373153;373290;47324;47792;47823.84792684337;47825.28262076002;47870.28194577084;1063.1760385701143;1082.4479515447022;1140.5779861451317;1175.3535555444641;1175.5767923547517;26167.86916065484;27896.163115106578;28908.855455722587;29204.56193157147;29218.415631687672;39831.601683982786;40318;40347.79826100851;40353.596464034985;40374.19251614893;294645;296567;296864;297294;297815;23978.28065158048;25064.248072557853;25071.498570028132;25927.870360648078;26038.34904127412;39132.41301380539;39139.41290880696;39583.40624890571;39773.80113099416;40559;34110.829445852614;34178.65821341755;34292.14269643279;34398;34890;34097;34339.31321373609;34434.31131377409;34748.82625586957;34822.651773482954;34465.82767086149;34740.652593474755;34998.30003399969;35220.823895880356;35585.28829423449;29034.12897613075;30656.481833270227;31718.524222136224;31790.205244869063;32163.67836321607;24064.87967560151;24780.25659230226;24860.39524269007;25233.621495677213;25268.115615953353 21:55:42 INFO - PROCESS | 8145 | |2;jquery.html;336.7709957229083;343.75593328736613;345.72342126298963;352.3217805723982;366.7139631087751;12155.331456769874;12626.305553194583;15678.294476748559;16056.59858503535;16212.513624591282;15874.444394446196;16473;16598.419055333066;16674.58313542162;16831.044704494463;4685.601723853477;4972.70163790172;5227.973860130713;5228.8692782680355;5230.084735171349;5941.554383421239;6068.362821903681;6097.969510152443;6101.755929762804;6131.785387511438;5784.768609255625;5950.404959504058;6019.759209631609;6031.185789918349;6032.819015429523;5896.823095307148;5923.703814809242;5924.7926322578505;5928.614640048405;5935.228420305376;4533.637309015304;4779.904401911977;4797.808087676489;4857.34425852509;5145.6398052136365;11224.49489772954;11361;11403.771924561463;11424.371659558721;17779.73330400045;1863.8974856382893;1895.346105593568;1930.6042261336393;2019.7677267114177;2369.07606033647;8618.138186181395;9036.32227582934;9271.165595096474;9431.104045115771;9569.808603827954;1703.3101593854508;1726.7755191824983;1753.9824601753946;1758.6570618729354;1786.3926265069938;64259.67870160666;70227.29772702258;70473.29526704719;70612.64693676551;71470.64264678644;9625.229981601455;9782.403965303594;9836;9896.307258491981;9923.00769923002;13808.17150970945;13850.861491385158;13881.583552493441;13882.236476993863;13888.097273677178;6780.32196780318;6970.721171153198;7013.333733295329;7075.292470752884;7116.608586527687;6461.838454038687;6551.0500977358015;6641.1366522352755;6688;6763.222229443677;4182.393552934807;4221.197972385237;4247.5540068293;4337.327714204303;4355.324924636623;1741.8171092035407;1767.1959258537336;1768.2043080613776;1770.3892157205744;1785.6696760913203;789.9052113746272;832.3341326938546;837.2673910328463;880.4145243413186;961.1157734883924;16032.911607540003;16164.191790410432;16280.511584652479;16417.343306267856;17410.912945435193;793.9761807145795;831.4720152703077;832.1137988042836;844.472204871955;872.9476231426135;8882.555872206363;9322.580483878242;9462.57418416173;9543.713688589354;9690.273229507815;331443;332097;335424;336092;336391;71499;72587.83003444661;73619.63190184122;75128.62435687897;76281.61859190669;860.6514361683653;922.4096578189964;935.5883411299006;945.3193700535603;949.3259785552335;14349.641258968191;15244;15725.135117568643;15886.920565397098;16036.839631603534;34639.826800865834;34941;35067.29865402729;35331.470027949086;35387.646123538434;45727.99760041913;46892.53107468881;46940;46948.78396280706;47219.76390118165;7357.117145942521;7404.370628496638;7406.925930740624;7497.587632680037;7902.407319451179;8257.917420825715;10767.838482422927;10984.176186785864;11250.549978000789;11613.5354585819;9495.14543691071;9614.855777163488;9667.613295468103;9887.060729230712;10061.798764024825;9561.330706850455;9775.560099795384;9790.26573007013;9904.25718071133;10095.091441770275;9416.529173541432;9656.75858103553;9685.757856053655;9782.41305521671;10171.593136274467;7590.316871481593;7620.504667196615;7628.885566716614;7729.598976450344;7867.13461519221;8507.234348908629;9635.13283804461;9726.659566915407;9861.408315501092;10006.149477294512 21:55:42 INFO - PROCESS | 8145 | |3;mootools.html;1223.162133938253;1312.25201635068;1355.5187908292555;1386.6048176269758;1615.1116885712854;6534.117894084297;7053.294670532944;7395.1125864896285;7397.334239918407;7837;7378.114626244858;7440.888386674191;7443.506425347501;7446.143693475252;7448.888266676005;2125.0437303213575;2143.882086485243;2144.9463763405884;2148.226638410179;2151.3115802942984;2066.4214020074405;2099.748030236374;2103.29539604232;2103.453102193433;2107.441527995075;2112.7781582933803;2125.9893700531475;2139.935801925945;2141.2826703054498;2144.3245377706053;2089.968650470244;2094.1623350659706;2096.423483542023;2099.170827523135;2099.842511811605;1998.3405476192822;2076.8234700050516;2082.239982406426;2082.8958552072336;2086.2698055680544;6861.828454288683;7152.785416437515;7592.620368981528;7606.163322034572;7702.730404435818;4191.832326706928;4301.913961720748;4312.892177695583;4330.783460826978;4332.891677708051;2699.35215548269;2752.8898844046216;2815.47913635978;2823.8588070596593;2829.1512546236045;893.9776505587347;904.5522466379118;910.5310764956052;914.4833169259347;927.1331305229564;9190.126937940951;9206.079392060807;9208.585613647401;9211.63153473867;9224.723258302194;3533.611302756695;3560.181158333598;3601.657842504958;3680.245549662313;3711.758735682172;7564.886526702104;7565.470417070862;7575.280348366897;7576.5832879191075;7584.08990921093;4222.092250166229;4231.174920890458;4243.024104455931;4247.978760106242;4250;3538.1862171700654;3679.748885378984;3853.7687738735767;3943.8225279862477;3945.6448919597374;3203.9199020024685;3230.144011836865;3360.781549199294;3379.1889946413175;3381.9492707609406;984.871966644346;992.3500107429645;1006.3760468509571;1010.8584798128268;1037.823569993103;793.2860425616991;810.6109067647562;814.230552128245;823.2261674026515;833.3957880536684;4862;4878.829240976549;4981.501849815062;5018.222175562793;5252.054630166606;383.6949625048093;385.13152840344844;386.9651731344193;388.37665546797547;396.33218027622974;3418.384690755638;3421.0934102462866;3434.4848272759286;3448.603410607762;3574.6067932527403;8902.42134261271;9245;9313.860292095624;9347.90652093484;9363.531823408803;9284.164425201629;9307.11582399671;9310.441373517475;9312.534373281309;9325.533723313807;6937.063496428019;7067.257937916547;7101.502894797314;7106.822329441702;7122.074130363019;4720.339152518582;4798.160321943716;4861.368022157097;4890.535399137077;5060.316857224375;8341.916580834113;8549.829003420022;8550.57247137653;8573.65705371803;8630;8489.193526614961;8635.956820215859;8688.739337819876;8689.522076285612;8702.347323950602;5533.972330138485;6294.842628934313;6351.745930162741;6352.745890164341;6363.268224154282;6681.732730690718;7094.042304288855;7169.175544812413;7314.524555903849;7316.670749816165;6144.754209831735;6276;6278.215223097113;6452;6493.415592596689;6384.170057892445;6395.6482393468805;6445.903311450238;6448.387403196689;6467.353264673683;5613.74738136793;5705;5706.172604972338;5713.628614140068;5716.342620598684;4194.412782210432;4213.957860421357;4324.481062272547;4330.935035974526;4408.6693497987135;4383.254846676136;4435.1351486459835;4499.21263778844;4507.233770258998;4572.35986961819 21:55:42 INFO - PROCESS | 8145 | |4;prototype.html;265.08809694650415;274.99626363772234;281.25888284370683;281.27852059467466;283.57039085785027;4567.703099298552;4735.621150307976;4770.833020844271;4801.303810947411;4806.591439727627;4557;4686.531346865312;4700.777797772586;4718.5281471852795;4728.40894888139;3483.3904066788336;3717.293714194308;3717.6282371762877;3757.380032294668;3762.2099359134613;3602.783832970017;3611.259691763182;3613.9277214455697;3620.2216523447455;3625.6736893679563;3507.912302192453;3691.53855768029;3693.279810436966;3710.239400922804;3712;3671.57776855661;3674.761140525857;3677.4851520787247;3706.258748250361;3711.109333759905;3048.6646468888403;3140.654528001941;3243.4486137356707;3250.284937313811;3255.20247539352;4617.746023968681;4619.228462922253;4639.816846704102;4647.256438969748;4663.463701674317;4154.210699967027;4157.584241575849;4160.2111092230325;4160.54234034256;4171.791410429466;4737.507685079189;4883.169861123618;4913.484084171147;4938.617187187593;5016.673916195472;3410.181556426465;3411.385950528904;3419.4186988212064;3456.187795867969;3458.291050334675;5252.242572649351;5266.683998960037;5287.995280896617;5299.205119232146;5308.893822123575;3334.5164951081956;3471.9479207811396;3530.5763308403157;3538.663826936437;3539.150603855108;3504;3505.1412403961194;3509.824508774551;3517.9472307915403;3534.0281422608473;4088.2845502037026;4090.365993271048;4090.4682391288943;4096;4117.394216255662;4978.4025916890205;4981.227909674007;4981.875453113628;4999.275105109811;5003.49965003504;1124.1849658997326;1148.3970915269383;1188.8811118888043;1221.5052903574067;1225.3995542184266;820.819419727659;833.9416240863081;837.7779888329597;841.7264389073454;843.0684094075958;4412.382266482695;4431.689781715249;4436.733795972252;4439.22313595126;4447.444069491314;5123.923141152885;5150.227465880073;5162.303089082926;5166.276721259027;5180.378354597472;4291.527931927485;4449.820797488668;4523;4544.2047641662575;4566.680332376702;2753.2428582140074;2773.6394268744934;2781.1644314752166;2782.735640114186;2784.7354501322343;4911.631627627942;4915.3855768029;4924.507549245119;4924.704517728947;4926.802927882916;5119.48805119485;5288.021715982555;5293.470652934676;5296.549793267538;5330.173823057432;4856.805727770849;4858.368412106403;4865.270209468537;4869.561739443467;4871.8294859679745;5001.599872010303;5159.613029022763;5164.302819119371;5182.663126896739;5186.325777648882;4983.875403114951;5002.998201079324;5042.873928151826;5046.293518907282;5048.141815891381;4830.830920917751;4832.685875418087;4852.660313778002;4857.668319206871;4862.294967229803;3571.928561428705;3583.569971603424;3585.8744943926836;3597.352476554245;3599.262151259038;5032.874178145576;5082.136036873814;5131;5162.50287416645;5167.767450464663;4969.776360063878;4978.975105124451;4983.27742477346;4998.925016124688;5007.298978143136;4989.575886049582;4998.725070121178;5012.9723406700805;5014.194889839582;5035.697858128524;4712.363830882787;4715.905681886412;4838.564529192389;4916.655834091579;4940.665051090427;4828.613710903049;4961.875953101201;4993.675411098267;5001.474845141353;5002.224655178453;4906.509349065065;4922.3600931880055;4931.654784165074;4959.280904268789;4963.875903102306 21:55:42 INFO - PROCESS | 8145 | |5;yui.html;633.4172561243655;669.9799006029817;693.7918624412675;733.5855241788389;742.1539445032662;12141.635750927475;13244.072914895962;13265.40305686244;13278.933605331971;13280;13317.134386264886;13368.131071480348;13382.263975481344;13398.330083495835;13404;595.8361450601076;610.3194937644539;726.7020521586151;734.1410549656888;755.327758295115;755.12405609493;766.8696321625309;767.5931756169239;767.7121079595152;767.8195624028377;807.5356669914822;808.1110778144053;808.1716240853114;808.9231523005305;809.2635701511625;631.1479502671402;649.6978904809287;784.254957790096;798.6206551887835;799.3085980626745;586.5805948746666;587.5211702462523;587.5270407322104;587.8412828536314;587.8618524646747;12998.285094319808;13113.344332783323;13118.803217951738;13125.934370328183;13137;12411.875881241162;12525.874741252654;12813.551525696648;13065.934670326682;13487.932560337234;11612.36132012739;11699.298042117414;11811.527538898434;11871.0503159747;12189.51241950321;4085.22380747657;4089.5501494835544;4144.109016561454;4150.875473735793;4288.0351920817875;59000.70499647517;59303.70348148232;60351;60782.78434431331;61785.38214617841;10243.9487802562;10517.84223236652;10527.94736026315;10591.682249532527;10965.671029869116;16800.495985120466;17504.737428938577;19373.4187974361;19609.31367402134;19655.901720491307;6904.240533541307;7049.89425158623;7112.751053713096;7130.180029296594;7266.781996540112;3650.2881938021833;3733.9813300933865;3794.6015668354976;3794.658480736747;3834.0606551395085;2909.170886297395;3000.354923691417;3015.276333679945;3019.698030196963;3020.516717325261;492.26898056386955;494.36967865970456;502.74360076360585;503.4889587069128;504.0901173382081;480.71877951398824;487.87301333918055;518.4944678938081;533.2081858440213;565.9405762394889;7242.13094428672;7448.73929412468;7508.361789247866;7629.088080110906;7794.181610930884;519.130456485393;521.4342438454244;525.3170877858769;551.6827824001215;560.9298837645294;3383.4079036168573;3448.810315432625;3635.654612811779;3812.3709587917683;3816.7137464689704;59115.70442147762;97384;98609;98663.50668246756;101672.49163754281;52349.2147617786;53469.99999999922;82330.17669823345;84073;86090;75492.62253688916;75805.24194758091;76329.61835190789;76573.23426765772;77828.61085694535;6834.521583489108;7027.824304392227;7230.566166030055;7377.594232317274;7394.075740532434;43683.56316436795;44332.33501497415;44338.77830610827;44667;45035.54964450314;62647;64772.352276478516;65174.34825651683;65340.67329663321;66793;9805.950970245389;9822.165115965223;9869.062439068564;9961.103500684972;10011.149052330342;9961.850572241567;9985.60057597688;10023.298369114093;10074.093331600192;10522.158227341948;10201.132903702972;10386;10417.16662667;10561.26071175041;10570.990725630072;9622.47076410804;9635.903640963781;9855.704328870146;9904.801903962025;9925.205983521446;9656.71029869105;9933.155681766842;9957.402555846673;10037.247206459399;10083.344582602107;8052.718154864551;8084.272415482635;8095.23095305945;8353.331733461187;8424.873626895724;8233.259006689426;8506.489610623383;8567.828643426972;8680.479171249744;9040.864387034067 21:55:42 INFO - PROCESS | 8145 | __end_tp_report 21:55:42 INFO - PROCESS | 8145 | __start_cc_report 21:55:42 INFO - PROCESS | 8145 | _x_x_mozilla_cycle_collect,1110 21:55:42 INFO - PROCESS | 8145 | __end_cc_report 21:55:42 INFO - PROCESS | 8145 | __startTimestamp1475902542376__endTimestamp 21:55:42 INFO - PROCESS | 8145 | 21:55:42 INFO - PROCESS | 8145 | ------- Summary: start ------- 21:55:42 INFO - PROCESS | 8145 | Number of tests: 6 21:55:42 INFO - PROCESS | 8145 | 21:55:42 INFO - PROCESS | 8145 | [#0] dojo.html Cycles:165 Average:4548.97 Median:4707.11 stddev:591.18 (12.6%) stddev-sans-first:572.24 21:55:42 INFO - PROCESS | 8145 | Values: 2569.9 2582.3 2613.7 2624.1 2633.7 4514.5 4598.2 4618.9 4619.5 4632.2 4618.9 4647.5 4651.1 4663.8 4664.1 4246.5 4257.3 4260.0 4270.9 4295.5 4216.2 4317.9 4330.6 4331.7 4384.4 4284.9 4299.0 4299.7 4348.3 4351.7 137.6 4246.7 4253.6 4283.2 4294.5 4197.9 4219.8 4224.2 4227.5 4265.8 4656.1 4656.8 4661.4 4709.3 4720.1 4845.5 4888.4 4906.9 4987.0 4992.3 4963.0 4966.3 4987.3 4988.2 5051.3 4608.1 4645.2 4654.4 4657.0 4707.1 4908.9 4946.1 5041.8 5083.0 5133.1 4847.8 4887.0 4892.6 4932.4 4941.2 4967.8 4983.7 4983.9 4987.0 5042.4 4800.3 4856.8 4919.3 4930.3 4976.1 4799.3 4803.4 4860.3 4861.6 4863.1 4096.3 4107.2 4108.9 4155.0 4162.3 3604.9 3606.0 3626.1 3639.4 3672.5 4195.4 4218.3 4235.3 4273.1 4276.6 4948.8 4949.9 4953.6 4954.4 4981.5 4272.6 4277.9 4278.5 4322.5 4329.9 4284.3 4315.3 4316.7 4414.5 4440.2 4673.3 4747.3 4747.6 4748.1 4749.4 4967.3 4987.8 4992.4 4996.7 5058.7 4657.8 4673.8 4676.6 4681.8 4737.3 4724.9 4753.0 4876.0 4910.8 4925.0 4961.6 4997.1 5048.8 5049.9 5065.2 4862.9 4863.1 4866.8 4867.6 4929.4 4642.6 4738.8 4853.7 4871.5 4930.9 4662.0 4724.0 4732.7 4740.3 4768.4 4784.5 4791.9 4793.7 4801.5 4869.2 4576.9 4691.1 4700.4 4714.4 4777.7 21:55:42 INFO - PROCESS | 8145 | 21:55:42 INFO - PROCESS | 8145 | [#1] ext.html Cycles:180 Average:45396.40 Median:34744.74 stddev:81157.45 (233.6%) stddev-sans-first:81315.29 21:55:42 INFO - PROCESS | 8145 | Values: 556.4 565.2 570.4 576.7 578.9 26805.9 27779.0 30056.8 37116.3 38367.8 37976.4 38546.0 38717.8 38724.0 38793.6 7663.5 7763.9 7801.0 7822.8 7823.7 7159.3 7332.9 7606.7 9717.7 9968.7 9966.1 9997.9 10012.8 10030.1 10033.8 9954.7 10009.7 10012.6 10019.4 10028.5 6722.7 6917.2 6919.2 7087.3 9126.2 36193.6 36531.8 36546.8 36561.3 36568.6 2981.8 3019.2 3038.1 3123.7 3154.7 27321.0 27431.2 27581.2 27732.3 28071.3 3180.9 3302.3 3340.2 3343.6 3384.1 241893.0 243664.0 243684.0 243770.0 244672.0 44105.0 45382.1 49999.5 51761.5 52140.0 55644.0 56151.7 56153.2 56177.0 56237.4 13545.9 13629.7 13671.2 13684.2 13685.5 9210.5 9674.0 9702.0 9705.0 9717.9 14666.9 16970.2 17277.2 17633.6 18152.0 6506.8 6683.3 6716.3 6786.4 6889.0 786.6 857.5 917.6 949.1 1007.5 26356.5 26715.5 27175.2 27178.6 27210.0 957.2 969.2 988.7 992.1 1016.9 13366.5 14496.4 14534.4 14643.2 14740.6 368668.0 372636.0 372926.0 373153.0 373290.0 47324.0 47792.0 47823.8 47825.3 47870.3 1063.2 1082.4 1140.6 1175.4 1175.6 26167.9 27896.2 28908.9 29204.6 29218.4 39831.6 40318.0 40347.8 40353.6 40374.2 294645.0 296567.0 296864.0 297294.0 297815.0 23978.3 25064.2 25071.5 25927.9 26038.3 39132.4 39139.4 39583.4 39773.8 40559.0 34110.8 34178.7 34292.1 34398.0 34890.0 34097.0 34339.3 34434.3 34748.8 34822.7 34465.8 34740.7 34998.3 35220.8 35585.3 29034.1 30656.5 31718.5 31790.2 32163.7 24064.9 24780.3 24860.4 25233.6 25268.1 21:55:42 INFO - PROCESS | 8145 | 21:55:42 INFO - PROCESS | 8145 | [#2] jquery.html Cycles:180 Average:22111.78 Median:5924.25 stddev:55521.02 (937.2%) stddev-sans-first:55652.70 21:55:42 INFO - PROCESS | 8145 | Values: 336.8 343.8 345.7 352.3 366.7 12155.3 12626.3 15678.3 16056.6 16212.5 15874.4 16473.0 16598.4 16674.6 16831.0 4685.6 4972.7 5228.0 5228.9 5230.1 5941.6 6068.4 6098.0 6101.8 6131.8 5784.8 5950.4 6019.8 6031.2 6032.8 5896.8 5923.7 5924.8 5928.6 5935.2 4533.6 4779.9 4797.8 4857.3 5145.6 11224.5 11361.0 11403.8 11424.4 17779.7 1863.9 1895.3 1930.6 2019.8 2369.1 8618.1 9036.3 9271.2 9431.1 9569.8 1703.3 1726.8 1754.0 1758.7 1786.4 64259.7 70227.3 70473.3 70612.6 71470.6 9625.2 9782.4 9836.0 9896.3 9923.0 13808.2 13850.9 13881.6 13882.2 13888.1 6780.3 6970.7 7013.3 7075.3 7116.6 6461.8 6551.1 6641.1 6688.0 6763.2 4182.4 4221.2 4247.6 4337.3 4355.3 1741.8 1767.2 1768.2 1770.4 1785.7 789.9 832.3 837.3 880.4 961.1 16032.9 16164.2 16280.5 16417.3 17410.9 794.0 831.5 832.1 844.5 872.9 8882.6 9322.6 9462.6 9543.7 9690.3 331443.0 332097.0 335424.0 336092.0 336391.0 71499.0 72587.8 73619.6 75128.6 76281.6 860.7 922.4 935.6 945.3 949.3 14349.6 15244.0 15725.1 15886.9 16036.8 34639.8 34941.0 35067.3 35331.5 35387.6 45728.0 46892.5 46940.0 46948.8 47219.8 7357.1 7404.4 7406.9 7497.6 7902.4 8257.9 10767.8 10984.2 11250.5 11613.5 9495.1 9614.9 9667.6 9887.1 10061.8 9561.3 9775.6 9790.3 9904.3 10095.1 9416.5 9656.8 9685.8 9782.4 10171.6 7590.3 7620.5 7628.9 7729.6 7867.1 8507.2 9635.1 9726.7 9861.4 10006.1 21:55:42 INFO - PROCESS | 8145 | 21:55:42 INFO - PROCESS | 8145 | [#3] mootools.html Cycles:180 Average:4792.48 Median:5039.27 stddev:2686.95 (53.3%) stddev-sans-first:2681.10 21:55:42 INFO - PROCESS | 8145 | Values: 1223.2 1312.3 1355.5 1386.6 1615.1 6534.1 7053.3 7395.1 7397.3 7837.0 7378.1 7440.9 7443.5 7446.1 7448.9 2125.0 2143.9 2144.9 2148.2 2151.3 2066.4 2099.7 2103.3 2103.5 2107.4 2112.8 2126.0 2139.9 2141.3 2144.3 2090.0 2094.2 2096.4 2099.2 2099.8 1998.3 2076.8 2082.2 2082.9 2086.3 6861.8 7152.8 7592.6 7606.2 7702.7 4191.8 4301.9 4312.9 4330.8 4332.9 2699.4 2752.9 2815.5 2823.9 2829.2 894.0 904.6 910.5 914.5 927.1 9190.1 9206.1 9208.6 9211.6 9224.7 3533.6 3560.2 3601.7 3680.2 3711.8 7564.9 7565.5 7575.3 7576.6 7584.1 4222.1 4231.2 4243.0 4248.0 4250.0 3538.2 3679.7 3853.8 3943.8 3945.6 3203.9 3230.1 3360.8 3379.2 3381.9 984.9 992.4 1006.4 1010.9 1037.8 793.3 810.6 814.2 823.2 833.4 4862.0 4878.8 4981.5 5018.2 5252.1 383.7 385.1 387.0 388.4 396.3 3418.4 3421.1 3434.5 3448.6 3574.6 8902.4 9245.0 9313.9 9347.9 9363.5 9284.2 9307.1 9310.4 9312.5 9325.5 6937.1 7067.3 7101.5 7106.8 7122.1 4720.3 4798.2 4861.4 4890.5 5060.3 8341.9 8549.8 8550.6 8573.7 8630.0 8489.2 8636.0 8688.7 8689.5 8702.3 5534.0 6294.8 6351.7 6352.7 6363.3 6681.7 7094.0 7169.2 7314.5 7316.7 6144.8 6276.0 6278.2 6452.0 6493.4 6384.2 6395.6 6445.9 6448.4 6467.4 5613.7 5705.0 5706.2 5713.6 5716.3 4194.4 4214.0 4324.5 4330.9 4408.7 4383.3 4435.1 4499.2 4507.2 4572.4 21:55:42 INFO - PROCESS | 8145 | 21:55:42 INFO - PROCESS | 8145 | [#4] prototype.html Cycles:180 Average:4121.24 Median:4717.22 stddev:1223.55 (25.9%) stddev-sans-first:1192.26 21:55:42 INFO - PROCESS | 8145 | Values: 265.1 275.0 281.3 281.3 283.6 4567.7 4735.6 4770.8 4801.3 4806.6 4557.0 4686.5 4700.8 4718.5 4728.4 3483.4 3717.3 3717.6 3757.4 3762.2 3602.8 3611.3 3613.9 3620.2 3625.7 3507.9 3691.5 3693.3 3710.2 3712.0 3671.6 3674.8 3677.5 3706.3 3711.1 3048.7 3140.7 3243.4 3250.3 3255.2 4617.7 4619.2 4639.8 4647.3 4663.5 4154.2 4157.6 4160.2 4160.5 4171.8 4737.5 4883.2 4913.5 4938.6 5016.7 3410.2 3411.4 3419.4 3456.2 3458.3 5252.2 5266.7 5288.0 5299.2 5308.9 3334.5 3471.9 3530.6 3538.7 3539.2 3504.0 3505.1 3509.8 3517.9 3534.0 4088.3 4090.4 4090.5 4096.0 4117.4 4978.4 4981.2 4981.9 4999.3 5003.5 1124.2 1148.4 1188.9 1221.5 1225.4 820.8 833.9 837.8 841.7 843.1 4412.4 4431.7 4436.7 4439.2 4447.4 5123.9 5150.2 5162.3 5166.3 5180.4 4291.5 4449.8 4523.0 4544.2 4566.7 2753.2 2773.6 2781.2 2782.7 2784.7 4911.6 4915.4 4924.5 4924.7 4926.8 5119.5 5288.0 5293.5 5296.5 5330.2 4856.8 4858.4 4865.3 4869.6 4871.8 5001.6 5159.6 5164.3 5182.7 5186.3 4983.9 5003.0 5042.9 5046.3 5048.1 4830.8 4832.7 4852.7 4857.7 4862.3 3571.9 3583.6 3585.9 3597.4 3599.3 5032.9 5082.1 5131.0 5162.5 5167.8 4969.8 4979.0 4983.3 4998.9 5007.3 4989.6 4998.7 5013.0 5014.2 5035.7 4712.4 4715.9 4838.6 4916.7 4940.7 4828.6 4961.9 4993.7 5001.5 5002.2 4906.5 4922.4 4931.7 4959.3 4963.9 21:55:42 INFO - PROCESS | 8145 | 21:55:42 INFO - PROCESS | 8145 | [#5] yui.html Cycles:180 Average:16978.75 Median:587.52 stddev:24423.78 (4157.1%) stddev-sans-first:24461.46 21:55:42 INFO - PROCESS | 8145 | Values: 633.4 670.0 693.8 733.6 742.2 12141.6 13244.1 13265.4 13278.9 13280.0 13317.1 13368.1 13382.3 13398.3 13404.0 595.8 610.3 726.7 734.1 755.3 755.1 766.9 767.6 767.7 767.8 807.5 808.1 808.2 808.9 809.3 631.1 649.7 784.3 798.6 799.3 586.6 587.5 587.5 587.8 587.9 12998.3 13113.3 13118.8 13125.9 13137.0 12411.9 12525.9 12813.6 13065.9 13487.9 11612.4 11699.3 11811.5 11871.1 12189.5 4085.2 4089.6 4144.1 4150.9 4288.0 59000.7 59303.7 60351.0 60782.8 61785.4 10243.9 10517.8 10527.9 10591.7 10965.7 16800.5 17504.7 19373.4 19609.3 19655.9 6904.2 7049.9 7112.8 7130.2 7266.8 3650.3 3734.0 3794.6 3794.7 3834.1 2909.2 3000.4 3015.3 3019.7 3020.5 492.3 494.4 502.7 503.5 504.1 480.7 487.9 518.5 533.2 565.9 7242.1 7448.7 7508.4 7629.1 7794.2 519.1 521.4 525.3 551.7 560.9 3383.4 3448.8 3635.7 3812.4 3816.7 59115.7 97384.0 98609.0 98663.5 101672.5 52349.2 53470.0 82330.2 84073.0 86090.0 75492.6 75805.2 76329.6 76573.2 77828.6 6834.5 7027.8 7230.6 7377.6 7394.1 43683.6 44332.3 44338.8 44667.0 45035.5 62647.0 64772.4 65174.3 65340.7 66793.0 9806.0 9822.2 9869.1 9961.1 10011.1 9961.9 9985.6 10023.3 10074.1 10522.2 10201.1 10386.0 10417.2 10561.3 10571.0 9622.5 9635.9 9855.7 9904.8 9925.2 9656.7 9933.2 9957.4 10037.2 10083.3 8052.7 8084.3 8095.2 8353.3 8424.9 8233.3 8506.5 8567.8 8680.5 9040.9 21:55:42 INFO - PROCESS | 8145 | -------- Summary: end -------- 21:55:42 INFO - PROCESS | 8145 | 21:55:43 INFO - TEST-INFO | 8145: exit 0 21:55:43 INFO - TEST-OK | dromaeo_css | took 1120410ms 21:55:43 INFO - TEST-START | kraken 21:55:43 INFO - operating with platform_type : linux_ 21:55:43 INFO - Initialising browser for kraken test... 21:55:43 INFO - TEST-INFO | started process 8446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPxYe_j/profile http://localhost:60779/getInfo.html) 21:55:47 INFO - PROCESS | 8446 | __metrics Screen width/height:1600/1200 21:55:47 INFO - PROCESS | 8446 | colorDepth:24 21:55:47 INFO - PROCESS | 8446 | Browser inner width/height: 1024/697 21:55:47 INFO - PROCESS | 8446 | __metrics 21:55:48 INFO - PROCESS | 8446 | 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" 21:55:48 INFO - PROCESS | 8446 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:55:48 INFO - PROCESS | 8446 | console.error: PushService: 21:55:48 INFO - PROCESS | 8446 | stateChangeProcessEnqueue: Error transitioning state 21:55:48 INFO - PROCESS | 8446 | UnknownError 21:55:49 INFO - TEST-INFO | 8446: exit 0 21:55:49 INFO - Browser initialized. 21:55:49 INFO - Running cycle 1/1 for kraken test... 21:55:49 INFO - TEST-INFO | started process 8529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPxYe_j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:56:01 INFO - PROCESS | 8529 | RSS: Main: 174440448 21:56:01 INFO - PROCESS | 8529 | 21:56:04 INFO - PROCESS | 8529 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60779/tests/kraken/driver.html?testName=audio-beat-detection) 21:56:05 INFO - PROCESS | 8529 | RSS: Main: 233459712 21:56:05 INFO - PROCESS | 8529 | 21:56:08 INFO - PROCESS | 8529 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60779/tests/kraken/driver.html?testName=audio-dft) 21:56:08 INFO - PROCESS | 8529 | RSS: Main: 218370048 21:56:08 INFO - PROCESS | 8529 | 21:56:12 INFO - PROCESS | 8529 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60779/tests/kraken/driver.html?testName=audio-fft) 21:56:12 INFO - PROCESS | 8529 | RSS: Main: 300871680 21:56:12 INFO - PROCESS | 8529 | 21:56:14 INFO - PROCESS | 8529 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60779/tests/kraken/driver.html?testName=audio-oscillator) 21:56:15 INFO - PROCESS | 8529 | RSS: Main: 211185664 21:56:15 INFO - PROCESS | 8529 | 21:56:17 INFO - PROCESS | 8529 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60779/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:56:18 INFO - PROCESS | 8529 | RSS: Main: 213868544 21:56:18 INFO - PROCESS | 8529 | 21:56:21 INFO - PROCESS | 8529 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60779/tests/kraken/driver.html?testName=imaging-darkroom) 21:56:22 INFO - PROCESS | 8529 | RSS: Main: 250114048 21:56:22 INFO - PROCESS | 8529 | 21:56:25 INFO - PROCESS | 8529 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60779/tests/kraken/driver.html?testName=imaging-desaturate) 21:56:26 INFO - PROCESS | 8529 | RSS: Main: 243642368 21:56:26 INFO - PROCESS | 8529 | 21:56:29 INFO - PROCESS | 8529 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60779/tests/kraken/driver.html?testName=json-parse-financial) 21:56:29 INFO - PROCESS | 8529 | RSS: Main: 246976512 21:56:29 INFO - PROCESS | 8529 | 21:56:31 INFO - PROCESS | 8529 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60779/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:56:31 INFO - PROCESS | 8529 | RSS: Main: 209833984 21:56:31 INFO - PROCESS | 8529 | 21:56:33 INFO - PROCESS | 8529 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60779/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:56:34 INFO - PROCESS | 8529 | RSS: Main: 217686016 21:56:34 INFO - PROCESS | 8529 | 21:56:36 INFO - PROCESS | 8529 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60779/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:56:37 INFO - PROCESS | 8529 | RSS: Main: 226103296 21:56:37 INFO - PROCESS | 8529 | 21:56:40 INFO - PROCESS | 8529 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:56:40 INFO - PROCESS | 8529 | RSS: Main: 235614208 21:56:40 INFO - PROCESS | 8529 | 21:56:43 INFO - PROCESS | 8529 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:56:44 INFO - PROCESS | 8529 | RSS: Main: 231731200 21:56:44 INFO - PROCESS | 8529 | 21:56:46 INFO - PROCESS | 8529 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60779/tests/kraken/driver.html?testName=ai-astar) 21:56:46 INFO - PROCESS | 8529 | RSS: Main: 283303936 21:56:46 INFO - PROCESS | 8529 | 21:56:46 INFO - PROCESS | 8529 | __start_tp_report 21:56:46 INFO - PROCESS | 8529 | _x_x_mozilla_page_load 21:56:46 INFO - PROCESS | 8529 | _x_x_mozilla_page_load_details 21:56:46 INFO - PROCESS | 8529 | |i|pagename|runs| 21:56:46 INFO - PROCESS | 8529 | |0;ai-astar;112;114;114;115;114;116;115;115;115;114 21:56:46 INFO - PROCESS | 8529 | |1;audio-beat-detection;154;133;128;164;131;129;128;128;174;129 21:56:46 INFO - PROCESS | 8529 | |2;audio-dft;162;162;163;162;163;163;162;164;161;162 21:56:46 INFO - PROCESS | 8529 | |3;audio-fft;76;76;77;112;77;76;76;77;108;77 21:56:46 INFO - PROCESS | 8529 | |4;audio-oscillator;83;82;130;84;83;84;108;83;84;127 21:56:46 INFO - PROCESS | 8529 | |5;imaging-gaussian-blur;118;117;117;116;116;117;117;116;117;117 21:56:46 INFO - PROCESS | 8529 | |6;imaging-darkroom;147;147;147;147;147;146;147;147;147;146 21:56:46 INFO - PROCESS | 8529 | |7;imaging-desaturate;95;94;95;94;94;95;95;95;95;94 21:56:46 INFO - PROCESS | 8529 | |8;json-parse-financial;64;64;65;64;64;64;65;66;65;64 21:56:46 INFO - PROCESS | 8529 | |9;json-stringify-tinderbox;66;66;65;67;68;66;66;67;66;67 21:56:46 INFO - PROCESS | 8529 | |10;stanford-crypto-aes;83;82;82;82;83;83;82;82;84;81 21:56:46 INFO - PROCESS | 8529 | |11;stanford-crypto-ccm;148;139;138;139;142;142;155;140;173;136 21:56:46 INFO - PROCESS | 8529 | |12;stanford-crypto-pbkdf2;180;176;178;184;181;175;176;175;178;181 21:56:46 INFO - PROCESS | 8529 | |13;stanford-crypto-sha256-iterative;74;71;69;72;70;68;72;69;72;70 21:56:46 INFO - PROCESS | 8529 | __end_tp_report 21:56:46 INFO - PROCESS | 8529 | __start_cc_report 21:56:46 INFO - PROCESS | 8529 | _x_x_mozilla_cycle_collect,1923 21:56:46 INFO - PROCESS | 8529 | __end_cc_report 21:56:46 INFO - PROCESS | 8529 | __startTimestamp1475902606572__endTimestamp 21:56:46 INFO - PROCESS | 8529 | 21:56:46 INFO - PROCESS | 8529 | ------- Summary: start ------- 21:56:46 INFO - PROCESS | 8529 | Number of tests: 14 21:56:46 INFO - PROCESS | 8529 | 21:56:46 INFO - PROCESS | 8529 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:1.07 (0.9%) stddev-sans-first:0.71 21:56:46 INFO - PROCESS | 8529 | Values: 112.0 114.0 114.0 115.0 114.0 116.0 115.0 115.0 115.0 114.0 21:56:46 INFO - PROCESS | 8529 | 21:56:46 INFO - PROCESS | 8529 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:132.00 stddev:17.42 (13.2%) stddev-sans-first:17.70 21:56:46 INFO - PROCESS | 8529 | Values: 154.0 133.0 128.0 164.0 131.0 129.0 128.0 128.0 174.0 129.0 21:56:46 INFO - PROCESS | 8529 | 21:56:46 INFO - PROCESS | 8529 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 21:56:46 INFO - PROCESS | 8529 | Values: 162.0 162.0 163.0 162.0 163.0 163.0 162.0 164.0 161.0 162.0 21:56:46 INFO - PROCESS | 8529 | 21:56:46 INFO - PROCESS | 8529 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.50 stddev:14.16 (18.5%) stddev-sans-first:14.78 21:56:46 INFO - PROCESS | 8529 | Values: 76.0 76.0 77.0 112.0 77.0 76.0 76.0 77.0 108.0 77.0 21:56:46 INFO - PROCESS | 8529 | 21:56:46 INFO - PROCESS | 8529 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:83.00 stddev:19.38 (23.4%) stddev-sans-first:20.08 21:56:46 INFO - PROCESS | 8529 | Values: 83.0 82.0 130.0 84.0 83.0 84.0 108.0 83.0 84.0 127.0 21:56:46 INFO - PROCESS | 8529 | 21:56:46 INFO - PROCESS | 8529 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 21:56:46 INFO - PROCESS | 8529 | Values: 118.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 21:56:46 INFO - PROCESS | 8529 | 21:56:46 INFO - PROCESS | 8529 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 21:56:46 INFO - PROCESS | 8529 | Values: 147.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 21:56:46 INFO - PROCESS | 8529 | 21:56:46 INFO - PROCESS | 8529 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 21:56:46 INFO - PROCESS | 8529 | Values: 95.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 21:56:46 INFO - PROCESS | 8529 | 21:56:46 INFO - PROCESS | 8529 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 21:56:46 INFO - PROCESS | 8529 | Values: 64.0 64.0 65.0 64.0 64.0 64.0 65.0 66.0 65.0 64.0 21:56:46 INFO - PROCESS | 8529 | 21:56:46 INFO - PROCESS | 8529 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 21:56:46 INFO - PROCESS | 8529 | Values: 66.0 66.0 65.0 67.0 68.0 66.0 66.0 67.0 66.0 67.0 21:56:46 INFO - PROCESS | 8529 | 21:56:46 INFO - PROCESS | 8529 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:0.84 (1.0%) stddev-sans-first:0.87 21:56:46 INFO - PROCESS | 8529 | Values: 83.0 82.0 82.0 82.0 83.0 83.0 82.0 82.0 84.0 81.0 21:56:46 INFO - PROCESS | 8529 | 21:56:46 INFO - PROCESS | 8529 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:142.00 stddev:11.24 (7.9%) stddev-sans-first:11.88 21:56:46 INFO - PROCESS | 8529 | Values: 148.0 139.0 138.0 139.0 142.0 142.0 155.0 140.0 173.0 136.0 21:56:46 INFO - PROCESS | 8529 | 21:56:46 INFO - PROCESS | 8529 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.40 Median:179.00 stddev:3.03 (1.7%) stddev-sans-first:3.15 21:56:46 INFO - PROCESS | 8529 | Values: 180.0 176.0 178.0 184.0 181.0 175.0 176.0 175.0 178.0 181.0 21:56:46 INFO - PROCESS | 8529 | 21:56:46 INFO - PROCESS | 8529 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.50 stddev:1.83 (2.6%) stddev-sans-first:1.50 21:56:46 INFO - PROCESS | 8529 | Values: 74.0 71.0 69.0 72.0 70.0 68.0 72.0 69.0 72.0 70.0 21:56:46 INFO - PROCESS | 8529 | -------- Summary: end -------- 21:56:46 INFO - PROCESS | 8529 | 21:56:47 INFO - TEST-INFO | 8529: exit 0 21:56:47 INFO - TEST-OK | kraken | took 64570ms 21:56:47 INFO - SUITE-END | took 1184s 21:56:48 INFO - Completed test suite (00:19:45) 21:56:48 INFO - javascript benchmark 21:56:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2569.858657773823, 2582.28987028567, 2613.7386261373863, 2624.068455698227, 2633.7102918678943, 4514.52597477265, 4598.195315819727, 4618.907621847566, 4619.51495093015, 4632.2356811126165, 4618.861434156981, 4647.465541462733, 4651.116287905295, 4663.7668116594205, 4664.090502352043, 4246.490421149459, 4257.340112282585, 4260.02019535507, 4270.935935960963, 4295.463067116611, 4216.177845320164, 4317.913641727164, 4330.631896288819, 4331.6534677225745, 4384.430024096879, 4284.914301713964, 4298.978505107486, 4299.699021068526, 4348.260795664729, 4351.738895666254, 137.5812784387316, 4246.660267178619, 4253.617174454283, 4283.164782867342, 4294.463192100988, 4197.853075142386, 4219.810108545123, 4224.176285624305, 4227.534971153202, 4265.808038638269, 4656.068786242731, 4656.790444430008, 4661.394018777572, 4709.293605959099, 4720.079584481027, 4845.53967373099, 4888.364512613373, 4906.877328066791, 4986.950130498722, 4992.326035985132, 4962.975185124087, 4966.255061740768, 4987.326710894019, 4988.226824842155, 5051.318072060261, 4608.055348653518, 4645.210314246586, 4654.394928659252, 4657.04530571232, 4707.105649926503, 4908.852734417973, 4946.1344264753525, 5041.823536176216, 5083.0, 5133.076046311699, 4847.781849816767, 4887.022595480918, 4892.608591312686, 4932.432770231398, 4941.209406494943, 4967.751612419364, 4983.725895075806, 4983.875403114951, 4986.950130498722, 5042.42012168598, 4800.255960326155, 4856.805727770849, 4919.3358896549225, 4930.2851086592245, 4976.0794253063295, 4799.28010798383, 4803.423589169322, 4860.343853579792, 4861.586765124934, 4863.148948933923, 4096.262672718939, 4107.158032603309, 4108.8767336979345, 4154.979225103855, 4162.334026555736, 3604.9098772530897, 3605.963940360615, 3626.1478552540134, 3639.3813051781262, 3672.5225720656144, 4195.4336164618, 4218.261804184255, 4235.25882970479, 4273.059926816096, 4276.615104640535, 4948.802047918115, 4949.925751113737, 4953.554180123806, 4954.405471343462, 4981.501849814989, 4272.636825869774, 4277.893052673708, 4278.4865816102265, 4322.502912165141, 4329.891752706145, 4284.250256205151, 4315.309550471972, 4316.676249281317, 4414.514403415622, 4440.156370289635, 4673.322368256584, 4747.287906813867, 4747.572718455355, 4748.09786140646, 4749.35883655702, 4967.254911763264, 4987.80048798044, 4992.350994370709, 4996.725180115129, 5058.747062646779, 4657.836975705834, 4673.836415725569, 4676.55572720591, 4681.765911704333, 4737.28940658904, 4724.905501890012, 4752.976235118802, 4875.951240487691, 4910.779014944407, 4925.014997000686, 4961.5534601886, 4997.100521906092, 5048.798048078036, 5049.924251136163, 5065.189569668835, 4862.92705609409, 4863.10032643962, 4866.756662166807, 4867.561919427269, 4929.359183306147, 4642.582167604932, 4738.786754596121, 4853.6602437829015, 4871.472137786371, 4930.926036109389, 4662.0, 4723.976380118077, 4732.6687131900435, 4740.288956656529, 4768.356271903249, 4784.545468180518, 4791.928121078117, 4793.664443488922, 4801.4958429364415, 4869.1722407190155, 4576.8626941191815, 4691.085238378483, 4700.435947686299, 4714.38712967312, 4777.737224452689], "value": 4513.899284552852, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.4463358957837, 565.2256408720054, 570.3526497425421, 576.711644177911, 578.9218455508507, 26805.865970670144, 27779.0, 30056.849715751447, 37116.257674846485, 38367.80816095923, 37976.43035354472, 38546.03634909121, 38717.806410967976, 38724.0, 38793.61206387935, 7663.501872378305, 7763.922360776404, 7800.960995195044, 7822.843543129134, 7823.687052517921, 7159.284071592851, 7332.890006649878, 7606.657700403495, 9717.708468745914, 9968.700938971842, 9966.053224943618, 9997.850032249522, 10012.849807252896, 10030.097291243786, 10033.799324013515, 9954.65158719445, 10009.69970900874, 10012.59949602015, 10019.398836069859, 10028.498575071253, 6722.663866806689, 6917.169939607279, 6919.204291506491, 7087.291270872923, 9126.224270936978, 36193.63806361929, 36531.81734091339, 36546.81726591376, 36561.26877462436, 36568.63431365679, 2981.835999020053, 3019.215004098928, 3038.1189455058006, 3123.687631236881, 3154.68453154685, 27321.0, 27431.17706468809, 27581.172564823086, 27732.342007434945, 28071.29821754452, 3180.872765089394, 3302.306515631696, 3340.2150494633743, 3343.64582344151, 3384.069380920242, 241893.0, 243664.0, 243684.0, 243770.0, 244672.0, 44105.0, 45382.09235815265, 49999.50000500021, 51761.48238517567, 52140.0, 55644.0, 56151.71924140353, 56153.1577026345, 56177.0, 56237.437625624036, 13545.932270338586, 13629.727405452033, 13671.248081355421, 13684.247366394944, 13685.452581896612, 9210.493422861808, 9674.03259674027, 9702.0, 9705.0, 9717.854232186522, 14666.926665366818, 16970.236339364757, 17277.222524986406, 17633.559161021076, 18152.0, 6506.837329066811, 6683.2648408675, 6716.261211266757, 6786.353322204344, 6888.965555172192, 786.6106277392727, 857.5283594023387, 917.6237742525666, 949.0888746803008, 1007.536533194724, 26356.472870542864, 26715.465690686076, 27175.1847444577, 27178.5923211152, 27210.0, 957.1911734584265, 969.1665167955553, 988.663854289545, 992.1021475564626, 1016.903394177552, 13366.465341386236, 14496.420143194155, 14534.418623254951, 14643.194624295553, 14740.557783266519, 368668.0, 372636.0, 372926.0, 373153.0, 373290.0, 47324.0, 47792.0, 47823.84792684337, 47825.28262076002, 47870.28194577084, 1063.1760385701143, 1082.4479515447022, 1140.5779861451317, 1175.3535555444641, 1175.5767923547517, 26167.86916065484, 27896.163115106578, 28908.855455722587, 29204.56193157147, 29218.415631687672, 39831.601683982786, 40318.0, 40347.79826100851, 40353.596464034985, 40374.19251614893, 294645.0, 296567.0, 296864.0, 297294.0, 297815.0, 23978.28065158048, 25064.248072557853, 25071.498570028132, 25927.870360648078, 26038.34904127412, 39132.41301380539, 39139.41290880696, 39583.40624890571, 39773.80113099416, 40559.0, 34110.829445852614, 34178.65821341755, 34292.14269643279, 34398.0, 34890.0, 34097.0, 34339.31321373609, 34434.31131377409, 34748.82625586957, 34822.651773482954, 34465.82767086149, 34740.652593474755, 34998.30003399969, 35220.823895880356, 35585.28829423449, 29034.12897613075, 30656.481833270227, 31718.524222136224, 31790.205244869063, 32163.67836321607, 24064.87967560151, 24780.25659230226, 24860.39524269007, 25233.621495677213, 25268.115615953353], "value": 17120.24401104499, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.7709957229083, 343.75593328736613, 345.72342126298963, 352.3217805723982, 366.7139631087751, 12155.331456769874, 12626.305553194583, 15678.294476748559, 16056.59858503535, 16212.513624591282, 15874.444394446196, 16473.0, 16598.419055333066, 16674.58313542162, 16831.044704494463, 4685.601723853477, 4972.70163790172, 5227.973860130713, 5228.8692782680355, 5230.084735171349, 5941.554383421239, 6068.362821903681, 6097.969510152443, 6101.755929762804, 6131.785387511438, 5784.768609255625, 5950.404959504058, 6019.759209631609, 6031.185789918349, 6032.819015429523, 5896.823095307148, 5923.703814809242, 5924.7926322578505, 5928.614640048405, 5935.228420305376, 4533.637309015304, 4779.904401911977, 4797.808087676489, 4857.34425852509, 5145.6398052136365, 11224.49489772954, 11361.0, 11403.771924561463, 11424.371659558721, 17779.73330400045, 1863.8974856382893, 1895.346105593568, 1930.6042261336393, 2019.7677267114177, 2369.07606033647, 8618.138186181395, 9036.32227582934, 9271.165595096474, 9431.104045115771, 9569.808603827954, 1703.3101593854508, 1726.7755191824983, 1753.9824601753946, 1758.6570618729354, 1786.3926265069938, 64259.67870160666, 70227.29772702258, 70473.29526704719, 70612.64693676551, 71470.64264678644, 9625.229981601455, 9782.403965303594, 9836.0, 9896.307258491981, 9923.00769923002, 13808.17150970945, 13850.861491385158, 13881.583552493441, 13882.236476993863, 13888.097273677178, 6780.32196780318, 6970.721171153198, 7013.333733295329, 7075.292470752884, 7116.608586527687, 6461.838454038687, 6551.0500977358015, 6641.1366522352755, 6688.0, 6763.222229443677, 4182.393552934807, 4221.197972385237, 4247.5540068293, 4337.327714204303, 4355.324924636623, 1741.8171092035407, 1767.1959258537336, 1768.2043080613776, 1770.3892157205744, 1785.6696760913203, 789.9052113746272, 832.3341326938546, 837.2673910328463, 880.4145243413186, 961.1157734883924, 16032.911607540003, 16164.191790410432, 16280.511584652479, 16417.343306267856, 17410.912945435193, 793.9761807145795, 831.4720152703077, 832.1137988042836, 844.472204871955, 872.9476231426135, 8882.555872206363, 9322.580483878242, 9462.57418416173, 9543.713688589354, 9690.273229507815, 331443.0, 332097.0, 335424.0, 336092.0, 336391.0, 71499.0, 72587.83003444661, 73619.63190184122, 75128.62435687897, 76281.61859190669, 860.6514361683653, 922.4096578189964, 935.5883411299006, 945.3193700535603, 949.3259785552335, 14349.641258968191, 15244.0, 15725.135117568643, 15886.920565397098, 16036.839631603534, 34639.826800865834, 34941.0, 35067.29865402729, 35331.470027949086, 35387.646123538434, 45727.99760041913, 46892.53107468881, 46940.0, 46948.78396280706, 47219.76390118165, 7357.117145942521, 7404.370628496638, 7406.925930740624, 7497.587632680037, 7902.407319451179, 8257.917420825715, 10767.838482422927, 10984.176186785864, 11250.549978000789, 11613.5354585819, 9495.14543691071, 9614.855777163488, 9667.613295468103, 9887.060729230712, 10061.798764024825, 9561.330706850455, 9775.560099795384, 9790.26573007013, 9904.25718071133, 10095.091441770275, 9416.529173541432, 9656.75858103553, 9685.757856053655, 9782.41305521671, 10171.593136274467, 7590.316871481593, 7620.504667196615, 7628.885566716614, 7729.598976450344, 7867.13461519221, 8507.234348908629, 9635.13283804461, 9726.659566915407, 9861.408315501092, 10006.149477294512], "value": 7900.536152746111, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1223.162133938253, 1312.25201635068, 1355.5187908292555, 1386.6048176269758, 1615.1116885712854, 6534.117894084297, 7053.294670532944, 7395.1125864896285, 7397.334239918407, 7837.0, 7378.114626244858, 7440.888386674191, 7443.506425347501, 7446.143693475252, 7448.888266676005, 2125.0437303213575, 2143.882086485243, 2144.9463763405884, 2148.226638410179, 2151.3115802942984, 2066.4214020074405, 2099.748030236374, 2103.29539604232, 2103.453102193433, 2107.441527995075, 2112.7781582933803, 2125.9893700531475, 2139.935801925945, 2141.2826703054498, 2144.3245377706053, 2089.968650470244, 2094.1623350659706, 2096.423483542023, 2099.170827523135, 2099.842511811605, 1998.3405476192822, 2076.8234700050516, 2082.239982406426, 2082.8958552072336, 2086.2698055680544, 6861.828454288683, 7152.785416437515, 7592.620368981528, 7606.163322034572, 7702.730404435818, 4191.832326706928, 4301.913961720748, 4312.892177695583, 4330.783460826978, 4332.891677708051, 2699.35215548269, 2752.8898844046216, 2815.47913635978, 2823.8588070596593, 2829.1512546236045, 893.9776505587347, 904.5522466379118, 910.5310764956052, 914.4833169259347, 927.1331305229564, 9190.126937940951, 9206.079392060807, 9208.585613647401, 9211.63153473867, 9224.723258302194, 3533.611302756695, 3560.181158333598, 3601.657842504958, 3680.245549662313, 3711.758735682172, 7564.886526702104, 7565.470417070862, 7575.280348366897, 7576.5832879191075, 7584.08990921093, 4222.092250166229, 4231.174920890458, 4243.024104455931, 4247.978760106242, 4250.0, 3538.1862171700654, 3679.748885378984, 3853.7687738735767, 3943.8225279862477, 3945.6448919597374, 3203.9199020024685, 3230.144011836865, 3360.781549199294, 3379.1889946413175, 3381.9492707609406, 984.871966644346, 992.3500107429645, 1006.3760468509571, 1010.8584798128268, 1037.823569993103, 793.2860425616991, 810.6109067647562, 814.230552128245, 823.2261674026515, 833.3957880536684, 4862.0, 4878.829240976549, 4981.501849815062, 5018.222175562793, 5252.054630166606, 383.6949625048093, 385.13152840344844, 386.9651731344193, 388.37665546797547, 396.33218027622974, 3418.384690755638, 3421.0934102462866, 3434.4848272759286, 3448.603410607762, 3574.6067932527403, 8902.42134261271, 9245.0, 9313.860292095624, 9347.90652093484, 9363.531823408803, 9284.164425201629, 9307.11582399671, 9310.441373517475, 9312.534373281309, 9325.533723313807, 6937.063496428019, 7067.257937916547, 7101.502894797314, 7106.822329441702, 7122.074130363019, 4720.339152518582, 4798.160321943716, 4861.368022157097, 4890.535399137077, 5060.316857224375, 8341.916580834113, 8549.829003420022, 8550.57247137653, 8573.65705371803, 8630.0, 8489.193526614961, 8635.956820215859, 8688.739337819876, 8689.522076285612, 8702.347323950602, 5533.972330138485, 6294.842628934313, 6351.745930162741, 6352.745890164341, 6363.268224154282, 6681.732730690718, 7094.042304288855, 7169.175544812413, 7314.524555903849, 7316.670749816165, 6144.754209831735, 6276.0, 6278.215223097113, 6452.0, 6493.415592596689, 6384.170057892445, 6395.6482393468805, 6445.903311450238, 6448.387403196689, 6467.353264673683, 5613.74738136793, 5705.0, 5706.172604972338, 5713.628614140068, 5716.342620598684, 4194.412782210432, 4213.957860421357, 4324.481062272547, 4330.935035974526, 4408.6693497987135, 4383.254846676136, 4435.1351486459835, 4499.21263778844, 4507.233770258998, 4572.35986961819], "value": 3805.2236047347, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [265.08809694650415, 274.99626363772234, 281.25888284370683, 281.27852059467466, 283.57039085785027, 4567.703099298552, 4735.621150307976, 4770.833020844271, 4801.303810947411, 4806.591439727627, 4557.0, 4686.531346865312, 4700.777797772586, 4718.5281471852795, 4728.40894888139, 3483.3904066788336, 3717.293714194308, 3717.6282371762877, 3757.380032294668, 3762.2099359134613, 3602.783832970017, 3611.259691763182, 3613.9277214455697, 3620.2216523447455, 3625.6736893679563, 3507.912302192453, 3691.53855768029, 3693.279810436966, 3710.239400922804, 3712.0, 3671.57776855661, 3674.761140525857, 3677.4851520787247, 3706.258748250361, 3711.109333759905, 3048.6646468888403, 3140.654528001941, 3243.4486137356707, 3250.284937313811, 3255.20247539352, 4617.746023968681, 4619.228462922253, 4639.816846704102, 4647.256438969748, 4663.463701674317, 4154.210699967027, 4157.584241575849, 4160.2111092230325, 4160.54234034256, 4171.791410429466, 4737.507685079189, 4883.169861123618, 4913.484084171147, 4938.617187187593, 5016.673916195472, 3410.181556426465, 3411.385950528904, 3419.4186988212064, 3456.187795867969, 3458.291050334675, 5252.242572649351, 5266.683998960037, 5287.995280896617, 5299.205119232146, 5308.893822123575, 3334.5164951081956, 3471.9479207811396, 3530.5763308403157, 3538.663826936437, 3539.150603855108, 3504.0, 3505.1412403961194, 3509.824508774551, 3517.9472307915403, 3534.0281422608473, 4088.2845502037026, 4090.365993271048, 4090.4682391288943, 4096.0, 4117.394216255662, 4978.4025916890205, 4981.227909674007, 4981.875453113628, 4999.275105109811, 5003.49965003504, 1124.1849658997326, 1148.3970915269383, 1188.8811118888043, 1221.5052903574067, 1225.3995542184266, 820.819419727659, 833.9416240863081, 837.7779888329597, 841.7264389073454, 843.0684094075958, 4412.382266482695, 4431.689781715249, 4436.733795972252, 4439.22313595126, 4447.444069491314, 5123.923141152885, 5150.227465880073, 5162.303089082926, 5166.276721259027, 5180.378354597472, 4291.527931927485, 4449.820797488668, 4523.0, 4544.2047641662575, 4566.680332376702, 2753.2428582140074, 2773.6394268744934, 2781.1644314752166, 2782.735640114186, 2784.7354501322343, 4911.631627627942, 4915.3855768029, 4924.507549245119, 4924.704517728947, 4926.802927882916, 5119.48805119485, 5288.021715982555, 5293.470652934676, 5296.549793267538, 5330.173823057432, 4856.805727770849, 4858.368412106403, 4865.270209468537, 4869.561739443467, 4871.8294859679745, 5001.599872010303, 5159.613029022763, 5164.302819119371, 5182.663126896739, 5186.325777648882, 4983.875403114951, 5002.998201079324, 5042.873928151826, 5046.293518907282, 5048.141815891381, 4830.830920917751, 4832.685875418087, 4852.660313778002, 4857.668319206871, 4862.294967229803, 3571.928561428705, 3583.569971603424, 3585.8744943926836, 3597.352476554245, 3599.262151259038, 5032.874178145576, 5082.136036873814, 5131.0, 5162.50287416645, 5167.767450464663, 4969.776360063878, 4978.975105124451, 4983.27742477346, 4998.925016124688, 5007.298978143136, 4989.575886049582, 4998.725070121178, 5012.9723406700805, 5014.194889839582, 5035.697858128524, 4712.363830882787, 4715.905681886412, 4838.564529192389, 4916.655834091579, 4940.665051090427, 4828.613710903049, 4961.875953101201, 4993.675411098267, 5001.474845141353, 5002.224655178453, 4906.509349065065, 4922.3600931880055, 4931.654784165074, 4959.280904268789, 4963.875903102306], "value": 3724.8951522290754, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.4172561243655, 669.9799006029817, 693.7918624412675, 733.5855241788389, 742.1539445032662, 12141.635750927475, 13244.072914895962, 13265.40305686244, 13278.933605331971, 13280.0, 13317.134386264886, 13368.131071480348, 13382.263975481344, 13398.330083495835, 13404.0, 595.8361450601076, 610.3194937644539, 726.7020521586151, 734.1410549656888, 755.327758295115, 755.12405609493, 766.8696321625309, 767.5931756169239, 767.7121079595152, 767.8195624028377, 807.5356669914822, 808.1110778144053, 808.1716240853114, 808.9231523005305, 809.2635701511625, 631.1479502671402, 649.6978904809287, 784.254957790096, 798.6206551887835, 799.3085980626745, 586.5805948746666, 587.5211702462523, 587.5270407322104, 587.8412828536314, 587.8618524646747, 12998.285094319808, 13113.344332783323, 13118.803217951738, 13125.934370328183, 13137.0, 12411.875881241162, 12525.874741252654, 12813.551525696648, 13065.934670326682, 13487.932560337234, 11612.36132012739, 11699.298042117414, 11811.527538898434, 11871.0503159747, 12189.51241950321, 4085.22380747657, 4089.5501494835544, 4144.109016561454, 4150.875473735793, 4288.0351920817875, 59000.70499647517, 59303.70348148232, 60351.0, 60782.78434431331, 61785.38214617841, 10243.9487802562, 10517.84223236652, 10527.94736026315, 10591.682249532527, 10965.671029869116, 16800.495985120466, 17504.737428938577, 19373.4187974361, 19609.31367402134, 19655.901720491307, 6904.240533541307, 7049.89425158623, 7112.751053713096, 7130.180029296594, 7266.781996540112, 3650.2881938021833, 3733.9813300933865, 3794.6015668354976, 3794.658480736747, 3834.0606551395085, 2909.170886297395, 3000.354923691417, 3015.276333679945, 3019.698030196963, 3020.516717325261, 492.26898056386955, 494.36967865970456, 502.74360076360585, 503.4889587069128, 504.0901173382081, 480.71877951398824, 487.87301333918055, 518.4944678938081, 533.2081858440213, 565.9405762394889, 7242.13094428672, 7448.73929412468, 7508.361789247866, 7629.088080110906, 7794.181610930884, 519.130456485393, 521.4342438454244, 525.3170877858769, 551.6827824001215, 560.9298837645294, 3383.4079036168573, 3448.810315432625, 3635.654612811779, 3812.3709587917683, 3816.7137464689704, 59115.70442147762, 97384.0, 98609.0, 98663.50668246756, 101672.49163754281, 52349.2147617786, 53469.99999999922, 82330.17669823345, 84073.0, 86090.0, 75492.62253688916, 75805.24194758091, 76329.61835190789, 76573.23426765772, 77828.61085694535, 6834.521583489108, 7027.824304392227, 7230.566166030055, 7377.594232317274, 7394.075740532434, 43683.56316436795, 44332.33501497415, 44338.77830610827, 44667.0, 45035.54964450314, 62647.0, 64772.352276478516, 65174.34825651683, 65340.67329663321, 66793.0, 9805.950970245389, 9822.165115965223, 9869.062439068564, 9961.103500684972, 10011.149052330342, 9961.850572241567, 9985.60057597688, 10023.298369114093, 10074.093331600192, 10522.158227341948, 10201.132903702972, 10386.0, 10417.16662667, 10561.26071175041, 10570.990725630072, 9622.47076410804, 9635.903640963781, 9855.704328870146, 9904.801903962025, 9925.205983521446, 9656.71029869105, 9933.155681766842, 9957.402555846673, 10037.247206459399, 10083.344582602107, 8052.718154864551, 8084.272415482635, 8095.23095305945, 8353.331733461187, 8424.873626895724, 8233.259006689426, 8506.489610623383, 8567.828643426972, 8680.479171249744, 9040.864387034067], "value": 6264.155110726849, "unit": "score"}], "name": "dromaeo_css", "value": 6152.071264591131, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 114.0, 115.0, 114.0, 116.0, 115.0, 115.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 133.0, 128.0, 164.0, 131.0, 129.0, 128.0, 128.0, 174.0, 129.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 163.0, 163.0, 162.0, 164.0, 161.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 112.0, 77.0, 76.0, 76.0, 77.0, 108.0, 77.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 130.0, 84.0, 83.0, 84.0, 108.0, 83.0, 84.0, 127.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 66.0, 65.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 67.0, 68.0, 66.0, 66.0, 67.0, 66.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 82.0, 83.0, 83.0, 82.0, 82.0, 84.0, 81.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 139.0, 138.0, 139.0, 142.0, 142.0, 155.0, 140.0, 173.0, 136.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 176.0, 178.0, 184.0, 181.0, 175.0, 176.0, 175.0, 178.0, 181.0], "value": 178.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 69.0, 72.0, 70.0, 68.0, 72.0, 69.0, 72.0, 70.0], "value": 70.7, "unit": "score"}], "name": "kraken", "value": 1560.4000000000003, "alertThreshold": 2.0}]} 21:56:48 INFO - Return code: 0 21:56:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:56:48 INFO - # TBPL SUCCESS # 21:56:48 INFO - Running post-action listener: _resource_record_post_action 21:56:48 INFO - [mozharness: 2016-10-08 04:56:48.377208Z] Finished run-tests step (success) 21:56:48 INFO - Running post-run listener: _resource_record_post_run 21:56:48 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404934656; Read time: 12; Write time: 295852 21:56:48 INFO - TinderboxPrint: CPU usage
13.0% 21:56:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:56:48 INFO - TinderboxPrint: I/O write bytes / time
404,934,656 / 295,852 21:56:48 INFO - TinderboxPrint: CPU idle
8,342.4 (87.0%) 21:56:48 INFO - TinderboxPrint: CPU user
1,200.6 (12.5%) 21:56:48 INFO - TinderboxPrint: Swap in / out
0 / 0 21:56:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110649344; Read time: 0; Write time: 60040 21:56:48 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 294285312; Read time: 0; Write time: 235812 21:56:49 INFO - Running post-run listener: _upload_blobber_files 21:56:49 INFO - Blob upload gear active. 21:56:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:56:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:56:49 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:56:49 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:56:49 INFO - (blobuploader) - INFO - Open directory for files ... 21:56:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:56:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:56:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:56:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:56:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:56:50 INFO - (blobuploader) - INFO - Done attempting. 21:56:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:56:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:56:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:56:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:56:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:56:50 INFO - (blobuploader) - INFO - Done attempting. 21:56:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:56:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:56:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:56:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:56:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:56:54 INFO - (blobuploader) - INFO - Done attempting. 21:56:54 INFO - (blobuploader) - INFO - Iteration through files over. 21:56:54 INFO - Return code: 0 21:56:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:56:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:56:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e64557dd3b5b97f3db87187badaa557ff09fee257c639ba78e95929a579cb804ab84bc7c63f2d354dc10283f22cfe386f294424aff46008412cb7d0a6b00ccfc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e20fb3dd2ec181e855ad6da9cef363157c7c0806213585e149148f97f9534a07d4c741d788f6d12d44f7e5f7f6c016f4b82d31d256320b9fe6fc2a255ce4967d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7271b427d7db92820a375d28f22aeb08b59d06b25e9ff52c91fab1b8522c3026420e5dc3eaa5eff9c0dc28a76cc09d956967d5869f88a956cd87997992ecedb"} 21:56:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:56:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:56:54 INFO - Contents: 21:56:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e64557dd3b5b97f3db87187badaa557ff09fee257c639ba78e95929a579cb804ab84bc7c63f2d354dc10283f22cfe386f294424aff46008412cb7d0a6b00ccfc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e20fb3dd2ec181e855ad6da9cef363157c7c0806213585e149148f97f9534a07d4c741d788f6d12d44f7e5f7f6c016f4b82d31d256320b9fe6fc2a255ce4967d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7271b427d7db92820a375d28f22aeb08b59d06b25e9ff52c91fab1b8522c3026420e5dc3eaa5eff9c0dc28a76cc09d956967d5869f88a956cd87997992ecedb"} 21:56:54 INFO - Running post-run listener: copy_logs_to_upload_dir 21:56:54 INFO - Copying logs to upload dir... 21:56:54 INFO - mkdir: /builds/slave/test/build/upload/logs 21:56:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.230550 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-07 21:56:54.102161) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 21:56:54.106231) ========= 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=62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057 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-Non-PGO/sha512/e64557dd3b5b97f3db87187badaa557ff09fee257c639ba78e95929a579cb804ab84bc7c63f2d354dc10283f22cfe386f294424aff46008412cb7d0a6b00ccfc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e20fb3dd2ec181e855ad6da9cef363157c7c0806213585e149148f97f9534a07d4c741d788f6d12d44f7e5f7f6c016f4b82d31d256320b9fe6fc2a255ce4967d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7271b427d7db92820a375d28f22aeb08b59d06b25e9ff52c91fab1b8522c3026420e5dc3eaa5eff9c0dc28a76cc09d956967d5869f88a956cd87997992ecedb"} build_url:https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/WG17_2CzQH-wQhzBcmmZIA/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-Non-PGO/sha512/e64557dd3b5b97f3db87187badaa557ff09fee257c639ba78e95929a579cb804ab84bc7c63f2d354dc10283f22cfe386f294424aff46008412cb7d0a6b00ccfc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e20fb3dd2ec181e855ad6da9cef363157c7c0806213585e149148f97f9534a07d4c741d788f6d12d44f7e5f7f6c016f4b82d31d256320b9fe6fc2a255ce4967d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7271b427d7db92820a375d28f22aeb08b59d06b25e9ff52c91fab1b8522c3026420e5dc3eaa5eff9c0dc28a76cc09d956967d5869f88a956cd87997992ecedb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 21:56:54.132362) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:56:54.132749) ========= 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=62c568580acbfdaac3eec7be000001dc-1475900880.948541-662891057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:56:54.215035) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 21:56:54.215395) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 21:56:54.215759) ========= ========= Total master_lag: 0.18 =========