builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1471428924.89 results: success (0) buildid: 20160817014415 builduid: 66ab59acd5c64f6dab16a675d29d3565 revision: 587a4c621b5f78aece57046bd3a19ab695da14ed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 03:15:24.888497) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 03:15:24.889016) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 03:15:24.889345) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 03:15:24.928796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:15:24.929187) ========= 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=7de08804244eb36560b44971000001c3-1471425317.477164-1998930345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-17 03:15:25-- 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% 114M=0s 2016-08-17 03:15:25 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.217769 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:15:25.184657) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:15:25.184944) ========= 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=7de08804244eb36560b44971000001c3-1471425317.477164-1998930345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.096358 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:15:25.301229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-17 03:15:25.301831) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 587a4c621b5f78aece57046bd3a19ab695da14ed --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 587a4c621b5f78aece57046bd3a19ab695da14ed --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=7de08804244eb36560b44971000001c3-1471425317.477164-1998930345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-17 03:15:25,393 truncating revision to first 12 chars 2016-08-17 03:15:25,393 Setting DEBUG logging. 2016-08-17 03:15:25,393 attempt 1/10 2016-08-17 03:15:25,394 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/587a4c621b5f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-17 03:15:26,208 unpacking tar archive at: autoland-587a4c621b5f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.157582 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-17 03:15:26.478903) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 03:15:26.479265) ========= script_repo_revision: 587a4c621b5f78aece57046bd3a19ab695da14ed ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 03:15:26.479701) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 03:15:26.479980) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 03:15:26.490875) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-17 03:15:26.491513) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1471425317.477164-1998930345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:15:26 INFO - MultiFileLogger online at 20160817 03:15:26 in /builds/slave/test 03:15:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 03:15:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:15:26 INFO - {'append_to_log': False, 03:15:26 INFO - 'base_work_dir': '/builds/slave/test', 03:15:26 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 03:15:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:15:26 INFO - 'branch': 'Autoland-Non-PGO', 03:15:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:15:26 INFO - 'config_files': ('talos/linux_config.py',), 03:15:26 INFO - 'default_actions': ('clobber', 03:15:26 INFO - 'read-buildbot-config', 03:15:26 INFO - 'download-and-extract', 03:15:26 INFO - 'populate-webroot', 03:15:26 INFO - 'create-virtualenv', 03:15:26 INFO - 'install', 03:15:26 INFO - 'run-tests'), 03:15:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:15:26 INFO - 'download_minidump_stackwalk': True, 03:15:26 INFO - 'download_symbols': 'ondemand', 03:15:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:15:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:15:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:15:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:15:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:15:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:15:26 INFO - 'installer_path': 'installer.exe', 03:15:26 INFO - 'log_level': 'info', 03:15:26 INFO - 'log_name': 'talos', 03:15:26 INFO - 'log_to_console': True, 03:15:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:15:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:15:26 INFO - 'opt_config_files': (), 03:15:26 INFO - 'pip_index': False, 03:15:26 INFO - 'sps_profile': False, 03:15:26 INFO - 'sps_profile_interval': 0, 03:15:26 INFO - 'suite': 'dromaeojs-e10s', 03:15:26 INFO - 'system_bits': '32', 03:15:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:15:26 INFO - 'title': 'talos-linux64-ix-003', 03:15:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:15:26 INFO - 'use_talos_json': True, 03:15:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:15:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:15:26 INFO - 'work_dir': 'build'} 03:15:26 INFO - [mozharness: 2016-08-17 10:15:26.785196Z] Running clobber step. 03:15:26 INFO - Running pre-action listener: _resource_record_pre_action 03:15:26 INFO - Running main action method: clobber 03:15:26 INFO - rmtree: /builds/slave/test/build 03:15:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:15:28 INFO - Running post-action listener: _resource_record_post_action 03:15:28 INFO - [mozharness: 2016-08-17 10:15:28.674364Z] Finished clobber step (success) 03:15:28 INFO - [mozharness: 2016-08-17 10:15:28.674495Z] Running read-buildbot-config step. 03:15:28 INFO - Running pre-action listener: _resource_record_pre_action 03:15:28 INFO - Running main action method: read_buildbot_config 03:15:28 INFO - Using buildbot properties: 03:15:28 INFO - { 03:15:28 INFO - "project": "", 03:15:28 INFO - "product": "firefox", 03:15:28 INFO - "script_repo_revision": "production", 03:15:28 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 03:15:28 INFO - "repository": "", 03:15:28 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 03:15:28 INFO - "buildid": "20160817014415", 03:15:28 INFO - "pgo_build": "False", 03:15:28 INFO - "basedir": "/builds/slave/test", 03:15:28 INFO - "buildnumber": 291, 03:15:28 INFO - "slavename": "talos-linux64-ix-003", 03:15:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:15:28 INFO - "platform": "ubuntu64_hw", 03:15:28 INFO - "scheduler": "tests-autoland-linux64-talos-7-3600", 03:15:28 INFO - "branch": "autoland", 03:15:28 INFO - "repo_path": "integration/autoland", 03:15:28 INFO - "revision": "587a4c621b5f78aece57046bd3a19ab695da14ed", 03:15:28 INFO - "stage_platform": "linux64", 03:15:28 INFO - "builduid": "66ab59acd5c64f6dab16a675d29d3565", 03:15:28 INFO - "slavebuilddir": "test" 03:15:28 INFO - } 03:15:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 03:15:28 INFO - Running post-action listener: _resource_record_post_action 03:15:28 INFO - [mozharness: 2016-08-17 10:15:28.677730Z] Finished read-buildbot-config step (success) 03:15:28 INFO - [mozharness: 2016-08-17 10:15:28.677848Z] Running download-and-extract step. 03:15:28 INFO - Running pre-action listener: _resource_record_pre_action 03:15:28 INFO - Running main action method: download_and_extract 03:15:28 INFO - mkdir: /builds/slave/test/build/tests 03:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:28 INFO - trying https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:15:28 INFO - Downloading https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:15:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:15:29 INFO - Downloaded 1361 bytes. 03:15:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:15:29 INFO - Using the following test package requirements: 03:15:29 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:15:29 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:15:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:15:29 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:15:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:15:29 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:15:29 INFO - u'jsshell-linux-x86_64.zip'], 03:15:29 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:15:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:15:29 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:15:29 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:15:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:15:29 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:15:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:15:29 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:15:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:15:29 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:15:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:15:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:15: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')]} 03:15:29 INFO - trying https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:15:29 INFO - Downloading https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:15:30 INFO - Downloaded 20315772 bytes. 03:15:30 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 03:15:34 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:15: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')]} 03:15:34 INFO - trying https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:15:34 INFO - Downloading https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:15:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:15:35 INFO - Downloaded 20315772 bytes. 03:15:35 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 03:15:40 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')]} 03:15:41 INFO - trying https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:15:41 INFO - Downloading https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:15:42 INFO - Downloaded 14413719 bytes. 03:15:42 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 03:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:42 INFO - trying https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:15:42 INFO - Downloading https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:15:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:15:44 INFO - Downloaded 55773895 bytes. 03:15:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:15:44 INFO - mkdir: /builds/slave/test/properties 03:15:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:15:44 INFO - Writing to file /builds/slave/test/properties/build_url 03:15:44 INFO - Contents: 03:15:44 INFO - build_url:https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:15:44 INFO - Running post-action listener: _resource_record_post_action 03:15:44 INFO - Running post-action listener: set_extra_try_arguments 03:15:44 INFO - [mozharness: 2016-08-17 10:15:44.929054Z] Finished download-and-extract step (success) 03:15:44 INFO - [mozharness: 2016-08-17 10:15:44.929278Z] Running populate-webroot step. 03:15:44 INFO - Running pre-action listener: _resource_record_pre_action 03:15:44 INFO - Running main action method: populate_webroot 03:15:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:15:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:15:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:15:44 INFO - '--tppagecycles', 03:15:44 INFO - '7'], 03:15:44 INFO - 'tests': ['tsvgm']}}, 03:15:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:15:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:15:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:15:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:15:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:15:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:15:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:44 INFO - 'talos_options': ['--disable-e10s'], 03:15:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:44 INFO - 'talos_options': ['--disable-e10s'], 03:15:44 INFO - 'tests': ['damp', 'tps']}, 03:15:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:44 INFO - 'tests': ['damp', 'tps']}, 03:15:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:15:44 INFO - 'tests': ['dromaeo_dom']}, 03:15:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:15:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:15:44 INFO - 'tests': ['basic_compositor_video']}, 03:15:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:15:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:15:44 INFO - 'tests': ['a11yr', 03:15:44 INFO - 'ts_paint', 03:15:44 INFO - 'tpaint', 03:15:44 INFO - 'sessionrestore', 03:15:44 INFO - 'sessionrestore_no_auto_restore', 03:15:44 INFO - 'tabpaint']}, 03:15:44 INFO - 'other-e10s': {'tests': ['a11yr', 03:15:44 INFO - 'ts_paint', 03:15:44 INFO - 'tpaint', 03:15:44 INFO - 'sessionrestore', 03:15:44 INFO - 'sessionrestore_no_auto_restore', 03:15:44 INFO - 'tabpaint']}, 03:15:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:15:44 INFO - 'ts_paint', 03:15:44 INFO - 'tpaint', 03:15:44 INFO - 'sessionrestore', 03:15:44 INFO - 'sessionrestore_no_auto_restore', 03:15:44 INFO - 'tabpaint']}, 03:15:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:15:44 INFO - 'ts_paint', 03:15:44 INFO - 'tpaint', 03:15:44 INFO - 'sessionrestore', 03:15:44 INFO - 'sessionrestore_no_auto_restore', 03:15:44 INFO - 'tabpaint']}, 03:15:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:15:44 INFO - 'tests': ['a11yr', 03:15:44 INFO - 'ts_paint', 03:15:44 INFO - 'tpaint', 03:15:44 INFO - 'sessionrestore', 03:15:44 INFO - 'sessionrestore_no_auto_restore', 03:15:44 INFO - 'tabpaint']}, 03:15:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:15:44 INFO - 'tests': ['a11yr', 03:15:44 INFO - 'ts_paint', 03:15:44 INFO - 'tpaint', 03:15:44 INFO - 'sessionrestore', 03:15:44 INFO - 'sessionrestore_no_auto_restore', 03:15:44 INFO - 'tabpaint']}, 03:15:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:15:44 INFO - 'tests': ['tsvgx', 03:15:44 INFO - 'tsvgr_opacity', 03:15:44 INFO - 'tart', 03:15:44 INFO - 'tscrollx', 03:15:44 INFO - 'cart']}, 03:15:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:15:44 INFO - 'tsvgr_opacity', 03:15:44 INFO - 'tart', 03:15:44 INFO - 'tscrollx', 03:15:44 INFO - 'cart']}, 03:15:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:44 INFO - 'talos_options': ['--disable-e10s'], 03:15:44 INFO - 'tests': ['tp5o']}, 03:15:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:44 INFO - 'tests': ['tp5o']}, 03:15:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:44 INFO - 'talos_options': ['--disable-e10s', 03:15:44 INFO - '--xperf_path', 03:15:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:44 INFO - 'tests': ['tp5n']}, 03:15:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:44 INFO - 'talos_options': ['--xperf_path', 03:15:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:44 INFO - 'tests': ['tp5n']}}, 03:15:44 INFO - 'talos.zip': {'path': '', 03:15:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:15:44 INFO - Running post-action listener: _resource_record_post_action 03:15:44 INFO - [mozharness: 2016-08-17 10:15:44.952567Z] Finished populate-webroot step (success) 03:15:44 INFO - [mozharness: 2016-08-17 10:15:44.952660Z] Running create-virtualenv step. 03:15:44 INFO - Running pre-action listener: _resource_record_pre_action 03:15:44 INFO - Running main action method: create_virtualenv 03:15:44 INFO - Creating virtualenv /builds/slave/test/build/venv 03:15:44 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 03:15:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:15:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:15:45 INFO - Using real prefix '/usr' 03:15:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:15:45 INFO - Installing distribute.............................................................................................................................................................................................done. 03:15:47 INFO - Installing pip.................done. 03:15:47 INFO - Return code: 0 03:15:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc04bee3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1583090>, '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 0x15869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586e40>, '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': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', '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 03:15:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:15:47 INFO - Using env: {'DISPLAY': ':0', 03:15:47 INFO - 'HOME': '/home/cltbld', 03:15:47 INFO - 'LANG': 'en_US.UTF-8', 03:15:47 INFO - 'LANGUAGE': 'en_US:en', 03:15:47 INFO - 'LOGNAME': 'cltbld', 03:15:47 INFO - 'MAIL': '/var/mail/cltbld', 03:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:47 INFO - 'MOZ_NO_REMOTE': '1', 03:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:47 INFO - 'NO_EM_RESTART': '1', 03:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:47 INFO - 'PWD': '/builds/slave/test', 03:15:47 INFO - 'SHELL': '/bin/bash', 03:15:47 INFO - 'SHLVL': '1', 03:15:47 INFO - 'TERM': 'linux', 03:15:47 INFO - 'TMOUT': '86400', 03:15:47 INFO - 'USER': 'cltbld', 03:15:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', 03:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:47 INFO - '_': '/tools/buildbot/bin/python'} 03:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:47 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 03:15:47 INFO - Cleaning up... 03:15:47 INFO - Return code: 0 03:15:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc04bee3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1583090>, '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 0x15869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586e40>, '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': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', '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 03:15:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:15:47 INFO - Using env: {'DISPLAY': ':0', 03:15:47 INFO - 'HOME': '/home/cltbld', 03:15:47 INFO - 'LANG': 'en_US.UTF-8', 03:15:47 INFO - 'LANGUAGE': 'en_US:en', 03:15:47 INFO - 'LOGNAME': 'cltbld', 03:15:47 INFO - 'MAIL': '/var/mail/cltbld', 03:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:47 INFO - 'MOZ_NO_REMOTE': '1', 03:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:47 INFO - 'NO_EM_RESTART': '1', 03:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:47 INFO - 'PWD': '/builds/slave/test', 03:15:47 INFO - 'SHELL': '/bin/bash', 03:15:47 INFO - 'SHLVL': '1', 03:15:47 INFO - 'TERM': 'linux', 03:15:47 INFO - 'TMOUT': '86400', 03:15:47 INFO - 'USER': 'cltbld', 03:15:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', 03:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:47 INFO - '_': '/tools/buildbot/bin/python'} 03:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:48 INFO - Downloading/unpacking psutil>=3.1.1 03:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:15:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:50 INFO - Installing collected packages: psutil 03:15:50 INFO - Running setup.py install for psutil 03:15:50 INFO - building 'psutil._psutil_linux' extension 03:15:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:15:51 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 03:15:51 INFO - building 'psutil._psutil_posix' extension 03:15:51 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 03:15:51 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 03:15:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:51 INFO - Successfully installed psutil 03:15:51 INFO - Cleaning up... 03:15:51 INFO - Return code: 0 03:15:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:51 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 0x7fc04bee3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1583090>, '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 0x15869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586e40>, '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': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', '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 03:15:51 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 03:15:51 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 03:15:51 INFO - Using env: {'DISPLAY': ':0', 03:15:51 INFO - 'HOME': '/home/cltbld', 03:15:51 INFO - 'LANG': 'en_US.UTF-8', 03:15:51 INFO - 'LANGUAGE': 'en_US:en', 03:15:51 INFO - 'LOGNAME': 'cltbld', 03:15:51 INFO - 'MAIL': '/var/mail/cltbld', 03:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:51 INFO - 'MOZ_NO_REMOTE': '1', 03:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:51 INFO - 'NO_EM_RESTART': '1', 03:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:51 INFO - 'PWD': '/builds/slave/test', 03:15:51 INFO - 'SHELL': '/bin/bash', 03:15:51 INFO - 'SHLVL': '1', 03:15:51 INFO - 'TERM': 'linux', 03:15:51 INFO - 'TMOUT': '86400', 03:15:51 INFO - 'USER': 'cltbld', 03:15:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', 03:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:51 INFO - '_': '/tools/buildbot/bin/python'} 03:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:15:52 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 03:15:52 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 03:15:52 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 03:15:52 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 03:15:52 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 03:15:52 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 03:15:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:15:54 INFO - Installing collected packages: mozsystemmonitor 03:15:54 INFO - Running setup.py install for mozsystemmonitor 03:15:54 INFO - Successfully installed mozsystemmonitor 03:15:54 INFO - Cleaning up... 03:15:54 INFO - Return code: 0 03:15:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:15:54 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')]} 03:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:54 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')]} 03:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:54 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 0x7fc04bee3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1583090>, '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 0x15869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586e40>, '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': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', '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 03:15:54 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 03:15:54 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 03:15:54 INFO - Using env: {'DISPLAY': ':0', 03:15:54 INFO - 'HOME': '/home/cltbld', 03:15:54 INFO - 'LANG': 'en_US.UTF-8', 03:15:54 INFO - 'LANGUAGE': 'en_US:en', 03:15:54 INFO - 'LOGNAME': 'cltbld', 03:15:54 INFO - 'MAIL': '/var/mail/cltbld', 03:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:54 INFO - 'MOZ_NO_REMOTE': '1', 03:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:54 INFO - 'NO_EM_RESTART': '1', 03:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:54 INFO - 'PWD': '/builds/slave/test', 03:15:54 INFO - 'SHELL': '/bin/bash', 03:15:54 INFO - 'SHLVL': '1', 03:15:54 INFO - 'TERM': 'linux', 03:15:54 INFO - 'TMOUT': '86400', 03:15:54 INFO - 'USER': 'cltbld', 03:15:54 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', 03:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:54 INFO - '_': '/tools/buildbot/bin/python'} 03:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:54 INFO - Downloading/unpacking jsonschema==2.5.1 03:15:54 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 03:15:54 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 03:15:54 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 03:15:54 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 03:15:54 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 03:15:54 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 03:15:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:15:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:56 INFO - Downloading functools32-3.2.3-2.tar.gz 03:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:15:56 INFO - warning: no files found matching '*.txt' 03:15:56 INFO - no previously-included directories found matching 'build' 03:15:56 INFO - no previously-included directories found matching 'dist' 03:15:56 INFO - no previously-included directories found matching '.git*' 03:15:56 INFO - Installing collected packages: jsonschema, functools32 03:15:56 INFO - Running setup.py install for functools32 03:15:56 INFO - warning: no files found matching '*.txt' 03:15:56 INFO - no previously-included directories found matching 'build' 03:15:56 INFO - no previously-included directories found matching 'dist' 03:15:56 INFO - no previously-included directories found matching '.git*' 03:15:56 INFO - Successfully installed jsonschema functools32 03:15:56 INFO - Cleaning up... 03:15:56 INFO - Return code: 0 03:15:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc04bee3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1583090>, '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 0x15869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586e40>, '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': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', '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 03:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:15:56 INFO - Using env: {'DISPLAY': ':0', 03:15:56 INFO - 'HOME': '/home/cltbld', 03:15:56 INFO - 'LANG': 'en_US.UTF-8', 03:15:56 INFO - 'LANGUAGE': 'en_US:en', 03:15:56 INFO - 'LOGNAME': 'cltbld', 03:15:56 INFO - 'MAIL': '/var/mail/cltbld', 03:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:56 INFO - 'MOZ_NO_REMOTE': '1', 03:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:56 INFO - 'NO_EM_RESTART': '1', 03:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:56 INFO - 'PWD': '/builds/slave/test', 03:15:56 INFO - 'SHELL': '/bin/bash', 03:15:56 INFO - 'SHLVL': '1', 03:15:56 INFO - 'TERM': 'linux', 03:15:56 INFO - 'TMOUT': '86400', 03:15:56 INFO - 'USER': 'cltbld', 03:15:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', 03:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:56 INFO - '_': '/tools/buildbot/bin/python'} 03:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:15:56 INFO - Cleaning up... 03:15:56 INFO - Return code: 0 03:15:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc04bee3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1583090>, '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 0x15869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586e40>, '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': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', '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 03:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:15:56 INFO - Using env: {'DISPLAY': ':0', 03:15:56 INFO - 'HOME': '/home/cltbld', 03:15:56 INFO - 'LANG': 'en_US.UTF-8', 03:15:56 INFO - 'LANGUAGE': 'en_US:en', 03:15:56 INFO - 'LOGNAME': 'cltbld', 03:15:56 INFO - 'MAIL': '/var/mail/cltbld', 03:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:56 INFO - 'MOZ_NO_REMOTE': '1', 03:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:56 INFO - 'NO_EM_RESTART': '1', 03:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:56 INFO - 'PWD': '/builds/slave/test', 03:15:56 INFO - 'SHELL': '/bin/bash', 03:15:57 INFO - 'SHLVL': '1', 03:15:57 INFO - 'TERM': 'linux', 03:15:57 INFO - 'TMOUT': '86400', 03:15:57 INFO - 'USER': 'cltbld', 03:15:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', 03:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:57 INFO - '_': '/tools/buildbot/bin/python'} 03:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:57 INFO - Downloading/unpacking blobuploader==1.2.4 03:15:57 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 03:15:57 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 03:15:57 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 03:15:57 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 03:15:57 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 03:15:57 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 03:15:59 INFO - Downloading blobuploader-1.2.4.tar.gz 03:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:15:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:15:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:59 INFO - Downloading docopt-0.6.1.tar.gz 03:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:15:59 INFO - Installing collected packages: blobuploader, requests, docopt 03:15:59 INFO - Running setup.py install for blobuploader 03:15:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:15:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:15:59 INFO - Running setup.py install for requests 03:16:00 INFO - Running setup.py install for docopt 03:16:00 INFO - Successfully installed blobuploader requests docopt 03:16:00 INFO - Cleaning up... 03:16:00 INFO - Return code: 0 03:16:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:00 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')]} 03:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:00 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')]} 03:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:00 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 0x7fc04bee3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1583090>, '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 0x15869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586e40>, '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': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', '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 03:16:00 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 03:16:00 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 03:16:00 INFO - Using env: {'DISPLAY': ':0', 03:16:00 INFO - 'HOME': '/home/cltbld', 03:16:00 INFO - 'LANG': 'en_US.UTF-8', 03:16:00 INFO - 'LANGUAGE': 'en_US:en', 03:16:00 INFO - 'LOGNAME': 'cltbld', 03:16:00 INFO - 'MAIL': '/var/mail/cltbld', 03:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:00 INFO - 'MOZ_NO_REMOTE': '1', 03:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:00 INFO - 'NO_EM_RESTART': '1', 03:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:00 INFO - 'PWD': '/builds/slave/test', 03:16:00 INFO - 'SHELL': '/bin/bash', 03:16:00 INFO - 'SHLVL': '1', 03:16:00 INFO - 'TERM': 'linux', 03:16:00 INFO - 'TMOUT': '86400', 03:16:00 INFO - 'USER': 'cltbld', 03:16:00 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', 03:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:00 INFO - '_': '/tools/buildbot/bin/python'} 03:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:00 INFO - Running setup.py (path:/tmp/pip-8PmDkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:00 INFO - Running setup.py (path:/tmp/pip-Xx0Hdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:00 INFO - Running setup.py (path:/tmp/pip-R9mCzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:00 INFO - Running setup.py (path:/tmp/pip-nnNT5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:00 INFO - Running setup.py (path:/tmp/pip-vGddYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:01 INFO - Running setup.py (path:/tmp/pip-iJzIe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:01 INFO - Running setup.py (path:/tmp/pip-vaxMFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:01 INFO - Running setup.py (path:/tmp/pip-r8B64L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:01 INFO - Running setup.py (path:/tmp/pip-S3QRTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:01 INFO - Running setup.py (path:/tmp/pip-Q5wPGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:01 INFO - Running setup.py (path:/tmp/pip-aJHroI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:01 INFO - Running setup.py (path:/tmp/pip-I5gkaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:01 INFO - Running setup.py (path:/tmp/pip-dMQIfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:01 INFO - Running setup.py (path:/tmp/pip-Lo58kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:01 INFO - Running setup.py (path:/tmp/pip-cOYxEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:01 INFO - Running setup.py (path:/tmp/pip-AYWht6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:01 INFO - Running setup.py (path:/tmp/pip-8mcYyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:16:01 INFO - Running setup.py install for manifestparser 03:16:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:16:02 INFO - Running setup.py install for mozcrash 03:16:02 INFO - Running setup.py install for mozdebug 03:16:02 INFO - Running setup.py install for mozdevice 03:16:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:16:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:16:02 INFO - Running setup.py install for mozfile 03:16:02 INFO - Running setup.py install for mozhttpd 03:16:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:16:02 INFO - Running setup.py install for mozinfo 03:16:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:16:02 INFO - Running setup.py install for mozInstall 03:16:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:16:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:16:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:16:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:16:02 INFO - Running setup.py install for mozleak 03:16:02 INFO - Running setup.py install for mozlog 03:16:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:16:02 INFO - Running setup.py install for moznetwork 03:16:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:16:03 INFO - Running setup.py install for mozprocess 03:16:03 INFO - Running setup.py install for mozprofile 03:16:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:16:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:16:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:16:03 INFO - Running setup.py install for mozrunner 03:16:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:16:03 INFO - Running setup.py install for mozscreenshot 03:16:03 INFO - Running setup.py install for moztest 03:16:03 INFO - Running setup.py install for mozversion 03:16:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:16:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:16:03 INFO - Cleaning up... 03:16:03 INFO - Return code: 0 03:16:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:03 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')]} 03:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:03 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')]} 03:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:03 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 0x7fc04bee3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1583090>, '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 0x15869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586e40>, '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': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', '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 03:16:03 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 03:16:03 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 03:16:03 INFO - Using env: {'DISPLAY': ':0', 03:16:03 INFO - 'HOME': '/home/cltbld', 03:16:03 INFO - 'LANG': 'en_US.UTF-8', 03:16:03 INFO - 'LANGUAGE': 'en_US:en', 03:16:03 INFO - 'LOGNAME': 'cltbld', 03:16:03 INFO - 'MAIL': '/var/mail/cltbld', 03:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:03 INFO - 'MOZ_NO_REMOTE': '1', 03:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:03 INFO - 'NO_EM_RESTART': '1', 03:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:03 INFO - 'PWD': '/builds/slave/test', 03:16:03 INFO - 'SHELL': '/bin/bash', 03:16:03 INFO - 'SHLVL': '1', 03:16:03 INFO - 'TERM': 'linux', 03:16:03 INFO - 'TMOUT': '86400', 03:16:03 INFO - 'USER': 'cltbld', 03:16:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', 03:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:03 INFO - '_': '/tools/buildbot/bin/python'} 03:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:03 INFO - Running setup.py (path:/tmp/pip-zQF79c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:03 INFO - Running setup.py (path:/tmp/pip-dnTO5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:04 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)) 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:04 INFO - Running setup.py (path:/tmp/pip-LLt1xM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:04 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)) 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:04 INFO - Running setup.py (path:/tmp/pip-jGDrfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:04 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)) 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:04 INFO - Running setup.py (path:/tmp/pip-09gkkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:04 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)) 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:04 INFO - Running setup.py (path:/tmp/pip-MdqaAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:04 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)) 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:04 INFO - Running setup.py (path:/tmp/pip-k7Boao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:04 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)) 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:04 INFO - Running setup.py (path:/tmp/pip-mTWVUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:04 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)) 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:04 INFO - Running setup.py (path:/tmp/pip-0Hi4z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:04 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)) 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:04 INFO - Running setup.py (path:/tmp/pip-bCXqi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:04 INFO - Running setup.py (path:/tmp/pip-fysRDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:04 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)) 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:04 INFO - Running setup.py (path:/tmp/pip-Cwwv6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:04 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)) 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:04 INFO - Running setup.py (path:/tmp/pip-2Ms2tW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:04 INFO - Running setup.py (path:/tmp/pip-CHQ9oN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:04 INFO - Running setup.py (path:/tmp/pip-Q7Y1so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:05 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)) 03:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:05 INFO - Running setup.py (path:/tmp/pip-DbCXNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:05 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)) 03:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:05 INFO - Running setup.py (path:/tmp/pip-O35IKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:05 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)) 03:16:05 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)) 03:16:05 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)) 03:16:05 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)) 03:16:05 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)) 03:16:05 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)) 03:16:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:16:05 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 03:16:05 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 03:16:05 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 03:16:05 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 03:16:05 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 03:16:05 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 03:16:07 INFO - Downloading blessings-1.6.tar.gz 03:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:16:07 INFO - Installing collected packages: blessings 03:16:07 INFO - Running setup.py install for blessings 03:16:07 INFO - Successfully installed blessings 03:16:07 INFO - Cleaning up... 03:16:07 INFO - Return code: 0 03:16:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:16:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:07 INFO - Reading from file tmpfile_stdout 03:16:07 INFO - Current package versions: 03:16:07 INFO - argparse == 1.2.1 03:16:07 INFO - blessings == 1.6 03:16:07 INFO - blobuploader == 1.2.4 03:16:07 INFO - docopt == 0.6.1 03:16:07 INFO - functools32 == 3.2.3-2 03:16:07 INFO - jsonschema == 2.5.1 03:16:07 INFO - manifestparser == 1.1 03:16:07 INFO - mozInstall == 1.12 03:16:07 INFO - mozcrash == 0.17 03:16:07 INFO - mozdebug == 0.1 03:16:07 INFO - mozdevice == 0.48 03:16:07 INFO - mozfile == 1.2 03:16:07 INFO - mozhttpd == 0.7 03:16:07 INFO - mozinfo == 0.9 03:16:07 INFO - mozleak == 0.1 03:16:07 INFO - mozlog == 3.3 03:16:07 INFO - moznetwork == 0.27 03:16:07 INFO - mozprocess == 0.23 03:16:07 INFO - mozprofile == 0.28 03:16:07 INFO - mozrunner == 6.12 03:16:07 INFO - mozscreenshot == 0.1 03:16:07 INFO - mozsystemmonitor == 0.3 03:16:07 INFO - moztest == 0.7 03:16:07 INFO - mozversion == 1.4 03:16:07 INFO - psutil == 3.1.1 03:16:07 INFO - requests == 1.2.3 03:16:07 INFO - wsgiref == 0.1.2 03:16:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:07 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 0x7fc04bee3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1583090>, '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 0x15869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586e40>, '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': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', '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 03:16:07 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 03:16:07 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 03:16:07 INFO - Using env: {'DISPLAY': ':0', 03:16:07 INFO - 'HOME': '/home/cltbld', 03:16:07 INFO - 'LANG': 'en_US.UTF-8', 03:16:07 INFO - 'LANGUAGE': 'en_US:en', 03:16:07 INFO - 'LOGNAME': 'cltbld', 03:16:07 INFO - 'MAIL': '/var/mail/cltbld', 03:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:07 INFO - 'MOZ_NO_REMOTE': '1', 03:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:07 INFO - 'NO_EM_RESTART': '1', 03:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:07 INFO - 'PWD': '/builds/slave/test', 03:16:07 INFO - 'SHELL': '/bin/bash', 03:16:07 INFO - 'SHLVL': '1', 03:16:07 INFO - 'TERM': 'linux', 03:16:07 INFO - 'TMOUT': '86400', 03:16:07 INFO - 'USER': 'cltbld', 03:16:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', 03:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:07 INFO - '_': '/tools/buildbot/bin/python'} 03:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:07 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)) 03:16:07 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)) 03:16:07 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)) 03:16:07 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)) 03:16:07 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)) 03:16:07 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)) 03:16:07 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)) 03:16:07 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)) 03:16:07 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)) 03:16:07 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)) 03:16:07 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)) 03:16:07 INFO - Cleaning up... 03:16:07 INFO - Return code: 0 03:16:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:07 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 0x7fc04bee3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1583090>, '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 0x15869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586e40>, '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': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', '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 03:16:07 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 03:16:07 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 03:16:07 INFO - Using env: {'DISPLAY': ':0', 03:16:07 INFO - 'HOME': '/home/cltbld', 03:16:07 INFO - 'LANG': 'en_US.UTF-8', 03:16:07 INFO - 'LANGUAGE': 'en_US:en', 03:16:07 INFO - 'LOGNAME': 'cltbld', 03:16:07 INFO - 'MAIL': '/var/mail/cltbld', 03:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:07 INFO - 'MOZ_NO_REMOTE': '1', 03:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:07 INFO - 'NO_EM_RESTART': '1', 03:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:07 INFO - 'PWD': '/builds/slave/test', 03:16:07 INFO - 'SHELL': '/bin/bash', 03:16:07 INFO - 'SHLVL': '1', 03:16:07 INFO - 'TERM': 'linux', 03:16:07 INFO - 'TMOUT': '86400', 03:16:07 INFO - 'USER': 'cltbld', 03:16:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', 03:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:07 INFO - '_': '/tools/buildbot/bin/python'} 03:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:16:07 INFO - Cleaning up... 03:16:07 INFO - Return code: 0 03:16:07 INFO - Running post-action listener: _resource_record_post_action 03:16:07 INFO - Running post-action listener: _start_resource_monitoring 03:16:07 INFO - Starting resource monitoring. 03:16:08 INFO - [mozharness: 2016-08-17 10:16:08.001738Z] Finished create-virtualenv step (success) 03:16:08 INFO - [mozharness: 2016-08-17 10:16:08.002724Z] Running install step. 03:16:08 INFO - Running pre-action listener: _resource_record_pre_action 03:16:08 INFO - Running main action method: install 03:16:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:08 INFO - Reading from file tmpfile_stdout 03:16:08 INFO - Detecting whether we're running mozinstall >=1.0... 03:16:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:16:08 INFO - Reading from file tmpfile_stdout 03:16:08 INFO - Output received: 03:16:08 INFO - Usage: mozinstall [options] installer 03:16:08 INFO - Options: 03:16:08 INFO - -h, --help show this help message and exit 03:16:08 INFO - -d DEST, --destination=DEST 03:16:08 INFO - Directory to install application into. [default: 03:16:08 INFO - "/builds/slave/test"] 03:16:08 INFO - --app=APP Application being installed. [default: firefox] 03:16:08 INFO - mkdir: /builds/slave/test/build/application 03:16:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:16:24 INFO - Reading from file tmpfile_stdout 03:16:24 INFO - Output received: 03:16:24 INFO - /builds/slave/test/build/application/firefox/firefox 03:16:24 INFO - Running post-action listener: _resource_record_post_action 03:16:24 INFO - [mozharness: 2016-08-17 10:16:24.377979Z] Finished install step (success) 03:16:24 INFO - [mozharness: 2016-08-17 10:16:24.378227Z] Running run-tests step. 03:16:24 INFO - Running pre-action listener: _resource_record_pre_action 03:16:24 INFO - Running main action method: run_tests 03:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:16:24 INFO - Python 2.7.3 03:16:24 INFO - Return code: 0 03:16:24 INFO - grabbing minidump binary from tooltool 03:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:24 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1583090>, '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 0x15869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:16:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:16:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:16:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:16:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:16:24 INFO - Return code: 0 03:16:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:16:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:16:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:16:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:16:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:16:24 INFO - Using env: {'DISPLAY': ':0', 03:16:24 INFO - 'HOME': '/home/cltbld', 03:16:24 INFO - 'LANG': 'en_US.UTF-8', 03:16:24 INFO - 'LANGUAGE': 'en_US:en', 03:16:24 INFO - 'LOGNAME': 'cltbld', 03:16:24 INFO - 'MAIL': '/var/mail/cltbld', 03:16:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:16:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:24 INFO - 'MOZ_NO_REMOTE': '1', 03:16:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:24 INFO - 'NO_EM_RESTART': '1', 03:16:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:24 INFO - 'PWD': '/builds/slave/test', 03:16:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:16:24 INFO - 'SHELL': '/bin/bash', 03:16:24 INFO - 'SHLVL': '1', 03:16:24 INFO - 'TERM': 'linux', 03:16:24 INFO - 'TMOUT': '86400', 03:16:24 INFO - 'USER': 'cltbld', 03:16:24 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471425317.477164-1998930345', 03:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:24 INFO - '_': '/tools/buildbot/bin/python'} 03:16:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:16:24 INFO - mozversion application_buildid: 20160817014415 03:16:24 INFO - mozversion application_changeset: 587a4c621b5f78aece57046bd3a19ab695da14ed 03:16:24 INFO - mozversion application_display_name: Nightly 03:16:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:16:24 INFO - mozversion application_name: Firefox 03:16:24 INFO - mozversion application_remotingname: firefox 03:16:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:16:24 INFO - mozversion application_vendor: Mozilla 03:16:24 INFO - mozversion application_version: 51.0a1 03:16:24 INFO - mozversion platform_buildid: 20160817014415 03:16:24 INFO - mozversion platform_changeset: 587a4c621b5f78aece57046bd3a19ab695da14ed 03:16:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:16:24 INFO - mozversion platform_version: 51.0a1 03:16:24 INFO - using testdate: 1471428984 03:16:24 INFO - actual date: 1471428984 03:16:24 INFO - starting webserver on 'localhost:54630' 03:16:24 INFO - SUITE-START | Running 2 tests 03:16:24 INFO - TEST-START | dromaeo_css 03:16:24 INFO - operating with platform_type : linux_ 03:16:24 INFO - Initialising browser for dromaeo_css test... 03:16:24 INFO - TEST-INFO | started process 3336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIWZ20j/profile http://localhost:54630/getInfo.html) 03:16:31 INFO - PROCESS | 3336 | __metrics Screen width/height:1600/1200 03:16:31 INFO - PROCESS | 3336 | colorDepth:24 03:16:31 INFO - PROCESS | 3336 | Browser inner width/height: 1024/697 03:16:31 INFO - PROCESS | 3336 | __metrics 03:16:31 ERROR - PROCESS | 3336 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 03:16:32 INFO - TEST-INFO | 3336: exit 0 03:16:32 INFO - Browser initialized. 03:16:32 INFO - Running cycle 1/1 for dromaeo_css test... 03:16:32 INFO - TEST-INFO | started process 3454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIWZ20j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:44 INFO - PROCESS | 3454 | RSS: Main: 163479552 03:16:44 INFO - PROCESS | 3454 | 03:17:34 INFO - PROCESS | 3454 | 1471429054189 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] 03:19:47 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:54630/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54630/tests/dromaeo/cssquery-ext.html) 03:19:48 INFO - PROCESS | 3454 | RSS: Main: 165330944 03:19:48 INFO - PROCESS | 3454 | 03:22:51 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:54630/tests/dromaeo/cssquery-ext.html (next: http://localhost:54630/tests/dromaeo/cssquery-jquery.html) 03:22:51 INFO - PROCESS | 3454 | RSS: Main: 165400576 03:22:51 INFO - PROCESS | 3454 | 03:25:53 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:54630/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54630/tests/dromaeo/cssquery-mootools.html) 03:25:54 INFO - PROCESS | 3454 | RSS: Main: 165978112 03:25:54 INFO - PROCESS | 3454 | 03:28:56 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:54630/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54630/tests/dromaeo/cssquery-prototype.html) 03:28:56 INFO - PROCESS | 3454 | RSS: Main: 164159488 03:28:56 INFO - PROCESS | 3454 | 03:31:59 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:54630/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54630/tests/dromaeo/cssquery-yui.html) 03:32:00 INFO - PROCESS | 3454 | RSS: Main: 165404672 03:32:00 INFO - PROCESS | 3454 | 03:35:03 INFO - PROCESS | 3454 | Cycle 1(1): loaded http://localhost:54630/tests/dromaeo/cssquery-yui.html (next: http://localhost:54630/tests/dromaeo/cssquery-dojo.html) 03:35:03 INFO - PROCESS | 3454 | RSS: Main: 166821888 03:35:03 INFO - PROCESS | 3454 | 03:35:03 INFO - PROCESS | 3454 | __start_tp_report 03:35:03 INFO - PROCESS | 3454 | _x_x_mozilla_page_load 03:35:03 INFO - PROCESS | 3454 | _x_x_mozilla_page_load_details 03:35:03 INFO - PROCESS | 3454 | |i|pagename|runs| 03:35:03 INFO - PROCESS | 3454 | |0;dojo.html;2628.1327162036528;2651.2709005023617;2651.602259661049;2659.135780871216;2679.1962411276613;4587.2889702096145;4743.573078422941;4765.737884416356;4797.304390863323;4817.975910120449;4707.811687532503;4717.481077081518;4725.6928299660585;4728.290756386544;4760.642951778613;4287.849925252624;4378.97810510947;4383.780810959455;4420.9336859947125;4492.213862574053;4406.5373135820755;4458.821647134111;4466.0844526871915;4482.8879278017985;4501.504834468205;4174.791260436966;4255.893602659928;4316.48202215733;4316.935245971282;4351.28203846365;4323.697341186118;4330.415393921843;4332.501762297345;4346.739195648272;4411.426514553087;4345.152695224432;4364.214441400547;4378.321360189176;4379.868603941887;4406.823727050914;4725.810967561293;4781.784819683123;4789.664723469358;4793.520647935178;4823.011282687041;5143.254228136937;5148.613853960968;5168.22476628505;5178.792848286064;5217.50433708797;5200.869978250536;5218.191180367011;5218.739063046833;5221.869453263661;5225.346831646044;4601.987562736226;4717.716936983792;4734.384530011076;4739.454962679336;4799.784009719571;5198.0643484173215;5224.346956630421;5229.633925625246;5232.084385232569;5233.031889100528;4977.502249774993;4990.226514890198;4995.225740010304;5014.2979982802435;5043.571296439771;4923.606111511071;5022.824201152942;5069.670471419346;5107.387113546398;5143.639945203875;5085.5168758968575;5106.234064890296;5109.8722531936255;5115.5396014358885;5126.394717476473;5069.087564238473;5070.087384270867;5076.771545280471;5082.542571168613;5083.694978301313;4219.261629214875;4321.006168581244;4342.218400687843;4366.628836548865;4420.624246938982;3771.132639492932;3791.4123310886857;3791.734578579473;3818.4845045919;3824.579296277407;4462.776861156929;4490.2142125127975;4496.820127194941;4498.527654596286;4544.545545445429;4979.3526841510375;5053.797848086109;5104.948950510522;5105.974470127626;5149.871253218625;4386.1008493258805;4390.714603550759;4398.450193725785;4410;4415;4565.703229290086;4566.794494247767;4574.656900732459;4580.610648094883;4648.023914977893;4700.106979673919;4764.071006153767;4793.952060479351;4798.616110711065;4877.463479017376;5131.281620573197;5149.665271757323;5152.149895267239;5158.09733296679;5210.635255532076;4714.858554243378;4804.975975120242;4829.275608658589;4840.1287768200655;4841.080194762983;4941.75291235444;4983.6760610560195;4985.102681517362;4988.625853060962;5043.5712964398435;5027.371578552681;5066.493350664904;5082.33929589151;5103.719295438638;5125.359330083739;4810.062037902575;4942.184539551077;4953.529414705597;4962.779156327612;4968.329275547755;4862.6839255448285;4936.851894443173;4945.653804233669;4967.850964471072;4968.8757781055765;4861.246506791453;4864.343313652612;4899.804007839789;4904.705717656952;4909.77905994224;4905.2151655734915;5002;5011.498850114959;5022.397312322399;5080.415752188545;4832.63755218353;4867.245576935581;4909.729964851825;4919.3358896549935;5000.349954505891 03:35:03 INFO - PROCESS | 3454 | |1;ext.html;531.1209947536827;532.7016870552493;543.1255678357843;557.5149619830748;570.6005795942841;35178.64821351789;38328.80835595825;38343.42484862729;38396.81642978197;38404.61595384049;39239.60760392395;39354;39368.212635747266;39584.20831583367;39693.80153099231;7469.514481558695;7578.924210757877;7619.733309334174;7620.390368770512;7621.504602200867;7639.885401718979;7649.541027538366;7664.961675191616;7701.114371847225;7708.421868359867;7709.845803083935;7715.884261736079;7723.8069048273965;7771.689132434724;7782.416318776086;7688.730894418669;7706.7302644407455;7719.459637825355;7733.6133193340675;7745.7676269712;7601.619919004083;7664.501807382502;7672.386209103258;7674.769756907302;7675.616219189074;36307.4553881692;36573.451398229045;36714.81642591797;36727;36754.08114797125;3034.484137696597;3085.382923415326;3134.2321131322974;3177.7934434261697;3368.5620869286836;28766;29022;29318.70681293181;29544.556831647544;30440.391192176256;3423.726101911866;3496;3527.206378564828;3543.6279190684863;3557.964420355789;180232;180439;180706;180832;180852.09573952178;28281.01016464455;51872;52018;52158.47841521612;52430;30461.23846903801;31693.20766980844;32019.51970720441;32068.679313207034;32222.516662250084;11924.642260732191;11933.28400295985;12014.459349329301;12031.699207519881;12085.335306558223;9640.614375425044;9650.565724542412;9686.75783105414;9702.75743106414;9722.95138524317;7668.309852113337;7737.92262077372;7755.258202199151;7833.490823096595;7838.255365740246;3054.144839444959;3089.6137982752157;3118.6413562440157;3151.684831516876;3152;834.5952213176605;859.9785005374915;922.6217250927087;1004.3672486333563;1029.7837454134565;27783.55467086553;28592.857035715104;28643.28391790222;28704.13887583376;28863;920.2591913509689;926.2821313482106;933.8505839065717;960.596549449233;1023.672424824064;14420.495282665266;15135.848641513665;15156.621084472756;15183.772243416357;15442.305096270695;383480;385967;386511;386607;386836;49345.753271233414;49513.25730114051;49726.751366242934;49845.501544984814;50000;1134.4611309628026;1143.891330323618;1174.1135442740506;1176.2472017908544;1178.8762179971152;26317.60523592186;27557.38204870534;28269.858650706614;28482.430351393272;28789.424211515234;38479.807600961816;38739.612603873604;39127.413088804264;40259;42475.575244247164;321506;323087;324094;324216;325006;25392.365190870376;25548;25655.358616034748;25793.25997730356;25893.09374171895;41641.58358416377;42204.78897605492;43073.7846310779;43168.56831431646;43753.343699845165;36400.04163176698;36651.08372290714;37030.8148459256;37409.251814963005;38253.61746382501;36196;36439.45340819943;36775.632243677224;36894.8155259222;37011.44482832706;35341;35523.82238088793;36083.278334433686;36287.81856090703;36734;31614.683853161176;33317.83341083279;33452.33095338031;33629.3274134511;33844.661553384154;25081;25476.363090922874;25820.483590328466;26176.60735088937;26315.07897223588 03:35:03 INFO - PROCESS | 3454 | |2;jquery.html;361.9185683221274;374.1002888054229;380.89334986203863;381.9915423282536;390.9179072394797;15963.760543591841;16983.06593137377;17023;17091.40180093697;17136;15737.370505179808;15864.254931957475;16447.917760411212;16632.66734665306;16702.164891755394;5061.595072394209;5332.093544097494;5333.2000199969925;5334.333208348957;5340;3343.8328083595843;5192.480751924796;6000.939990600104;6281.528885333595;6300.149479820235;6116.143739876398;6355.30091689916;6366.745330186787;6377.075324078006;6392.584482008655;6077.301110372319;6156.7229474673295;6160.876782464348;6164.198654174974;6169.444749972524;4718.457377401574;4996.975015124901;5278.762455689503;5300.231466437345;5301.814436494704;10844.186685998502;10996;11007.284526505751;11009.394483303415;11021.83467247992;1842.207850624231;1863.7297591849242;1960.402077366417;1965.371081253985;2154.676798480225;9237.49193794341;9280.396774209656;9422.670206542738;9793.21654267657;9875.506224688808;1692.3822804676327;1787.7139657654843;1794.55136215946;1794.883332583378;1815.9092045397676;66012.66993665049;66685;67372.663136684;68168.6591567044;68743.65628171827;9848.655297064568;9978.60085596568;10034.799304013879;10311.48442577868;10337.328073675188;13661.453541858413;13667.589972300846;13709.314534273246;13730.65673358154;13786.65533361674;6971.930280697229;7103.254158313406;7153.320434558708;7432.851342973218;7435.4795164337975;6818.420434263143;6873.931260687429;6999.475039371966;7032.683529241196;7037.5425597337035;4216.873493795191;4335.696501244883;4343.543927887589;4475.1273501666865;4506.076254367847;1617.4581515192308;1754.7280171573427;1796.7035439152655;1834.7254627856314;1869.5980364221757;809.9028116625925;823.8681810910225;831.8627426474563;836.9539675317794;875.5053394832026;15762.005219008352;16605.0867202305;16715.52348373233;17517.386891458736;17701.645967080585;840.399114633028;850.1880703927734;909.6997990663066;911.4804561399939;929.7675581104724;9050.230730387992;9162.954185229164;9201.21789647874;9616.11063643762;9716.465594392235;370101;370293;382727;382962;383999;71766.64116679487;73223.26776732272;75446.24553754502;76162.23837761552;76672;884.2439714044657;922.1378011559214;946.8248374050822;948.3551185193996;949.159993405827;14972.401103955719;15187.253465851569;15550.844491555392;15578.376864925276;15586.688266234385;34764.13089672779;36174.4573831398;36259.274814503035;36541.81729091444;37643;47556;47772.044559109316;47865.5213447875;49096.50903490919;55119.72440137934;6799.286074962058;7257.637118144177;7426.220246874216;7687.654055567625;7765.572893490912;6014.669193194416;7654.502457340255;10904.672859814218;11579.07367410622;11594.94202528982;9417.858732118886;9427.952860235655;9495.715128546155;9755.80488390214;9835;9350.67272645454;10120.190384769054;10257.58969641206;10262.538185781807;10458.372497650165;9211.585478653342;9523.285753568649;9665.468399238109;9932.404055756677;10034.448105354275;7587.962060189884;7664.118626357817;7683.731069412544;7812.453128281193;8004.279614834692;8389.790255243668;9808.65669701557;9866.753331166778;10010.749731256778;10138.847917281395 03:35:03 INFO - PROCESS | 3454 | |3;mootools.html;1128.8588926384202;1137.4824454873033;1272.2303006680959;1366.2622184020622;1391.9582412527616;6907.516473846833;7554.169041405441;7590.354819840307;8184.713535026268;8191.959040204805;7628.466007379486;7937.9206207937905;7939.801504962379;7950.681972721099;7958.801029974254;2149.1188612668807;2169.5010147665967;2171.81539569136;2176.227439259056;2178.1287485005964;2109.4620871677703;2145.871247725134;2208.6686996950425;2208.9005994730196;2210.4968621337566;2086.6765651324067;2091.602595506849;2098.097817938286;2099.6640537514;2141.9464513387134;2082.4689704125426;2090.644590419632;2095.067694875781;2107.589020141073;2112.0706888968803;2047.4778931372405;2102.8107470327745;2109.546447513792;2111.7254756881507;2117.2272120675843;7993.640286187077;8063.879041814377;8064;8064.31453326468;8073.959630201812;4434.312681534368;4567.063751930879;4572.154151481986;4652.232381657022;4654.511276316006;2935.0901220621677;2959.422912532057;2963.6295463067117;3078.722914937644;3082.4605694003685;945.6122989574242;1002.2332915319786;1006.8942761010135;1011.4942528735633;1016.0855230292722;10289.53697083633;10423.583056677724;10430.061294483457;10473.685789426254;10599;4009.599040095967;4268.487781466182;4298.161858437575;4377.255866502638;4384.254676704968;9284.164425201629;9288;9354.345195836362;9354.438733676001;9402.43585384879;4427.690061695715;4464.575865292792;4465.888352791206;4473.619742321874;4491.528389519053;3687.0966613179944;4041.474608300961;4121.216968775923;4136.234796562646;4175.561566035522;3617.186133120027;3643.526341575578;3669.192777588926;3741.2330472253125;3785.470034195215;1192.952281908714;1194.4326444938586;1201.0511695760251;1202.7053371923935;1209.5282839692527;824.8432797768405;843.843888880559;849.9375780274656;866.9436486628349;874.9693760718344;5160.793568257228;5191.2472691459525;5206.8437946860895;5283.181106928432;5468.644538105011;385.24491995688203;386.84139502804277;389.69993105308754;390.3461701649782;392.6485795213325;3464.6708562686504;3605.6754892059316;3610.5125808016105;3712.832922518493;3774.301754175486;9801;10060.195184385379;10073.395596264247;10136.594536218468;10181.847272290921;9933.453660048623;10009.999999999854;10046.246531510165;10062.69811905644;10134.54394552247;7065.328793764585;7347;7488.176300606929;7532.887006694904;7561.962190189014;5464.644798088111;5537.169424586184;5545.972270138624;5552.222688823649;5735.827925162252;9200.631974720936;9255.953720231355;9261.953690231776;9327.486988215713;9364.297677674065;9075.2286055686;9182.816343672956;9361.672341468016;9369.531523423939;9425.528723563932;6057.18228039209;6612.107365505595;6873.931260687529;6888.586684798928;7075.681594328371;7734.187910269341;7745;7750.767476975474;7799.454038217497;7799.961000194962;6548.476121910331;6669.066330713801;6673.099131617364;6785.050092986887;6795;6641.634710090992;6684.16447944007;6718.596884186964;6784.05023296729;6885.311468853075;6522.478201743944;6567.638779867153;6597.934020659924;6600.768973085919;6617.536772425884;4689.624830013522;4725.810967561259;4831.347768051409;4843.104025755247;4898.975505122452;4702.318163866289;4710.4347478302825;4792.209285467999;4854.587360074292;4874.0495603357 03:35:03 INFO - PROCESS | 3454 | |4;prototype.html;293.72830132127774;304.39881234561744;305.89446640908886;309.9705527974842;312.2303521818717;4811.735354555498;4941.60467162627;4942.382202224722;5031.547160755531;5064.569511591514;4928.31003659487;4948.851534453963;4953.207486802113;4955.414267434422;4959.652824302291;3925.5661489876175;3928.3125453045745;3935.291647503448;3939.9803000984957;3947;3666.3034023535574;3930.547986981491;3942.369220924653;3952.6837852971835;3953.9011524711823;3825.3305671507514;3851.1912498375236;3856.113093988384;3857.112864041258;3866.3620502617173;3830.9425358619505;3836.4245363195464;3851.690425255427;3853.845846166178;3865.922681546381;3390.847411866472;3391.16916355492;3392.1858753899132;3394.574278802909;3429.4341433663417;4713.794619658631;4838.661293709441;4859.659823812334;4872.808310556591;4899.7661543381555;4393.648508119343;4396.691736838154;4404.4494438195225;4423.933640995388;4457.551295828868;5215.58275337972;5249.8425047248265;5261.184516399964;5264.499872512105;5293.126634105368;3616.2948225096115;3695.4087346024507;3704.8144593730017;3708.313961917027;3714.220013797106;5436.184572314145;5437;5451.318585176813;5476.028629693307;5517.200005999148;3733.5893051764283;3749.9687585914094;3755.5681096673684;3757.1546402059867;3765.8325918965206;3837.5586807516934;3848.9615103849164;3850;3853.133045064838;3853.420097759905;4310.137972405531;4365.454318210223;4374.693771435969;4377.233984052778;4404.757738324423;5242.947570524322;5243.251075481049;5247.475252474722;5258.421573626898;5288.656237344637;1243.1981372015;1284.8115493168782;1310.7220460051565;1313.9868601314056;1323.5764555342391;858.4248553469191;889.6085722282176;905.2893478619252;913.6665117232295;916.3493919317226;4560.4071470708595;4563.383943167696;4572.9314060289125;4573.222552166139;4587.266037433995;5335.226392173113;5339.131304043632;5348.545373643206;5355.919661205085;5395.865103372447;4367.366731823868;4546.88632784183;4583.449986001701;4596.678232523691;4613.792379342937;2483.255023492945;2490.9875450622994;2510.6234064890414;2516.358328626225;2521.571332873379;4416.845410410684;4443.688941774045;4444.4888837784065;4467.5755803198645;4500.639948804088;4638.628909687217;4786.95213047865;4815.2054910939305;4818.71087734737;4821.831235906727;4345.261305578059;4414.183376075436;4419.359192917009;4437.733735975852;4446.666500012448;4699.271612900006;4707.4821769606;4717.882052948704;4727.290906364073;4739.431268247695;4616.591939458497;4628.375169352229;4634.9536504634525;4661.230896901973;4684.742339171242;4294.377315289328;4412.6249268811225;4433.2241857674135;4436.334549817553;4456.487503936959;3409.846556904995;3415.470602056685;3425.2978139481843;3454.4990976308795;3471.340445315382;4769.422932800399;4782.713037217778;4798;4803.759812009455;5219.634625576173;5078.542931136216;5215.530602245816;5217.556507696737;5237.266782650356;5240.401677488403;5177.922331165111;5211.661242019257;5220.546343218681;5229.966619360837;5252.632315738015;5026.255072002453;5045.772940217626;5097.247486357325;5108.56577190943;5163.767630456563;5235.607329450383;5239.109351410193;5246.921296180484;5252.395974462833;5252.448492908343;5086.491350864884;5140.614453915897;5171.285075335479;5173.198154286091;5174.948250517597 03:35:03 INFO - PROCESS | 3454 | |5;yui.html;633.9175907132073;637.8469167399826;702.6276073680949;702.7154002628937;711.7331000874672;11788.7642247155;12649.93675031626;12704.491820327188;12709.936450317735;12720.936395318022;13039.478420863154;13659.385327660255;13697.452101915911;13962.16227026379;14086.859131408683;770.0643717882772;796.1004065406083;800.0519384529351;800.5276886636883;800.6637212370789;634.4924060751404;759.4114561215048;775.0660454152733;777.9611019449034;790.154534647927;824.0482243009304;824.5671022713094;825.6202147012382;825.8183199696088;828.7969447485375;817.1746535998655;824.1305422778966;824.2499325613693;824.5011767880466;824.8391563645091;597.8684689368332;602.692626760351;602.8553147244629;603.0592276049333;603.6287683074877;12485.250884946932;12495;12539.059570532156;12557.497700091986;12572.874271257262;12231.143819932608;12573.308468034254;12727.554535591209;13026.41381137851;13039.869601304055;9181.540922953825;9199.172074513326;9231.676891308773;9310.627574896997;9853.556589953398;3206.567113439679;3209.8555564999633;3215.565898603682;3231.1098007665546;3370.3259348130473;66790.66604666946;68676.01183810567;68975.65512172457;69665.3033469664;70566;9647.855282170773;9729.367591106555;9736.9026309736;9988;10003.749906252257;18762.812371876378;18764.343247986257;18822.811771882105;18844.811551884304;18946.052697365078;6846.178458584902;6923.411510021705;6995.755148569776;7065.116860392451;7128.07335046451;3612.3678356287546;3663.68858647018;3665.633436656313;3726.1802403471193;3761.8683346082757;2789.4839454700946;2909.47629426701;2973.7620990320725;2975.5239161734453;2979.06159559738;477.62506432450357;478.77258302306126;493.03857477918206;497.2268123068663;499.0916531911885;447.8544473046273;463.2402859310733;465.0721809989026;526.6497778977014;548.4981242163376;6614.140161778938;7045.718171273092;7359.632018399058;8687.609057592423;8691.304695624334;385.6124594782282;427.70274659112243;475.70030880545033;550.1884720037912;596.174298596447;3376.0884561168837;3614.1868079681863;3917.7257591968287;3945.6646185074014;4043.3126368517424;87282.56358718166;93617;96090.03909960951;96252.51873740586;97134;77676;77806;78719.21280787118;79368;80867;62657.68671156706;69904;69979.30020699727;70021;72762;7733.149353570991;7736.187700291388;7890.092639346319;8353.331733461187;8383.95808020956;33629;37002.07494812544;42110.947226319586;43340;44461.555384447034;48153.75923120502;55518;55548.72225638846;55680;62999.6850015747;10264.897351026693;10463.476826158814;10788.244822862323;10929.726756830825;10952.397618131079;10579.94200579936;11396.544138234378;11917.642470725892;12074.939625301817;12191.268523888595;10130.493475326351;10138.290319677846;11206.775864482828;11414.48634811452;11616.186866919572;10969.725756856142;10989.890101098887;11195.216334856483;11355.829662555234;11532.423378830857;10046.397216167054;10292.536835842555;10392.740181495523;10821.729456763329;10905.890941090487;7876.488028278143;8177.895984042316;8206.22040906113;8504.574771261536;9198.724038278862;8381.11998240176;8531.189536993976;8703.173198546128;8796.252318552739;8801.911980880366 03:35:03 INFO - PROCESS | 3454 | __end_tp_report 03:35:03 INFO - PROCESS | 3454 | __start_cc_report 03:35:03 INFO - PROCESS | 3454 | _x_x_mozilla_cycle_collect,364 03:35:03 INFO - PROCESS | 3454 | __end_cc_report 03:35:03 INFO - PROCESS | 3454 | __startTimestamp1471430103682__endTimestamp 03:35:03 INFO - PROCESS | 3454 | 03:35:03 INFO - PROCESS | 3454 | ------- Summary: start ------- 03:35:03 INFO - PROCESS | 3454 | Number of tests: 6 03:35:03 INFO - PROCESS | 3454 | 03:35:03 INFO - PROCESS | 3454 | [#0] dojo.html Cycles:165 Average:4712.90 Median:4829.28 stddev:495.82 (10.3%) stddev-sans-first:469.59 03:35:03 INFO - PROCESS | 3454 | Values: 2628.1 2651.3 2651.6 2659.1 2679.2 4587.3 4743.6 4765.7 4797.3 4818.0 4707.8 4717.5 4725.7 4728.3 4760.6 4287.8 4379.0 4383.8 4420.9 4492.2 4406.5 4458.8 4466.1 4482.9 4501.5 4174.8 4255.9 4316.5 4316.9 4351.3 4323.7 4330.4 4332.5 4346.7 4411.4 4345.2 4364.2 4378.3 4379.9 4406.8 4725.8 4781.8 4789.7 4793.5 4823.0 5143.3 5148.6 5168.2 5178.8 5217.5 5200.9 5218.2 5218.7 5221.9 5225.3 4602.0 4717.7 4734.4 4739.5 4799.8 5198.1 5224.3 5229.6 5232.1 5233.0 4977.5 4990.2 4995.2 5014.3 5043.6 4923.6 5022.8 5069.7 5107.4 5143.6 5085.5 5106.2 5109.9 5115.5 5126.4 5069.1 5070.1 5076.8 5082.5 5083.7 4219.3 4321.0 4342.2 4366.6 4420.6 3771.1 3791.4 3791.7 3818.5 3824.6 4462.8 4490.2 4496.8 4498.5 4544.5 4979.4 5053.8 5104.9 5106.0 5149.9 4386.1 4390.7 4398.5 4410.0 4415.0 4565.7 4566.8 4574.7 4580.6 4648.0 4700.1 4764.1 4794.0 4798.6 4877.5 5131.3 5149.7 5152.1 5158.1 5210.6 4714.9 4805.0 4829.3 4840.1 4841.1 4941.8 4983.7 4985.1 4988.6 5043.6 5027.4 5066.5 5082.3 5103.7 5125.4 4810.1 4942.2 4953.5 4962.8 4968.3 4862.7 4936.9 4945.7 4967.9 4968.9 4861.2 4864.3 4899.8 4904.7 4909.8 4905.2 5002.0 5011.5 5022.4 5080.4 4832.6 4867.2 4909.7 4919.3 5000.3 03:35:03 INFO - PROCESS | 3454 | 03:35:03 INFO - PROCESS | 3454 | [#1] ext.html Cycles:180 Average:44213.09 Median:36720.91 stddev:81734.47 (222.6%) stddev-sans-first:81897.96 03:35:03 INFO - PROCESS | 3454 | Values: 531.1 532.7 543.1 557.5 570.6 35178.6 38328.8 38343.4 38396.8 38404.6 39239.6 39354.0 39368.2 39584.2 39693.8 7469.5 7578.9 7619.7 7620.4 7621.5 7639.9 7649.5 7665.0 7701.1 7708.4 7709.8 7715.9 7723.8 7771.7 7782.4 7688.7 7706.7 7719.5 7733.6 7745.8 7601.6 7664.5 7672.4 7674.8 7675.6 36307.5 36573.5 36714.8 36727.0 36754.1 3034.5 3085.4 3134.2 3177.8 3368.6 28766.0 29022.0 29318.7 29544.6 30440.4 3423.7 3496.0 3527.2 3543.6 3558.0 180232.0 180439.0 180706.0 180832.0 180852.1 28281.0 51872.0 52018.0 52158.5 52430.0 30461.2 31693.2 32019.5 32068.7 32222.5 11924.6 11933.3 12014.5 12031.7 12085.3 9640.6 9650.6 9686.8 9702.8 9723.0 7668.3 7737.9 7755.3 7833.5 7838.3 3054.1 3089.6 3118.6 3151.7 3152.0 834.6 860.0 922.6 1004.4 1029.8 27783.6 28592.9 28643.3 28704.1 28863.0 920.3 926.3 933.9 960.6 1023.7 14420.5 15135.8 15156.6 15183.8 15442.3 383480.0 385967.0 386511.0 386607.0 386836.0 49345.8 49513.3 49726.8 49845.5 50000.0 1134.5 1143.9 1174.1 1176.2 1178.9 26317.6 27557.4 28269.9 28482.4 28789.4 38479.8 38739.6 39127.4 40259.0 42475.6 321506.0 323087.0 324094.0 324216.0 325006.0 25392.4 25548.0 25655.4 25793.3 25893.1 41641.6 42204.8 43073.8 43168.6 43753.3 36400.0 36651.1 37030.8 37409.3 38253.6 36196.0 36439.5 36775.6 36894.8 37011.4 35341.0 35523.8 36083.3 36287.8 36734.0 31614.7 33317.8 33452.3 33629.3 33844.7 25081.0 25476.4 25820.5 26176.6 26315.1 03:35:03 INFO - PROCESS | 3454 | 03:35:03 INFO - PROCESS | 3454 | [#2] jquery.html Cycles:180 Average:23441.57 Median:5332.65 stddev:62444.27 (1171.0%) stddev-sans-first:62595.40 03:35:03 INFO - PROCESS | 3454 | Values: 361.9 374.1 380.9 382.0 390.9 15963.8 16983.1 17023.0 17091.4 17136.0 15737.4 15864.3 16447.9 16632.7 16702.2 5061.6 5332.1 5333.2 5334.3 5340.0 3343.8 5192.5 6000.9 6281.5 6300.1 6116.1 6355.3 6366.7 6377.1 6392.6 6077.3 6156.7 6160.9 6164.2 6169.4 4718.5 4997.0 5278.8 5300.2 5301.8 10844.2 10996.0 11007.3 11009.4 11021.8 1842.2 1863.7 1960.4 1965.4 2154.7 9237.5 9280.4 9422.7 9793.2 9875.5 1692.4 1787.7 1794.6 1794.9 1815.9 66012.7 66685.0 67372.7 68168.7 68743.7 9848.7 9978.6 10034.8 10311.5 10337.3 13661.5 13667.6 13709.3 13730.7 13786.7 6971.9 7103.3 7153.3 7432.9 7435.5 6818.4 6873.9 6999.5 7032.7 7037.5 4216.9 4335.7 4343.5 4475.1 4506.1 1617.5 1754.7 1796.7 1834.7 1869.6 809.9 823.9 831.9 837.0 875.5 15762.0 16605.1 16715.5 17517.4 17701.6 840.4 850.2 909.7 911.5 929.8 9050.2 9163.0 9201.2 9616.1 9716.5 370101.0 370293.0 382727.0 382962.0 383999.0 71766.6 73223.3 75446.2 76162.2 76672.0 884.2 922.1 946.8 948.4 949.2 14972.4 15187.3 15550.8 15578.4 15586.7 34764.1 36174.5 36259.3 36541.8 37643.0 47556.0 47772.0 47865.5 49096.5 55119.7 6799.3 7257.6 7426.2 7687.7 7765.6 6014.7 7654.5 10904.7 11579.1 11594.9 9417.9 9428.0 9495.7 9755.8 9835.0 9350.7 10120.2 10257.6 10262.5 10458.4 9211.6 9523.3 9665.5 9932.4 10034.4 7588.0 7664.1 7683.7 7812.5 8004.3 8389.8 9808.7 9866.8 10010.7 10138.8 03:35:03 INFO - PROCESS | 3454 | 03:35:03 INFO - PROCESS | 3454 | [#3] mootools.html Cycles:180 Average:5204.53 Median:4653.37 stddev:2983.99 (64.1%) stddev-sans-first:2976.63 03:35:03 INFO - PROCESS | 3454 | Values: 1128.9 1137.5 1272.2 1366.3 1392.0 6907.5 7554.2 7590.4 8184.7 8192.0 7628.5 7937.9 7939.8 7950.7 7958.8 2149.1 2169.5 2171.8 2176.2 2178.1 2109.5 2145.9 2208.7 2208.9 2210.5 2086.7 2091.6 2098.1 2099.7 2141.9 2082.5 2090.6 2095.1 2107.6 2112.1 2047.5 2102.8 2109.5 2111.7 2117.2 7993.6 8063.9 8064.0 8064.3 8074.0 4434.3 4567.1 4572.2 4652.2 4654.5 2935.1 2959.4 2963.6 3078.7 3082.5 945.6 1002.2 1006.9 1011.5 1016.1 10289.5 10423.6 10430.1 10473.7 10599.0 4009.6 4268.5 4298.2 4377.3 4384.3 9284.2 9288.0 9354.3 9354.4 9402.4 4427.7 4464.6 4465.9 4473.6 4491.5 3687.1 4041.5 4121.2 4136.2 4175.6 3617.2 3643.5 3669.2 3741.2 3785.5 1193.0 1194.4 1201.1 1202.7 1209.5 824.8 843.8 849.9 866.9 875.0 5160.8 5191.2 5206.8 5283.2 5468.6 385.2 386.8 389.7 390.3 392.6 3464.7 3605.7 3610.5 3712.8 3774.3 9801.0 10060.2 10073.4 10136.6 10181.8 9933.5 10010.0 10046.2 10062.7 10134.5 7065.3 7347.0 7488.2 7532.9 7562.0 5464.6 5537.2 5546.0 5552.2 5735.8 9200.6 9256.0 9262.0 9327.5 9364.3 9075.2 9182.8 9361.7 9369.5 9425.5 6057.2 6612.1 6873.9 6888.6 7075.7 7734.2 7745.0 7750.8 7799.5 7800.0 6548.5 6669.1 6673.1 6785.1 6795.0 6641.6 6684.2 6718.6 6784.1 6885.3 6522.5 6567.6 6597.9 6600.8 6617.5 4689.6 4725.8 4831.3 4843.1 4899.0 4702.3 4710.4 4792.2 4854.6 4874.0 03:35:03 INFO - PROCESS | 3454 | 03:35:03 INFO - PROCESS | 3454 | [#4] prototype.html Cycles:180 Average:4189.09 Median:4578.34 stddev:1216.26 (26.6%) stddev-sans-first:1184.01 03:35:03 INFO - PROCESS | 3454 | Values: 293.7 304.4 305.9 310.0 312.2 4811.7 4941.6 4942.4 5031.5 5064.6 4928.3 4948.9 4953.2 4955.4 4959.7 3925.6 3928.3 3935.3 3940.0 3947.0 3666.3 3930.5 3942.4 3952.7 3953.9 3825.3 3851.2 3856.1 3857.1 3866.4 3830.9 3836.4 3851.7 3853.8 3865.9 3390.8 3391.2 3392.2 3394.6 3429.4 4713.8 4838.7 4859.7 4872.8 4899.8 4393.6 4396.7 4404.4 4423.9 4457.6 5215.6 5249.8 5261.2 5264.5 5293.1 3616.3 3695.4 3704.8 3708.3 3714.2 5436.2 5437.0 5451.3 5476.0 5517.2 3733.6 3750.0 3755.6 3757.2 3765.8 3837.6 3849.0 3850.0 3853.1 3853.4 4310.1 4365.5 4374.7 4377.2 4404.8 5242.9 5243.3 5247.5 5258.4 5288.7 1243.2 1284.8 1310.7 1314.0 1323.6 858.4 889.6 905.3 913.7 916.3 4560.4 4563.4 4572.9 4573.2 4587.3 5335.2 5339.1 5348.5 5355.9 5395.9 4367.4 4546.9 4583.4 4596.7 4613.8 2483.3 2491.0 2510.6 2516.4 2521.6 4416.8 4443.7 4444.5 4467.6 4500.6 4638.6 4787.0 4815.2 4818.7 4821.8 4345.3 4414.2 4419.4 4437.7 4446.7 4699.3 4707.5 4717.9 4727.3 4739.4 4616.6 4628.4 4635.0 4661.2 4684.7 4294.4 4412.6 4433.2 4436.3 4456.5 3409.8 3415.5 3425.3 3454.5 3471.3 4769.4 4782.7 4798.0 4803.8 5219.6 5078.5 5215.5 5217.6 5237.3 5240.4 5177.9 5211.7 5220.5 5230.0 5252.6 5026.3 5045.8 5097.2 5108.6 5163.8 5235.6 5239.1 5246.9 5252.4 5252.4 5086.5 5140.6 5171.3 5173.2 5174.9 03:35:03 INFO - PROCESS | 3454 | 03:35:03 INFO - PROCESS | 3454 | [#5] yui.html Cycles:180 Average:16953.39 Median:28034.09 stddev:24328.15 (86.8%) stddev-sans-first:24365.54 03:35:03 INFO - PROCESS | 3454 | Values: 633.9 637.8 702.6 702.7 711.7 11788.8 12649.9 12704.5 12709.9 12720.9 13039.5 13659.4 13697.5 13962.2 14086.9 770.1 796.1 800.1 800.5 800.7 634.5 759.4 775.1 778.0 790.2 824.0 824.6 825.6 825.8 828.8 817.2 824.1 824.2 824.5 824.8 597.9 602.7 602.9 603.1 603.6 12485.3 12495.0 12539.1 12557.5 12572.9 12231.1 12573.3 12727.6 13026.4 13039.9 9181.5 9199.2 9231.7 9310.6 9853.6 3206.6 3209.9 3215.6 3231.1 3370.3 66790.7 68676.0 68975.7 69665.3 70566.0 9647.9 9729.4 9736.9 9988.0 10003.7 18762.8 18764.3 18822.8 18844.8 18946.1 6846.2 6923.4 6995.8 7065.1 7128.1 3612.4 3663.7 3665.6 3726.2 3761.9 2789.5 2909.5 2973.8 2975.5 2979.1 477.6 478.8 493.0 497.2 499.1 447.9 463.2 465.1 526.6 548.5 6614.1 7045.7 7359.6 8687.6 8691.3 385.6 427.7 475.7 550.2 596.2 3376.1 3614.2 3917.7 3945.7 4043.3 87282.6 93617.0 96090.0 96252.5 97134.0 77676.0 77806.0 78719.2 79368.0 80867.0 62657.7 69904.0 69979.3 70021.0 72762.0 7733.1 7736.2 7890.1 8353.3 8384.0 33629.0 37002.1 42110.9 43340.0 44461.6 48153.8 55518.0 55548.7 55680.0 62999.7 10264.9 10463.5 10788.2 10929.7 10952.4 10579.9 11396.5 11917.6 12074.9 12191.3 10130.5 10138.3 11206.8 11414.5 11616.2 10969.7 10989.9 11195.2 11355.8 11532.4 10046.4 10292.5 10392.7 10821.7 10905.9 7876.5 8177.9 8206.2 8504.6 9198.7 8381.1 8531.2 8703.2 8796.3 8801.9 03:35:03 INFO - PROCESS | 3454 | -------- Summary: end -------- 03:35:03 INFO - PROCESS | 3454 | 03:35:04 INFO - TEST-INFO | 3454: exit 0 03:35:04 INFO - TEST-OK | dromaeo_css | took 1119674ms 03:35:04 INFO - TEST-START | kraken 03:35:04 INFO - operating with platform_type : linux_ 03:35:04 INFO - Initialising browser for kraken test... 03:35:04 INFO - TEST-INFO | started process 3811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprf8cNZ/profile http://localhost:54630/getInfo.html) 03:35:09 INFO - PROCESS | 3811 | __metrics Screen width/height:1600/1200 03:35:09 INFO - PROCESS | 3811 | colorDepth:24 03:35:09 INFO - PROCESS | 3811 | Browser inner width/height: 1024/697 03:35:09 INFO - PROCESS | 3811 | __metrics 03:35:09 ERROR - PROCESS | 3811 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 03:35:10 INFO - TEST-INFO | 3811: exit 0 03:35:10 INFO - Browser initialized. 03:35:10 INFO - Running cycle 1/1 for kraken test... 03:35:10 INFO - TEST-INFO | started process 3930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprf8cNZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:22 INFO - PROCESS | 3930 | RSS: Main: 163729408 03:35:22 INFO - PROCESS | 3930 | 03:35:25 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:54630/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54630/tests/kraken/driver.html?testName=audio-beat-detection) 03:35:26 INFO - PROCESS | 3930 | RSS: Main: 168886272 03:35:26 INFO - PROCESS | 3930 | 03:35:28 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:54630/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54630/tests/kraken/driver.html?testName=audio-dft) 03:35:29 INFO - PROCESS | 3930 | RSS: Main: 168632320 03:35:29 INFO - PROCESS | 3930 | 03:35:32 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:54630/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54630/tests/kraken/driver.html?testName=audio-fft) 03:35:33 INFO - PROCESS | 3930 | RSS: Main: 164282368 03:35:33 INFO - PROCESS | 3930 | 03:35:35 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:54630/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54630/tests/kraken/driver.html?testName=audio-oscillator) 03:35:35 INFO - PROCESS | 3930 | RSS: Main: 164892672 03:35:35 INFO - PROCESS | 3930 | 03:35:38 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:54630/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54630/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:35:38 INFO - PROCESS | 3930 | RSS: Main: 165171200 03:35:38 INFO - PROCESS | 3930 | 03:35:41 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:54630/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54630/tests/kraken/driver.html?testName=imaging-darkroom) 03:35:42 INFO - PROCESS | 3930 | RSS: Main: 165548032 03:35:42 INFO - PROCESS | 3930 | 03:35:46 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:54630/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54630/tests/kraken/driver.html?testName=imaging-desaturate) 03:35:46 INFO - PROCESS | 3930 | RSS: Main: 162725888 03:35:46 INFO - PROCESS | 3930 | 03:35:49 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:54630/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54630/tests/kraken/driver.html?testName=json-parse-financial) 03:35:50 INFO - PROCESS | 3930 | RSS: Main: 164536320 03:35:50 INFO - PROCESS | 3930 | 03:35:52 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:54630/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54630/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:35:52 INFO - PROCESS | 3930 | RSS: Main: 164491264 03:35:52 INFO - PROCESS | 3930 | 03:35:54 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:54630/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54630/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:35:55 INFO - PROCESS | 3930 | RSS: Main: 164651008 03:35:55 INFO - PROCESS | 3930 | 03:35:57 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:54630/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54630/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:35:58 INFO - PROCESS | 3930 | RSS: Main: 164564992 03:35:58 INFO - PROCESS | 3930 | 03:36:01 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:54630/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:36:01 INFO - PROCESS | 3930 | RSS: Main: 164962304 03:36:01 INFO - PROCESS | 3930 | 03:36:04 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:54630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:36:05 INFO - PROCESS | 3930 | RSS: Main: 164974592 03:36:05 INFO - PROCESS | 3930 | 03:36:07 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:54630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54630/tests/kraken/driver.html?testName=ai-astar) 03:36:07 INFO - PROCESS | 3930 | RSS: Main: 165961728 03:36:07 INFO - PROCESS | 3930 | 03:36:07 INFO - PROCESS | 3930 | __start_tp_report 03:36:07 INFO - PROCESS | 3930 | _x_x_mozilla_page_load 03:36:07 INFO - PROCESS | 3930 | _x_x_mozilla_page_load_details 03:36:07 INFO - PROCESS | 3930 | |i|pagename|runs| 03:36:07 INFO - PROCESS | 3930 | |0;ai-astar;107;120;114;116;115;115;121;118;116;115 03:36:07 INFO - PROCESS | 3930 | |1;audio-beat-detection;146;125;145;189;131;152;154;123;180;125 03:36:07 INFO - PROCESS | 3930 | |2;audio-dft;164;163;166;178;166;162;165;162;165;165 03:36:07 INFO - PROCESS | 3930 | |3;audio-fft;79;75;76;174;77;77;77;77;151;76 03:36:07 INFO - PROCESS | 3930 | |4;audio-oscillator;89;87;144;88;87;88;136;88;88;150 03:36:07 INFO - PROCESS | 3930 | |5;imaging-gaussian-blur;121;118;117;120;118;118;118;118;117;118 03:36:07 INFO - PROCESS | 3930 | |6;imaging-darkroom;148;148;151;147;148;149;148;148;149;149 03:36:07 INFO - PROCESS | 3930 | |7;imaging-desaturate;96;102;96;95;96;96;95;95;96;100 03:36:07 INFO - PROCESS | 3930 | |8;json-parse-financial;67;65;70;66;65;70;69;67;66;70 03:36:07 INFO - PROCESS | 3930 | |9;json-stringify-tinderbox;69;66;67;66;66;66;66;70;67;66 03:36:07 INFO - PROCESS | 3930 | |10;stanford-crypto-aes;92;90;84;85;84;83;86;87;83;83 03:36:07 INFO - PROCESS | 3930 | |11;stanford-crypto-ccm;137;140;142;136;138;135;138;138;160;145 03:36:07 INFO - PROCESS | 3930 | |12;stanford-crypto-pbkdf2;175;178;172;177;173;172;172;174;173;172 03:36:07 INFO - PROCESS | 3930 | |13;stanford-crypto-sha256-iterative;71;71;73;71;69;69;71;68;70;68 03:36:07 INFO - PROCESS | 3930 | __end_tp_report 03:36:07 INFO - PROCESS | 3930 | __start_cc_report 03:36:07 INFO - PROCESS | 3930 | _x_x_mozilla_cycle_collect,938 03:36:07 INFO - PROCESS | 3930 | __end_cc_report 03:36:07 INFO - PROCESS | 3930 | __startTimestamp1471430167424__endTimestamp 03:36:07 INFO - PROCESS | 3930 | 03:36:07 INFO - PROCESS | 3930 | ------- Summary: start ------- 03:36:07 INFO - PROCESS | 3930 | Number of tests: 14 03:36:07 INFO - PROCESS | 3930 | 03:36:07 INFO - PROCESS | 3930 | [#0] ai-astar Cycles:10 Average:115.70 Median:116.00 stddev:3.83 (3.3%) stddev-sans-first:2.45 03:36:07 INFO - PROCESS | 3930 | Values: 107.0 120.0 114.0 116.0 115.0 115.0 121.0 118.0 116.0 115.0 03:36:07 INFO - PROCESS | 3930 | 03:36:07 INFO - PROCESS | 3930 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:149.00 stddev:22.93 (15.4%) stddev-sans-first:24.32 03:36:07 INFO - PROCESS | 3930 | Values: 146.0 125.0 145.0 189.0 131.0 152.0 154.0 123.0 180.0 125.0 03:36:07 INFO - PROCESS | 3930 | 03:36:07 INFO - PROCESS | 3930 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.00 stddev:4.60 (2.8%) stddev-sans-first:4.84 03:36:07 INFO - PROCESS | 3930 | Values: 164.0 163.0 166.0 178.0 166.0 162.0 165.0 162.0 165.0 165.0 03:36:07 INFO - PROCESS | 3930 | 03:36:07 INFO - PROCESS | 3930 | [#3] audio-fft Cycles:10 Average:93.90 Median:77.00 stddev:36.57 (47.5%) stddev-sans-first:38.39 03:36:07 INFO - PROCESS | 3930 | Values: 79.0 75.0 76.0 174.0 77.0 77.0 77.0 77.0 151.0 76.0 03:36:07 INFO - PROCESS | 3930 | 03:36:07 INFO - PROCESS | 3930 | [#4] audio-oscillator Cycles:10 Average:104.50 Median:88.00 stddev:27.01 (30.7%) stddev-sans-first:28.06 03:36:07 INFO - PROCESS | 3930 | Values: 89.0 87.0 144.0 88.0 87.0 88.0 136.0 88.0 88.0 150.0 03:36:07 INFO - PROCESS | 3930 | 03:36:07 INFO - PROCESS | 3930 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:1.25 (1.1%) stddev-sans-first:0.87 03:36:07 INFO - PROCESS | 3930 | Values: 121.0 118.0 117.0 120.0 118.0 118.0 118.0 118.0 117.0 118.0 03:36:07 INFO - PROCESS | 3930 | 03:36:07 INFO - PROCESS | 3930 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 03:36:07 INFO - PROCESS | 3930 | Values: 148.0 148.0 151.0 147.0 148.0 149.0 148.0 148.0 149.0 149.0 03:36:07 INFO - PROCESS | 3930 | 03:36:07 INFO - PROCESS | 3930 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:2.36 (2.5%) stddev-sans-first:2.49 03:36:07 INFO - PROCESS | 3930 | Values: 96.0 102.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 100.0 03:36:07 INFO - PROCESS | 3930 | 03:36:07 INFO - PROCESS | 3930 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:68.00 stddev:2.07 (3.0%) stddev-sans-first:2.19 03:36:07 INFO - PROCESS | 3930 | Values: 67.0 65.0 70.0 66.0 65.0 70.0 69.0 67.0 66.0 70.0 03:36:07 INFO - PROCESS | 3930 | 03:36:07 INFO - PROCESS | 3930 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:66.50 stddev:1.45 (2.2%) stddev-sans-first:1.32 03:36:07 INFO - PROCESS | 3930 | Values: 69.0 66.0 67.0 66.0 66.0 66.0 66.0 70.0 67.0 66.0 03:36:07 INFO - PROCESS | 3930 | 03:36:07 INFO - PROCESS | 3930 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.50 stddev:3.13 (3.7%) stddev-sans-first:2.35 03:36:07 INFO - PROCESS | 3930 | Values: 92.0 90.0 84.0 85.0 84.0 83.0 86.0 87.0 83.0 83.0 03:36:07 INFO - PROCESS | 3930 | 03:36:07 INFO - PROCESS | 3930 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:139.00 stddev:7.32 (5.3%) stddev-sans-first:7.63 03:36:07 INFO - PROCESS | 3930 | Values: 137.0 140.0 142.0 136.0 138.0 135.0 138.0 138.0 160.0 145.0 03:36:07 INFO - PROCESS | 3930 | 03:36:07 INFO - PROCESS | 3930 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:173.50 stddev:2.20 (1.3%) stddev-sans-first:2.29 03:36:07 INFO - PROCESS | 3930 | Values: 175.0 178.0 172.0 177.0 173.0 172.0 172.0 174.0 173.0 172.0 03:36:07 INFO - PROCESS | 3930 | 03:36:07 INFO - PROCESS | 3930 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:71.00 stddev:1.60 (2.2%) stddev-sans-first:1.66 03:36:07 INFO - PROCESS | 3930 | Values: 71.0 71.0 73.0 71.0 69.0 69.0 71.0 68.0 70.0 68.0 03:36:07 INFO - PROCESS | 3930 | -------- Summary: end -------- 03:36:07 INFO - PROCESS | 3930 | 03:36:08 INFO - TEST-INFO | 3930: exit 0 03:36:08 INFO - TEST-OK | kraken | took 64032ms 03:36:08 INFO - SUITE-END | took 1183s 03:36:08 INFO - Completed test suite (00:19:43) 03:36:08 INFO - javascript benchmark 03:36:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6233.782927117615, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2628.1327162036528, 2651.2709005023617, 2651.602259661049, 2659.135780871216, 2679.1962411276613, 4587.2889702096145, 4743.573078422941, 4765.737884416356, 4797.304390863323, 4817.975910120449, 4707.811687532503, 4717.481077081518, 4725.6928299660585, 4728.290756386544, 4760.642951778613, 4287.849925252624, 4378.97810510947, 4383.780810959455, 4420.9336859947125, 4492.213862574053, 4406.5373135820755, 4458.821647134111, 4466.0844526871915, 4482.8879278017985, 4501.504834468205, 4174.791260436966, 4255.893602659928, 4316.48202215733, 4316.935245971282, 4351.28203846365, 4323.697341186118, 4330.415393921843, 4332.501762297345, 4346.739195648272, 4411.426514553087, 4345.152695224432, 4364.214441400547, 4378.321360189176, 4379.868603941887, 4406.823727050914, 4725.810967561293, 4781.784819683123, 4789.664723469358, 4793.520647935178, 4823.011282687041, 5143.254228136937, 5148.613853960968, 5168.22476628505, 5178.792848286064, 5217.50433708797, 5200.869978250536, 5218.191180367011, 5218.739063046833, 5221.869453263661, 5225.346831646044, 4601.987562736226, 4717.716936983792, 4734.384530011076, 4739.454962679336, 4799.784009719571, 5198.0643484173215, 5224.346956630421, 5229.633925625246, 5232.084385232569, 5233.031889100528, 4977.502249774993, 4990.226514890198, 4995.225740010304, 5014.2979982802435, 5043.571296439771, 4923.606111511071, 5022.824201152942, 5069.670471419346, 5107.387113546398, 5143.639945203875, 5085.5168758968575, 5106.234064890296, 5109.8722531936255, 5115.5396014358885, 5126.394717476473, 5069.087564238473, 5070.087384270867, 5076.771545280471, 5082.542571168613, 5083.694978301313, 4219.261629214875, 4321.006168581244, 4342.218400687843, 4366.628836548865, 4420.624246938982, 3771.132639492932, 3791.4123310886857, 3791.734578579473, 3818.4845045919, 3824.579296277407, 4462.776861156929, 4490.2142125127975, 4496.820127194941, 4498.527654596286, 4544.545545445429, 4979.3526841510375, 5053.797848086109, 5104.948950510522, 5105.974470127626, 5149.871253218625, 4386.1008493258805, 4390.714603550759, 4398.450193725785, 4410.0, 4415.0, 4565.703229290086, 4566.794494247767, 4574.656900732459, 4580.610648094883, 4648.023914977893, 4700.106979673919, 4764.071006153767, 4793.952060479351, 4798.616110711065, 4877.463479017376, 5131.281620573197, 5149.665271757323, 5152.149895267239, 5158.09733296679, 5210.635255532076, 4714.858554243378, 4804.975975120242, 4829.275608658589, 4840.1287768200655, 4841.080194762983, 4941.75291235444, 4983.6760610560195, 4985.102681517362, 4988.625853060962, 5043.5712964398435, 5027.371578552681, 5066.493350664904, 5082.33929589151, 5103.719295438638, 5125.359330083739, 4810.062037902575, 4942.184539551077, 4953.529414705597, 4962.779156327612, 4968.329275547755, 4862.6839255448285, 4936.851894443173, 4945.653804233669, 4967.850964471072, 4968.8757781055765, 4861.246506791453, 4864.343313652612, 4899.804007839789, 4904.705717656952, 4909.77905994224, 4905.2151655734915, 5002.0, 5011.498850114959, 5022.397312322399, 5080.415752188545, 4832.63755218353, 4867.245576935581, 4909.729964851825, 4919.3358896549935, 5000.349954505891], "value": 4681.082570470285, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.1209947536827, 532.7016870552493, 543.1255678357843, 557.5149619830748, 570.6005795942841, 35178.64821351789, 38328.80835595825, 38343.42484862729, 38396.81642978197, 38404.61595384049, 39239.60760392395, 39354.0, 39368.212635747266, 39584.20831583367, 39693.80153099231, 7469.514481558695, 7578.924210757877, 7619.733309334174, 7620.390368770512, 7621.504602200867, 7639.885401718979, 7649.541027538366, 7664.961675191616, 7701.114371847225, 7708.421868359867, 7709.845803083935, 7715.884261736079, 7723.8069048273965, 7771.689132434724, 7782.416318776086, 7688.730894418669, 7706.7302644407455, 7719.459637825355, 7733.6133193340675, 7745.7676269712, 7601.619919004083, 7664.501807382502, 7672.386209103258, 7674.769756907302, 7675.616219189074, 36307.4553881692, 36573.451398229045, 36714.81642591797, 36727.0, 36754.08114797125, 3034.484137696597, 3085.382923415326, 3134.2321131322974, 3177.7934434261697, 3368.5620869286836, 28766.0, 29022.0, 29318.70681293181, 29544.556831647544, 30440.391192176256, 3423.726101911866, 3496.0, 3527.206378564828, 3543.6279190684863, 3557.964420355789, 180232.0, 180439.0, 180706.0, 180832.0, 180852.09573952178, 28281.01016464455, 51872.0, 52018.0, 52158.47841521612, 52430.0, 30461.23846903801, 31693.20766980844, 32019.51970720441, 32068.679313207034, 32222.516662250084, 11924.642260732191, 11933.28400295985, 12014.459349329301, 12031.699207519881, 12085.335306558223, 9640.614375425044, 9650.565724542412, 9686.75783105414, 9702.75743106414, 9722.95138524317, 7668.309852113337, 7737.92262077372, 7755.258202199151, 7833.490823096595, 7838.255365740246, 3054.144839444959, 3089.6137982752157, 3118.6413562440157, 3151.684831516876, 3152.0, 834.5952213176605, 859.9785005374915, 922.6217250927087, 1004.3672486333563, 1029.7837454134565, 27783.55467086553, 28592.857035715104, 28643.28391790222, 28704.13887583376, 28863.0, 920.2591913509689, 926.2821313482106, 933.8505839065717, 960.596549449233, 1023.672424824064, 14420.495282665266, 15135.848641513665, 15156.621084472756, 15183.772243416357, 15442.305096270695, 383480.0, 385967.0, 386511.0, 386607.0, 386836.0, 49345.753271233414, 49513.25730114051, 49726.751366242934, 49845.501544984814, 50000.0, 1134.4611309628026, 1143.891330323618, 1174.1135442740506, 1176.2472017908544, 1178.8762179971152, 26317.60523592186, 27557.38204870534, 28269.858650706614, 28482.430351393272, 28789.424211515234, 38479.807600961816, 38739.612603873604, 39127.413088804264, 40259.0, 42475.575244247164, 321506.0, 323087.0, 324094.0, 324216.0, 325006.0, 25392.365190870376, 25548.0, 25655.358616034748, 25793.25997730356, 25893.09374171895, 41641.58358416377, 42204.78897605492, 43073.7846310779, 43168.56831431646, 43753.343699845165, 36400.04163176698, 36651.08372290714, 37030.8148459256, 37409.251814963005, 38253.61746382501, 36196.0, 36439.45340819943, 36775.632243677224, 36894.8155259222, 37011.44482832706, 35341.0, 35523.82238088793, 36083.278334433686, 36287.81856090703, 36734.0, 31614.683853161176, 33317.83341083279, 33452.33095338031, 33629.3274134511, 33844.661553384154, 25081.0, 25476.363090922874, 25820.483590328466, 26176.60735088937, 26315.07897223588], "value": 16097.645461481881, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.9185683221274, 374.1002888054229, 380.89334986203863, 381.9915423282536, 390.9179072394797, 15963.760543591841, 16983.06593137377, 17023.0, 17091.40180093697, 17136.0, 15737.370505179808, 15864.254931957475, 16447.917760411212, 16632.66734665306, 16702.164891755394, 5061.595072394209, 5332.093544097494, 5333.2000199969925, 5334.333208348957, 5340.0, 3343.8328083595843, 5192.480751924796, 6000.939990600104, 6281.528885333595, 6300.149479820235, 6116.143739876398, 6355.30091689916, 6366.745330186787, 6377.075324078006, 6392.584482008655, 6077.301110372319, 6156.7229474673295, 6160.876782464348, 6164.198654174974, 6169.444749972524, 4718.457377401574, 4996.975015124901, 5278.762455689503, 5300.231466437345, 5301.814436494704, 10844.186685998502, 10996.0, 11007.284526505751, 11009.394483303415, 11021.83467247992, 1842.207850624231, 1863.7297591849242, 1960.402077366417, 1965.371081253985, 2154.676798480225, 9237.49193794341, 9280.396774209656, 9422.670206542738, 9793.21654267657, 9875.506224688808, 1692.3822804676327, 1787.7139657654843, 1794.55136215946, 1794.883332583378, 1815.9092045397676, 66012.66993665049, 66685.0, 67372.663136684, 68168.6591567044, 68743.65628171827, 9848.655297064568, 9978.60085596568, 10034.799304013879, 10311.48442577868, 10337.328073675188, 13661.453541858413, 13667.589972300846, 13709.314534273246, 13730.65673358154, 13786.65533361674, 6971.930280697229, 7103.254158313406, 7153.320434558708, 7432.851342973218, 7435.4795164337975, 6818.420434263143, 6873.931260687429, 6999.475039371966, 7032.683529241196, 7037.5425597337035, 4216.873493795191, 4335.696501244883, 4343.543927887589, 4475.1273501666865, 4506.076254367847, 1617.4581515192308, 1754.7280171573427, 1796.7035439152655, 1834.7254627856314, 1869.5980364221757, 809.9028116625925, 823.8681810910225, 831.8627426474563, 836.9539675317794, 875.5053394832026, 15762.005219008352, 16605.0867202305, 16715.52348373233, 17517.386891458736, 17701.645967080585, 840.399114633028, 850.1880703927734, 909.6997990663066, 911.4804561399939, 929.7675581104724, 9050.230730387992, 9162.954185229164, 9201.21789647874, 9616.11063643762, 9716.465594392235, 370101.0, 370293.0, 382727.0, 382962.0, 383999.0, 71766.64116679487, 73223.26776732272, 75446.24553754502, 76162.23837761552, 76672.0, 884.2439714044657, 922.1378011559214, 946.8248374050822, 948.3551185193996, 949.159993405827, 14972.401103955719, 15187.253465851569, 15550.844491555392, 15578.376864925276, 15586.688266234385, 34764.13089672779, 36174.4573831398, 36259.274814503035, 36541.81729091444, 37643.0, 47556.0, 47772.044559109316, 47865.5213447875, 49096.50903490919, 55119.72440137934, 6799.286074962058, 7257.637118144177, 7426.220246874216, 7687.654055567625, 7765.572893490912, 6014.669193194416, 7654.502457340255, 10904.672859814218, 11579.07367410622, 11594.94202528982, 9417.858732118886, 9427.952860235655, 9495.715128546155, 9755.80488390214, 9835.0, 9350.67272645454, 10120.190384769054, 10257.58969641206, 10262.538185781807, 10458.372497650165, 9211.585478653342, 9523.285753568649, 9665.468399238109, 9932.404055756677, 10034.448105354275, 7587.962060189884, 7664.118626357817, 7683.731069412544, 7812.453128281193, 8004.279614834692, 8389.790255243668, 9808.65669701557, 9866.753331166778, 10010.749731256778, 10138.847917281395], "value": 8002.617844181429, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1128.8588926384202, 1137.4824454873033, 1272.2303006680959, 1366.2622184020622, 1391.9582412527616, 6907.516473846833, 7554.169041405441, 7590.354819840307, 8184.713535026268, 8191.959040204805, 7628.466007379486, 7937.9206207937905, 7939.801504962379, 7950.681972721099, 7958.801029974254, 2149.1188612668807, 2169.5010147665967, 2171.81539569136, 2176.227439259056, 2178.1287485005964, 2109.4620871677703, 2145.871247725134, 2208.6686996950425, 2208.9005994730196, 2210.4968621337566, 2086.6765651324067, 2091.602595506849, 2098.097817938286, 2099.6640537514, 2141.9464513387134, 2082.4689704125426, 2090.644590419632, 2095.067694875781, 2107.589020141073, 2112.0706888968803, 2047.4778931372405, 2102.8107470327745, 2109.546447513792, 2111.7254756881507, 2117.2272120675843, 7993.640286187077, 8063.879041814377, 8064.0, 8064.31453326468, 8073.959630201812, 4434.312681534368, 4567.063751930879, 4572.154151481986, 4652.232381657022, 4654.511276316006, 2935.0901220621677, 2959.422912532057, 2963.6295463067117, 3078.722914937644, 3082.4605694003685, 945.6122989574242, 1002.2332915319786, 1006.8942761010135, 1011.4942528735633, 1016.0855230292722, 10289.53697083633, 10423.583056677724, 10430.061294483457, 10473.685789426254, 10599.0, 4009.599040095967, 4268.487781466182, 4298.161858437575, 4377.255866502638, 4384.254676704968, 9284.164425201629, 9288.0, 9354.345195836362, 9354.438733676001, 9402.43585384879, 4427.690061695715, 4464.575865292792, 4465.888352791206, 4473.619742321874, 4491.528389519053, 3687.0966613179944, 4041.474608300961, 4121.216968775923, 4136.234796562646, 4175.561566035522, 3617.186133120027, 3643.526341575578, 3669.192777588926, 3741.2330472253125, 3785.470034195215, 1192.952281908714, 1194.4326444938586, 1201.0511695760251, 1202.7053371923935, 1209.5282839692527, 824.8432797768405, 843.843888880559, 849.9375780274656, 866.9436486628349, 874.9693760718344, 5160.793568257228, 5191.2472691459525, 5206.8437946860895, 5283.181106928432, 5468.644538105011, 385.24491995688203, 386.84139502804277, 389.69993105308754, 390.3461701649782, 392.6485795213325, 3464.6708562686504, 3605.6754892059316, 3610.5125808016105, 3712.832922518493, 3774.301754175486, 9801.0, 10060.195184385379, 10073.395596264247, 10136.594536218468, 10181.847272290921, 9933.453660048623, 10009.999999999854, 10046.246531510165, 10062.69811905644, 10134.54394552247, 7065.328793764585, 7347.0, 7488.176300606929, 7532.887006694904, 7561.962190189014, 5464.644798088111, 5537.169424586184, 5545.972270138624, 5552.222688823649, 5735.827925162252, 9200.631974720936, 9255.953720231355, 9261.953690231776, 9327.486988215713, 9364.297677674065, 9075.2286055686, 9182.816343672956, 9361.672341468016, 9369.531523423939, 9425.528723563932, 6057.18228039209, 6612.107365505595, 6873.931260687529, 6888.586684798928, 7075.681594328371, 7734.187910269341, 7745.0, 7750.767476975474, 7799.454038217497, 7799.961000194962, 6548.476121910331, 6669.066330713801, 6673.099131617364, 6785.050092986887, 6795.0, 6641.634710090992, 6684.16447944007, 6718.596884186964, 6784.05023296729, 6885.311468853075, 6522.478201743944, 6567.638779867153, 6597.934020659924, 6600.768973085919, 6617.536772425884, 4689.624830013522, 4725.810967561259, 4831.347768051409, 4843.104025755247, 4898.975505122452, 4702.318163866289, 4710.4347478302825, 4792.209285467999, 4854.587360074292, 4874.0495603357], "value": 4082.809871274282, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.72830132127774, 304.39881234561744, 305.89446640908886, 309.9705527974842, 312.2303521818717, 4811.735354555498, 4941.60467162627, 4942.382202224722, 5031.547160755531, 5064.569511591514, 4928.31003659487, 4948.851534453963, 4953.207486802113, 4955.414267434422, 4959.652824302291, 3925.5661489876175, 3928.3125453045745, 3935.291647503448, 3939.9803000984957, 3947.0, 3666.3034023535574, 3930.547986981491, 3942.369220924653, 3952.6837852971835, 3953.9011524711823, 3825.3305671507514, 3851.1912498375236, 3856.113093988384, 3857.112864041258, 3866.3620502617173, 3830.9425358619505, 3836.4245363195464, 3851.690425255427, 3853.845846166178, 3865.922681546381, 3390.847411866472, 3391.16916355492, 3392.1858753899132, 3394.574278802909, 3429.4341433663417, 4713.794619658631, 4838.661293709441, 4859.659823812334, 4872.808310556591, 4899.7661543381555, 4393.648508119343, 4396.691736838154, 4404.4494438195225, 4423.933640995388, 4457.551295828868, 5215.58275337972, 5249.8425047248265, 5261.184516399964, 5264.499872512105, 5293.126634105368, 3616.2948225096115, 3695.4087346024507, 3704.8144593730017, 3708.313961917027, 3714.220013797106, 5436.184572314145, 5437.0, 5451.318585176813, 5476.028629693307, 5517.200005999148, 3733.5893051764283, 3749.9687585914094, 3755.5681096673684, 3757.1546402059867, 3765.8325918965206, 3837.5586807516934, 3848.9615103849164, 3850.0, 3853.133045064838, 3853.420097759905, 4310.137972405531, 4365.454318210223, 4374.693771435969, 4377.233984052778, 4404.757738324423, 5242.947570524322, 5243.251075481049, 5247.475252474722, 5258.421573626898, 5288.656237344637, 1243.1981372015, 1284.8115493168782, 1310.7220460051565, 1313.9868601314056, 1323.5764555342391, 858.4248553469191, 889.6085722282176, 905.2893478619252, 913.6665117232295, 916.3493919317226, 4560.4071470708595, 4563.383943167696, 4572.9314060289125, 4573.222552166139, 4587.266037433995, 5335.226392173113, 5339.131304043632, 5348.545373643206, 5355.919661205085, 5395.865103372447, 4367.366731823868, 4546.88632784183, 4583.449986001701, 4596.678232523691, 4613.792379342937, 2483.255023492945, 2490.9875450622994, 2510.6234064890414, 2516.358328626225, 2521.571332873379, 4416.845410410684, 4443.688941774045, 4444.4888837784065, 4467.5755803198645, 4500.639948804088, 4638.628909687217, 4786.95213047865, 4815.2054910939305, 4818.71087734737, 4821.831235906727, 4345.261305578059, 4414.183376075436, 4419.359192917009, 4437.733735975852, 4446.666500012448, 4699.271612900006, 4707.4821769606, 4717.882052948704, 4727.290906364073, 4739.431268247695, 4616.591939458497, 4628.375169352229, 4634.9536504634525, 4661.230896901973, 4684.742339171242, 4294.377315289328, 4412.6249268811225, 4433.2241857674135, 4436.334549817553, 4456.487503936959, 3409.846556904995, 3415.470602056685, 3425.2978139481843, 3454.4990976308795, 3471.340445315382, 4769.422932800399, 4782.713037217778, 4798.0, 4803.759812009455, 5219.634625576173, 5078.542931136216, 5215.530602245816, 5217.556507696737, 5237.266782650356, 5240.401677488403, 5177.922331165111, 5211.661242019257, 5220.546343218681, 5229.966619360837, 5252.632315738015, 5026.255072002453, 5045.772940217626, 5097.247486357325, 5108.56577190943, 5163.767630456563, 5235.607329450383, 5239.109351410193, 5246.921296180484, 5252.395974462833, 5252.448492908343, 5086.491350864884, 5140.614453915897, 5171.285075335479, 5173.198154286091, 5174.948250517597], "value": 3806.8842720742964, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.9175907132073, 637.8469167399826, 702.6276073680949, 702.7154002628937, 711.7331000874672, 11788.7642247155, 12649.93675031626, 12704.491820327188, 12709.936450317735, 12720.936395318022, 13039.478420863154, 13659.385327660255, 13697.452101915911, 13962.16227026379, 14086.859131408683, 770.0643717882772, 796.1004065406083, 800.0519384529351, 800.5276886636883, 800.6637212370789, 634.4924060751404, 759.4114561215048, 775.0660454152733, 777.9611019449034, 790.154534647927, 824.0482243009304, 824.5671022713094, 825.6202147012382, 825.8183199696088, 828.7969447485375, 817.1746535998655, 824.1305422778966, 824.2499325613693, 824.5011767880466, 824.8391563645091, 597.8684689368332, 602.692626760351, 602.8553147244629, 603.0592276049333, 603.6287683074877, 12485.250884946932, 12495.0, 12539.059570532156, 12557.497700091986, 12572.874271257262, 12231.143819932608, 12573.308468034254, 12727.554535591209, 13026.41381137851, 13039.869601304055, 9181.540922953825, 9199.172074513326, 9231.676891308773, 9310.627574896997, 9853.556589953398, 3206.567113439679, 3209.8555564999633, 3215.565898603682, 3231.1098007665546, 3370.3259348130473, 66790.66604666946, 68676.01183810567, 68975.65512172457, 69665.3033469664, 70566.0, 9647.855282170773, 9729.367591106555, 9736.9026309736, 9988.0, 10003.749906252257, 18762.812371876378, 18764.343247986257, 18822.811771882105, 18844.811551884304, 18946.052697365078, 6846.178458584902, 6923.411510021705, 6995.755148569776, 7065.116860392451, 7128.07335046451, 3612.3678356287546, 3663.68858647018, 3665.633436656313, 3726.1802403471193, 3761.8683346082757, 2789.4839454700946, 2909.47629426701, 2973.7620990320725, 2975.5239161734453, 2979.06159559738, 477.62506432450357, 478.77258302306126, 493.03857477918206, 497.2268123068663, 499.0916531911885, 447.8544473046273, 463.2402859310733, 465.0721809989026, 526.6497778977014, 548.4981242163376, 6614.140161778938, 7045.718171273092, 7359.632018399058, 8687.609057592423, 8691.304695624334, 385.6124594782282, 427.70274659112243, 475.70030880545033, 550.1884720037912, 596.174298596447, 3376.0884561168837, 3614.1868079681863, 3917.7257591968287, 3945.6646185074014, 4043.3126368517424, 87282.56358718166, 93617.0, 96090.03909960951, 96252.51873740586, 97134.0, 77676.0, 77806.0, 78719.21280787118, 79368.0, 80867.0, 62657.68671156706, 69904.0, 69979.30020699727, 70021.0, 72762.0, 7733.149353570991, 7736.187700291388, 7890.092639346319, 8353.331733461187, 8383.95808020956, 33629.0, 37002.07494812544, 42110.947226319586, 43340.0, 44461.555384447034, 48153.75923120502, 55518.0, 55548.72225638846, 55680.0, 62999.6850015747, 10264.897351026693, 10463.476826158814, 10788.244822862323, 10929.726756830825, 10952.397618131079, 10579.94200579936, 11396.544138234378, 11917.642470725892, 12074.939625301817, 12191.268523888595, 10130.493475326351, 10138.290319677846, 11206.775864482828, 11414.48634811452, 11616.186866919572, 10969.725756856142, 10989.890101098887, 11195.216334856483, 11355.829662555234, 11532.423378830857, 10046.397216167054, 10292.536835842555, 10392.740181495523, 10821.729456763329, 10905.890941090487, 7876.488028278143, 8177.895984042316, 8206.22040906113, 8504.574771261536, 9198.724038278862, 8381.11998240176, 8531.189536993976, 8703.173198546128, 8796.252318552739, 8801.911980880366], "value": 6260.292911662882, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 120.0, 114.0, 116.0, 115.0, 115.0, 121.0, 118.0, 116.0, 115.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 125.0, 145.0, 189.0, 131.0, 152.0, 154.0, 123.0, 180.0, 125.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 166.0, 178.0, 166.0, 162.0, 165.0, 162.0, 165.0, 165.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 76.0, 174.0, 77.0, 77.0, 77.0, 77.0, 151.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 144.0, 88.0, 87.0, 88.0, 136.0, 88.0, 88.0, 150.0], "value": 104.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 117.0, 120.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 151.0, 147.0, 148.0, 149.0, 148.0, 148.0, 149.0, 149.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 102.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 100.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 70.0, 66.0, 65.0, 70.0, 69.0, 67.0, 66.0, 70.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 70.0, 67.0, 66.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 84.0, 85.0, 84.0, 83.0, 86.0, 87.0, 83.0, 83.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 140.0, 142.0, 136.0, 138.0, 135.0, 138.0, 138.0, 160.0, 145.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 178.0, 172.0, 177.0, 173.0, 172.0, 172.0, 174.0, 173.0, 172.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 73.0, 71.0, 69.0, 69.0, 71.0, 68.0, 70.0, 68.0], "value": 70.1, "unit": "score"}]}]} 03:36:08 INFO - Return code: 0 03:36:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:36:08 ERROR - # TBPL SUCCESS # 03:36:08 INFO - Running post-action listener: _resource_record_post_action 03:36:08 INFO - [mozharness: 2016-08-17 10:36:08.710274Z] Finished run-tests step (success) 03:36:08 INFO - Running post-run listener: _resource_record_post_run 03:36:08 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7778304; Write bytes: 419028992; Read time: 912; Write time: 347592 03:36:08 INFO - TinderboxPrint: CPU usage
13.4% 03:36:08 INFO - TinderboxPrint: I/O read bytes / time
7,778,304 / 912 03:36:08 INFO - TinderboxPrint: I/O write bytes / time
419,028,992 / 347,592 03:36:08 INFO - TinderboxPrint: CPU idle
8,289.0 (86.6%) 03:36:08 INFO - TinderboxPrint: CPU user
1,226.1 (12.8%) 03:36:08 INFO - TinderboxPrint: Swap in / out
0 / 0 03:36:08 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 97492992; Read time: 12; Write time: 51364 03:36:08 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 5533696; Write bytes: 321536000; Read time: 692; Write time: 296228 03:36:09 INFO - Running post-run listener: _upload_blobber_files 03:36:09 INFO - Blob upload gear active. 03:36:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:36:09 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 03:36:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:36:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:36:09 INFO - (blobuploader) - INFO - Open directory for files ... 03:36:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:36:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:36:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:10 INFO - (blobuploader) - INFO - Done attempting. 03:36:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:36:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:36:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:11 INFO - (blobuploader) - INFO - Done attempting. 03:36:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:36:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:36:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:14 INFO - (blobuploader) - INFO - Done attempting. 03:36:14 INFO - (blobuploader) - INFO - Iteration through files over. 03:36:14 INFO - Return code: 0 03:36:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:36:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:36:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6f2ec68158f61d3122be773bc85964205201d94dc6a1a677d49e136ac4c173d4c81f1a04b32dc8e868a5a09b511e6b9bb02898fb562dda903d278b2898afc47a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d37e28d80caa1220d1f217d03994ba8b0826ccd94f2c2de0f06510d6bc85c51b2b4013a91b07aeb50a974d46c0742bf005205212bfe04e4975dced08ec86bb25", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/19cf26fe5b685b9a07236920a6d0b77336787ca7beeea928ddd0942b592402d2b38686dfa58bd5a4eaea90a4cd845b64ec17d782001cd7aa2656b350a29956c3"} 03:36:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:36:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:36:14 INFO - Contents: 03:36:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6f2ec68158f61d3122be773bc85964205201d94dc6a1a677d49e136ac4c173d4c81f1a04b32dc8e868a5a09b511e6b9bb02898fb562dda903d278b2898afc47a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d37e28d80caa1220d1f217d03994ba8b0826ccd94f2c2de0f06510d6bc85c51b2b4013a91b07aeb50a974d46c0742bf005205212bfe04e4975dced08ec86bb25", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/19cf26fe5b685b9a07236920a6d0b77336787ca7beeea928ddd0942b592402d2b38686dfa58bd5a4eaea90a4cd845b64ec17d782001cd7aa2656b350a29956c3"} 03:36:14 INFO - Running post-run listener: copy_logs_to_upload_dir 03:36:14 INFO - Copying logs to upload dir... 03:36:14 INFO - mkdir: /builds/slave/test/build/upload/logs 03:36:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.136432 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-17 03:36:14.645414) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 03:36:14.648652) ========= 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=7de08804244eb36560b44971000001c3-1471425317.477164-1998930345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6f2ec68158f61d3122be773bc85964205201d94dc6a1a677d49e136ac4c173d4c81f1a04b32dc8e868a5a09b511e6b9bb02898fb562dda903d278b2898afc47a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d37e28d80caa1220d1f217d03994ba8b0826ccd94f2c2de0f06510d6bc85c51b2b4013a91b07aeb50a974d46c0742bf005205212bfe04e4975dced08ec86bb25", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/19cf26fe5b685b9a07236920a6d0b77336787ca7beeea928ddd0942b592402d2b38686dfa58bd5a4eaea90a4cd845b64ec17d782001cd7aa2656b350a29956c3"} build_url:https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011203 build_url: 'https://queue.taskcluster.net/v1/task/doTRSItnRVGHiiz_FRRk1g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6f2ec68158f61d3122be773bc85964205201d94dc6a1a677d49e136ac4c173d4c81f1a04b32dc8e868a5a09b511e6b9bb02898fb562dda903d278b2898afc47a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d37e28d80caa1220d1f217d03994ba8b0826ccd94f2c2de0f06510d6bc85c51b2b4013a91b07aeb50a974d46c0742bf005205212bfe04e4975dced08ec86bb25", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/19cf26fe5b685b9a07236920a6d0b77336787ca7beeea928ddd0942b592402d2b38686dfa58bd5a4eaea90a4cd845b64ec17d782001cd7aa2656b350a29956c3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 03:36:14.674372) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:36:14.674764) ========= 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=7de08804244eb36560b44971000001c3-1471425317.477164-1998930345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:36:14.760381) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 03:36:14.760711) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 03:36:14.761108) ========= ========= Total master_lag: 0.19 =========